builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1460743364.61 results: success (0) buildid: 20160415083221 builduid: dd653251b9544cc397dacba4285e386f revision: fec92924befbea7a0ee52c4cedd531a67b61f2fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.607479) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.607938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.608236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.625162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.625455) ========= 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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 11:02:45-- 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% 220M=0s 2016-04-15 11:02:45 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.736998) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.740394) ========= 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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.789758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 11:02:44.790105) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fec92924befbea7a0ee52c4cedd531a67b61f2fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fec92924befbea7a0ee52c4cedd531a67b61f2fb --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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 11:02:45,804 truncating revision to first 12 chars 2016-04-15 11:02:45,804 Setting DEBUG logging. 2016-04-15 11:02:45,804 attempt 1/10 2016-04-15 11:02:45,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fec92924befb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 11:02:47,057 unpacking tar archive at: fx-team-fec92924befb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.529716 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 11:02:46.346270) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:46.346576) ========= script_repo_revision: fec92924befbea7a0ee52c4cedd531a67b61f2fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:46.347014) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:46.347304) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:46.366989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-15 11:02:46.367272) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:47 INFO - MultiFileLogger online at 20160415 11:02:47 in /builds/slave/test 11:02:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:02:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:47 INFO - {'append_to_log': False, 11:02:47 INFO - 'base_work_dir': '/builds/slave/test', 11:02:47 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:47 INFO - 'branch': 'Fx-Team', 11:02:47 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:47 INFO - 'config_files': ('talos/linux_config.py',), 11:02:47 INFO - 'default_actions': ('clobber', 11:02:47 INFO - 'read-buildbot-config', 11:02:47 INFO - 'download-and-extract', 11:02:47 INFO - 'populate-webroot', 11:02:47 INFO - 'create-virtualenv', 11:02:47 INFO - 'install', 11:02:47 INFO - 'run-tests'), 11:02:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:47 INFO - 'download_minidump_stackwalk': True, 11:02:47 INFO - 'download_symbols': 'ondemand', 11:02:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:47 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:47 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:47 INFO - 'installer_path': 'installer.exe', 11:02:47 INFO - 'log_level': 'info', 11:02:47 INFO - 'log_name': 'talos', 11:02:47 INFO - 'log_to_console': True, 11:02:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:47 INFO - 'opt_config_files': (), 11:02:47 INFO - 'pip_index': False, 11:02:47 INFO - 'sps_profile': False, 11:02:47 INFO - 'sps_profile_interval': 0, 11:02:47 INFO - 'suite': 'dromaeojs', 11:02:47 INFO - 'system_bits': '32', 11:02:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:47 INFO - 'title': 'talos-linux64-ix-056', 11:02:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:47 INFO - 'use_talos_json': True, 11:02:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:47 INFO - 'work_dir': 'build'} 11:02:47 INFO - ##### 11:02:47 INFO - ##### Running clobber step. 11:02:47 INFO - ##### 11:02:47 INFO - Running pre-action listener: _resource_record_pre_action 11:02:47 INFO - Running main action method: clobber 11:02:47 INFO - rmtree: /builds/slave/test/build 11:02:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:47 INFO - Running post-action listener: _resource_record_post_action 11:02:47 INFO - ##### 11:02:47 INFO - ##### Running read-buildbot-config step. 11:02:47 INFO - ##### 11:02:47 INFO - Running pre-action listener: _resource_record_pre_action 11:02:47 INFO - Running main action method: read_buildbot_config 11:02:47 INFO - Using buildbot properties: 11:02:47 INFO - { 11:02:47 INFO - "project": "", 11:02:47 INFO - "product": "firefox", 11:02:47 INFO - "script_repo_revision": "production", 11:02:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:02:47 INFO - "repository": "", 11:02:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:02:47 INFO - "buildid": "20160415083221", 11:02:47 INFO - "pgo_build": "True", 11:02:47 INFO - "basedir": "/builds/slave/test", 11:02:47 INFO - "buildnumber": 31, 11:02:47 INFO - "slavename": "talos-linux64-ix-056", 11:02:47 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:02:47 INFO - "platform": "ubuntu64_hw", 11:02:47 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:02:47 INFO - "branch": "fx-team", 11:02:47 INFO - "repo_path": "integration/fx-team", 11:02:47 INFO - "revision": "fec92924befbea7a0ee52c4cedd531a67b61f2fb", 11:02:47 INFO - "stage_platform": "linux64-pgo", 11:02:47 INFO - "builduid": "dd653251b9544cc397dacba4285e386f", 11:02:47 INFO - "slavebuilddir": "test" 11:02:47 INFO - } 11:02:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:02:47 INFO - Running post-action listener: _resource_record_post_action 11:02:47 INFO - ##### 11:02:47 INFO - ##### Running download-and-extract step. 11:02:47 INFO - ##### 11:02:47 INFO - Running pre-action listener: _resource_record_pre_action 11:02:47 INFO - Running main action method: download_and_extract 11:02:47 INFO - mkdir: /builds/slave/test/build/tests 11:02: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')]} 11:02:47 INFO - https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:02:55 INFO - Downloaded 1361 bytes. 11:02:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:55 INFO - Using the following test package requirements: 11:02:55 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:55 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:02:55 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:02:55 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'jsshell-linux-x86_64.zip'], 11:02:55 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:02:55 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:55 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:02:55 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:02:55 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:02:55 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:02:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:55 INFO - https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:02:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:03:03 INFO - Downloaded 23776862 bytes. 11:03:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:03:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:03:04 INFO - Return code: 0 11:03:04 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:04 INFO - https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:03:08 INFO - Downloaded 23776862 bytes. 11:03:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:03:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:03:09 INFO - Return code: 0 11:03: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')]} 11:03:09 INFO - https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:03:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:03:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:03:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:03:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:03:10 INFO - Downloaded 10841076 bytes. 11:03:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:03:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:03:10 INFO - Return code: 0 11:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:10 INFO - https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:03:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:03:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:03:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:03:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:03:12 INFO - Downloaded 58241221 bytes. 11:03:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:03:12 INFO - mkdir: /builds/slave/test/properties 11:03:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:12 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:12 INFO - Contents: 11:03:12 INFO - build_url:https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:03:13 INFO - Running post-action listener: _resource_record_post_action 11:03:13 INFO - Running post-action listener: set_extra_try_arguments 11:03:13 INFO - ##### 11:03:13 INFO - ##### Running populate-webroot step. 11:03:13 INFO - ##### 11:03:13 INFO - Running pre-action listener: _resource_record_pre_action 11:03:13 INFO - Running main action method: populate_webroot 11:03:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:03:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:03:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:03:13 INFO - '--tppagecycles', 11:03:13 INFO - '7'], 11:03:13 INFO - 'tests': ['tsvgm']}}, 11:03:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:03:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:03:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['damp', 'tps']}, 11:03:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'tests': ['damp', 'tps']}, 11:03:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['dromaeo_dom']}, 11:03:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['a11yr', 11:03:13 INFO - 'ts_paint', 11:03:13 INFO - 'tpaint', 11:03:13 INFO - 'sessionrestore', 11:03:13 INFO - 'sessionrestore_no_auto_restore', 11:03:13 INFO - 'tabpaint']}, 11:03:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['tsvgx', 11:03:13 INFO - 'tsvgr_opacity', 11:03:13 INFO - 'tart', 11:03:13 INFO - 'tscrollx', 11:03:13 INFO - 'cart']}, 11:03:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:13 INFO - 'tsvgr_opacity', 11:03:13 INFO - 'tart', 11:03:13 INFO - 'tscrollx', 11:03:13 INFO - 'cart']}, 11:03:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'talos_options': ['--disable-e10s'], 11:03:13 INFO - 'tests': ['tp5o']}, 11:03:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'tests': ['tp5o']}, 11:03:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'talos_options': ['--disable-e10s', 11:03:13 INFO - '--xperf_path', 11:03:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:13 INFO - 'tests': ['tp5n']}, 11:03:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:03:13 INFO - 'talos_options': ['--xperf_path', 11:03:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:13 INFO - 'tests': ['tp5n']}}, 11:03:13 INFO - 'talos.zip': {'path': '', 11:03:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:03:13 INFO - Running post-action listener: _resource_record_post_action 11:03:13 INFO - ##### 11:03:13 INFO - ##### Running create-virtualenv step. 11:03:13 INFO - ##### 11:03:13 INFO - Running pre-action listener: _resource_record_pre_action 11:03:13 INFO - Running main action method: create_virtualenv 11:03:13 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:13 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 11:03:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:03:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:13 INFO - Using real prefix '/usr' 11:03:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:14 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:16 INFO - Installing pip.................done. 11:03:16 INFO - Return code: 0 11:03:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:16 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:16 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 11:03:16 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 11:03:16 INFO - Using env: {'DISPLAY': ':0', 11:03:16 INFO - 'HOME': '/home/cltbld', 11:03:16 INFO - 'LANG': 'en_US.UTF-8', 11:03:16 INFO - 'LANGUAGE': 'en_US:en', 11:03:16 INFO - 'LOGNAME': 'cltbld', 11:03:16 INFO - 'MAIL': '/var/mail/cltbld', 11:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:16 INFO - 'MOZ_NO_REMOTE': '1', 11:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:16 INFO - 'NO_EM_RESTART': '1', 11:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:16 INFO - 'PWD': '/builds/slave/test', 11:03:16 INFO - 'SHELL': '/bin/bash', 11:03:16 INFO - 'SHLVL': '1', 11:03:16 INFO - 'TERM': 'linux', 11:03:16 INFO - 'TMOUT': '86400', 11:03:16 INFO - 'USER': 'cltbld', 11:03:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:16 INFO - '_': '/tools/buildbot/bin/python'} 11:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:16 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 11:03:16 INFO - Cleaning up... 11:03:16 INFO - Return code: 0 11:03:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:16 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:16 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 11:03:16 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 11:03:16 INFO - Using env: {'DISPLAY': ':0', 11:03:16 INFO - 'HOME': '/home/cltbld', 11:03:16 INFO - 'LANG': 'en_US.UTF-8', 11:03:16 INFO - 'LANGUAGE': 'en_US:en', 11:03:16 INFO - 'LOGNAME': 'cltbld', 11:03:16 INFO - 'MAIL': '/var/mail/cltbld', 11:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:16 INFO - 'MOZ_NO_REMOTE': '1', 11:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:16 INFO - 'NO_EM_RESTART': '1', 11:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:16 INFO - 'PWD': '/builds/slave/test', 11:03:16 INFO - 'SHELL': '/bin/bash', 11:03:16 INFO - 'SHLVL': '1', 11:03:16 INFO - 'TERM': 'linux', 11:03:16 INFO - 'TMOUT': '86400', 11:03:16 INFO - 'USER': 'cltbld', 11:03:16 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:16 INFO - '_': '/tools/buildbot/bin/python'} 11:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:16 INFO - Downloading/unpacking psutil>=0.7.1 11:03:16 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 11:03:16 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 11:03:16 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 11:03:16 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 11:03:16 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 11:03:16 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 11:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:18 INFO - Installing collected packages: psutil 11:03:18 INFO - Running setup.py install for psutil 11:03:18 INFO - building 'psutil._psutil_linux' extension 11:03:18 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 11:03:18 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 11:03:18 INFO - building 'psutil._psutil_posix' extension 11:03:18 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 11:03:18 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 11:03:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:19 INFO - Successfully installed psutil 11:03:19 INFO - Cleaning up... 11:03:19 INFO - Return code: 0 11:03:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:03:19 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')]} 11:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:19 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')]} 11:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:19 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:19 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 11:03:19 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 11:03:19 INFO - Using env: {'DISPLAY': ':0', 11:03:19 INFO - 'HOME': '/home/cltbld', 11:03:19 INFO - 'LANG': 'en_US.UTF-8', 11:03:19 INFO - 'LANGUAGE': 'en_US:en', 11:03:19 INFO - 'LOGNAME': 'cltbld', 11:03:19 INFO - 'MAIL': '/var/mail/cltbld', 11:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:19 INFO - 'MOZ_NO_REMOTE': '1', 11:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:19 INFO - 'NO_EM_RESTART': '1', 11:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:19 INFO - 'PWD': '/builds/slave/test', 11:03:19 INFO - 'SHELL': '/bin/bash', 11:03:19 INFO - 'SHLVL': '1', 11:03:19 INFO - 'TERM': 'linux', 11:03:19 INFO - 'TMOUT': '86400', 11:03:19 INFO - 'USER': 'cltbld', 11:03:19 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:19 INFO - '_': '/tools/buildbot/bin/python'} 11:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:03:19 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 11:03:19 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 11:03:19 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 11:03:19 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 11:03:19 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 11:03:19 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 11:03:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:03:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:03:21 INFO - Installing collected packages: mozsystemmonitor 11:03:21 INFO - Running setup.py install for mozsystemmonitor 11:03:21 INFO - Successfully installed mozsystemmonitor 11:03:21 INFO - Cleaning up... 11:03:21 INFO - Return code: 0 11:03:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:21 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')]} 11:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:21 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')]} 11:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:21 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:21 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 11:03:21 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 11:03:21 INFO - Using env: {'DISPLAY': ':0', 11:03:21 INFO - 'HOME': '/home/cltbld', 11:03:21 INFO - 'LANG': 'en_US.UTF-8', 11:03:21 INFO - 'LANGUAGE': 'en_US:en', 11:03:21 INFO - 'LOGNAME': 'cltbld', 11:03:21 INFO - 'MAIL': '/var/mail/cltbld', 11:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:21 INFO - 'MOZ_NO_REMOTE': '1', 11:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:21 INFO - 'NO_EM_RESTART': '1', 11:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:21 INFO - 'PWD': '/builds/slave/test', 11:03:21 INFO - 'SHELL': '/bin/bash', 11:03:21 INFO - 'SHLVL': '1', 11:03:21 INFO - 'TERM': 'linux', 11:03:21 INFO - 'TMOUT': '86400', 11:03:21 INFO - 'USER': 'cltbld', 11:03:21 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:21 INFO - '_': '/tools/buildbot/bin/python'} 11:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:21 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:21 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 11:03:21 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 11:03:21 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 11:03:21 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 11:03:21 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 11:03:21 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 11:03:23 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:24 INFO - Downloading docopt-0.6.1.tar.gz 11:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:24 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:24 INFO - Running setup.py install for blobuploader 11:03:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:24 INFO - Running setup.py install for requests 11:03:24 INFO - Running setup.py install for docopt 11:03:24 INFO - Successfully installed blobuploader requests docopt 11:03:24 INFO - Cleaning up... 11:03:24 INFO - Return code: 0 11:03:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:24 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:24 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 11:03:24 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 11:03:24 INFO - Using env: {'DISPLAY': ':0', 11:03:24 INFO - 'HOME': '/home/cltbld', 11:03:24 INFO - 'LANG': 'en_US.UTF-8', 11:03:24 INFO - 'LANGUAGE': 'en_US:en', 11:03:24 INFO - 'LOGNAME': 'cltbld', 11:03:24 INFO - 'MAIL': '/var/mail/cltbld', 11:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:24 INFO - 'MOZ_NO_REMOTE': '1', 11:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:24 INFO - 'NO_EM_RESTART': '1', 11:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:24 INFO - 'PWD': '/builds/slave/test', 11:03:24 INFO - 'SHELL': '/bin/bash', 11:03:24 INFO - 'SHLVL': '1', 11:03:24 INFO - 'TERM': 'linux', 11:03:24 INFO - 'TMOUT': '86400', 11:03:24 INFO - 'USER': 'cltbld', 11:03:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:24 INFO - '_': '/tools/buildbot/bin/python'} 11:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:25 INFO - Running setup.py (path:/tmp/pip-JYo32I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:25 INFO - Running setup.py (path:/tmp/pip-EKXniX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:25 INFO - Running setup.py (path:/tmp/pip-8hXbr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:25 INFO - Running setup.py (path:/tmp/pip-VsXCqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:25 INFO - Running setup.py (path:/tmp/pip-1pBGcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:25 INFO - Running setup.py (path:/tmp/pip-VdvWYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:25 INFO - Running setup.py (path:/tmp/pip-5ODTmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:25 INFO - Running setup.py (path:/tmp/pip-kAFq4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:25 INFO - Running setup.py (path:/tmp/pip-oo6iNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:25 INFO - Running setup.py (path:/tmp/pip-yKiX8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:25 INFO - Running setup.py (path:/tmp/pip-0dIFju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:25 INFO - Running setup.py (path:/tmp/pip-3eReSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:26 INFO - Running setup.py (path:/tmp/pip-YlldCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:26 INFO - Running setup.py (path:/tmp/pip-Ff_6ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:26 INFO - Running setup.py (path:/tmp/pip-LSc_qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:26 INFO - Running setup.py (path:/tmp/pip-XR0hX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:26 INFO - Running setup.py (path:/tmp/pip-eNQ00X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:26 INFO - Running setup.py install for manifestparser 11:03:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:26 INFO - Running setup.py install for mozcrash 11:03:26 INFO - Running setup.py install for mozdebug 11:03:26 INFO - Running setup.py install for mozdevice 11:03:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:26 INFO - Running setup.py install for mozfile 11:03:26 INFO - Running setup.py install for mozhttpd 11:03:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:26 INFO - Running setup.py install for mozinfo 11:03:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for mozInstall 11:03:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for mozleak 11:03:27 INFO - Running setup.py install for mozlog 11:03:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for moznetwork 11:03:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for mozprocess 11:03:27 INFO - Running setup.py install for mozprofile 11:03:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for mozrunner 11:03:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:27 INFO - Running setup.py install for mozscreenshot 11:03:27 INFO - Running setup.py install for moztest 11:03:28 INFO - Running setup.py install for mozversion 11:03:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:28 INFO - Cleaning up... 11:03:28 INFO - Return code: 0 11:03:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:28 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:28 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 11:03:28 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 11:03:28 INFO - Using env: {'DISPLAY': ':0', 11:03:28 INFO - 'HOME': '/home/cltbld', 11:03:28 INFO - 'LANG': 'en_US.UTF-8', 11:03:28 INFO - 'LANGUAGE': 'en_US:en', 11:03:28 INFO - 'LOGNAME': 'cltbld', 11:03:28 INFO - 'MAIL': '/var/mail/cltbld', 11:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:28 INFO - 'MOZ_NO_REMOTE': '1', 11:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:28 INFO - 'NO_EM_RESTART': '1', 11:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:28 INFO - 'PWD': '/builds/slave/test', 11:03:28 INFO - 'SHELL': '/bin/bash', 11:03:28 INFO - 'SHLVL': '1', 11:03:28 INFO - 'TERM': 'linux', 11:03:28 INFO - 'TMOUT': '86400', 11:03:28 INFO - 'USER': 'cltbld', 11:03:28 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:28 INFO - '_': '/tools/buildbot/bin/python'} 11:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:28 INFO - Running setup.py (path:/tmp/pip-FC3UEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:28 INFO - Running setup.py (path:/tmp/pip-yZ05Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:28 INFO - Running setup.py (path:/tmp/pip-kdpm5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:28 INFO - Running setup.py (path:/tmp/pip-9xUI4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:28 INFO - Running setup.py (path:/tmp/pip-sf4jLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:28 INFO - Running setup.py (path:/tmp/pip-j2fAXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:28 INFO - Running setup.py (path:/tmp/pip-mWc6pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:28 INFO - Running setup.py (path:/tmp/pip-x6WlV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:28 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)) 11:03:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:28 INFO - Running setup.py (path:/tmp/pip-8jeOGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:29 INFO - Running setup.py (path:/tmp/pip-0lKxyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:29 INFO - Running setup.py (path:/tmp/pip-IwrXlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:29 INFO - Running setup.py (path:/tmp/pip-mQyWh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:29 INFO - Running setup.py (path:/tmp/pip-oPDP5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:29 INFO - Running setup.py (path:/tmp/pip-wn9_G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:29 INFO - Running setup.py (path:/tmp/pip-m_MFeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:29 INFO - Running setup.py (path:/tmp/pip-fTmDRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:29 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)) 11:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:29 INFO - Running setup.py (path:/tmp/pip-bdrrun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:29 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)) 11:03:29 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)) 11:03:29 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)) 11:03:29 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)) 11:03:29 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)) 11:03:29 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)) 11:03:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:31 INFO - Downloading blessings-1.6.tar.gz 11:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:31 INFO - Installing collected packages: blessings 11:03:31 INFO - Running setup.py install for blessings 11:03:31 INFO - Successfully installed blessings 11:03:31 INFO - Cleaning up... 11:03:31 INFO - Return code: 0 11:03:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:31 INFO - Reading from file tmpfile_stdout 11:03:31 INFO - Current package versions: 11:03:31 INFO - argparse == 1.2.1 11:03:31 INFO - blessings == 1.6 11:03:31 INFO - blobuploader == 1.2.4 11:03:31 INFO - docopt == 0.6.1 11:03:31 INFO - manifestparser == 1.1 11:03:31 INFO - mozInstall == 1.12 11:03:31 INFO - mozcrash == 0.17 11:03:31 INFO - mozdebug == 0.1 11:03:31 INFO - mozdevice == 0.48 11:03:31 INFO - mozfile == 1.2 11:03:31 INFO - mozhttpd == 0.7 11:03:31 INFO - mozinfo == 0.9 11:03:31 INFO - mozleak == 0.1 11:03:31 INFO - mozlog == 3.1 11:03:31 INFO - moznetwork == 0.27 11:03:31 INFO - mozprocess == 0.22 11:03:31 INFO - mozprofile == 0.28 11:03:31 INFO - mozrunner == 6.11 11:03:31 INFO - mozscreenshot == 0.1 11:03:31 INFO - mozsystemmonitor == 0.0 11:03:31 INFO - moztest == 0.7 11:03:31 INFO - mozversion == 1.4 11:03:31 INFO - psutil == 3.1.1 11:03:31 INFO - requests == 1.2.3 11:03:31 INFO - wsgiref == 0.1.2 11:03:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:31 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')]} 11:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:31 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')]} 11:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:31 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:31 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 11:03:31 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 11:03:31 INFO - Using env: {'DISPLAY': ':0', 11:03:31 INFO - 'HOME': '/home/cltbld', 11:03:31 INFO - 'LANG': 'en_US.UTF-8', 11:03:31 INFO - 'LANGUAGE': 'en_US:en', 11:03:31 INFO - 'LOGNAME': 'cltbld', 11:03:31 INFO - 'MAIL': '/var/mail/cltbld', 11:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:31 INFO - 'MOZ_NO_REMOTE': '1', 11:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:31 INFO - 'NO_EM_RESTART': '1', 11:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:31 INFO - 'PWD': '/builds/slave/test', 11:03:31 INFO - 'SHELL': '/bin/bash', 11:03:31 INFO - 'SHLVL': '1', 11:03:31 INFO - 'TERM': 'linux', 11:03:31 INFO - 'TMOUT': '86400', 11:03:31 INFO - 'USER': 'cltbld', 11:03:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:31 INFO - '_': '/tools/buildbot/bin/python'} 11:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 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)) 11:03:32 INFO - Cleaning up... 11:03:32 INFO - Return code: 0 11:03:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:32 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')]} 11:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:32 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')]} 11:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:32 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:32 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 11:03:32 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 11:03:32 INFO - Using env: {'DISPLAY': ':0', 11:03:32 INFO - 'HOME': '/home/cltbld', 11:03:32 INFO - 'LANG': 'en_US.UTF-8', 11:03:32 INFO - 'LANGUAGE': 'en_US:en', 11:03:32 INFO - 'LOGNAME': 'cltbld', 11:03:32 INFO - 'MAIL': '/var/mail/cltbld', 11:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:32 INFO - 'MOZ_NO_REMOTE': '1', 11:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:32 INFO - 'NO_EM_RESTART': '1', 11:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:32 INFO - 'PWD': '/builds/slave/test', 11:03:32 INFO - 'SHELL': '/bin/bash', 11:03:32 INFO - 'SHLVL': '1', 11:03:32 INFO - 'TERM': 'linux', 11:03:32 INFO - 'TMOUT': '86400', 11:03:32 INFO - 'USER': 'cltbld', 11:03:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:32 INFO - '_': '/tools/buildbot/bin/python'} 11:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:32 INFO - Downloading/unpacking jsonschema 11:03:32 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 11:03:32 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 11:03:32 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 11:03:32 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 11:03:32 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 11:03:32 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 11:03:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:34 INFO - Downloading/unpacking functools32 (from jsonschema) 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:34 INFO - warning: no files found matching '*.txt' 11:03:34 INFO - no previously-included directories found matching 'build' 11:03:34 INFO - no previously-included directories found matching 'dist' 11:03:34 INFO - no previously-included directories found matching '.git*' 11:03:34 INFO - Installing collected packages: jsonschema, functools32 11:03:34 INFO - Running setup.py install for functools32 11:03:34 INFO - warning: no files found matching '*.txt' 11:03:34 INFO - no previously-included directories found matching 'build' 11:03:34 INFO - no previously-included directories found matching 'dist' 11:03:34 INFO - no previously-included directories found matching '.git*' 11:03:34 INFO - Successfully installed jsonschema functools32 11:03:34 INFO - Cleaning up... 11:03:34 INFO - Return code: 0 11:03:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:03:34 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')]} 11:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:34 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')]} 11:03:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:34 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 0x7f264bf5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21229a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, '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': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', '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 11:03:34 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 11:03:34 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 11:03:34 INFO - Using env: {'DISPLAY': ':0', 11:03:34 INFO - 'HOME': '/home/cltbld', 11:03:34 INFO - 'LANG': 'en_US.UTF-8', 11:03:34 INFO - 'LANGUAGE': 'en_US:en', 11:03:34 INFO - 'LOGNAME': 'cltbld', 11:03:34 INFO - 'MAIL': '/var/mail/cltbld', 11:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:34 INFO - 'MOZ_NO_REMOTE': '1', 11:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:34 INFO - 'NO_EM_RESTART': '1', 11:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:34 INFO - 'PWD': '/builds/slave/test', 11:03:34 INFO - 'SHELL': '/bin/bash', 11:03:34 INFO - 'SHLVL': '1', 11:03:34 INFO - 'TERM': 'linux', 11:03:34 INFO - 'TMOUT': '86400', 11:03:34 INFO - 'USER': 'cltbld', 11:03:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:34 INFO - '_': '/tools/buildbot/bin/python'} 11:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:34 INFO - Downloading/unpacking flake8 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:34 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 11:03:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:03:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:03:36 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 11:03:36 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 11:03:36 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 11:03:36 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 11:03:36 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 11:03:36 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 11:03:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:03:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:03:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:37 INFO - no previously-included directories found matching 'docs/_build' 11:03:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:03:37 INFO - Running setup.py install for pep8 11:03:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:37 INFO - no previously-included directories found matching 'docs/_build' 11:03:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:03:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:03:37 INFO - Cleaning up... 11:03:37 INFO - Return code: 0 11:03:37 INFO - Running post-action listener: _resource_record_post_action 11:03:37 INFO - Running post-action listener: _start_resource_monitoring 11:03:37 INFO - Starting resource monitoring. 11:03:37 INFO - ##### 11:03:37 INFO - ##### Running install step. 11:03:37 INFO - ##### 11:03:37 INFO - Running pre-action listener: _resource_record_pre_action 11:03:37 INFO - Running main action method: install 11:03:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:38 INFO - Reading from file tmpfile_stdout 11:03:38 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:38 INFO - Reading from file tmpfile_stdout 11:03:38 INFO - Output received: 11:03:38 INFO - Usage: mozinstall [options] installer 11:03:38 INFO - Options: 11:03:38 INFO - -h, --help show this help message and exit 11:03:38 INFO - -d DEST, --destination=DEST 11:03:38 INFO - Directory to install application into. [default: 11:03:38 INFO - "/builds/slave/test"] 11:03:38 INFO - --app=APP Application being installed. [default: firefox] 11:03:38 INFO - mkdir: /builds/slave/test/build/application 11:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:03:54 INFO - Reading from file tmpfile_stdout 11:03:54 INFO - Output received: 11:03:54 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:54 INFO - Running post-action listener: _resource_record_post_action 11:03:54 INFO - ##### 11:03:54 INFO - ##### Running run-tests step. 11:03:54 INFO - ##### 11:03:54 INFO - Running pre-action listener: _resource_record_pre_action 11:03:54 INFO - Running main action method: run_tests 11:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:54 INFO - Python 2.7.3 11:03:54 INFO - Return code: 0 11:03:54 INFO - grabbing minidump binary from tooltool 11:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:54 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 0x21b1810>, '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 0x21b2710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b2ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:54 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 11:03:54 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 11:03:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:54 INFO - Return code: 0 11:03:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:03:55 INFO - Return code: 0 11:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:03:55 INFO - Using env: {'DISPLAY': ':0', 11:03:55 INFO - 'HOME': '/home/cltbld', 11:03:55 INFO - 'LANG': 'en_US.UTF-8', 11:03:55 INFO - 'LANGUAGE': 'en_US:en', 11:03:55 INFO - 'LOGNAME': 'cltbld', 11:03:55 INFO - 'MAIL': '/var/mail/cltbld', 11:03:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:55 INFO - 'MOZ_NO_REMOTE': '1', 11:03:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:55 INFO - 'NO_EM_RESTART': '1', 11:03:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:55 INFO - 'PWD': '/builds/slave/test', 11:03:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:55 INFO - 'SHELL': '/bin/bash', 11:03:55 INFO - 'SHLVL': '1', 11:03:55 INFO - 'TERM': 'linux', 11:03:55 INFO - 'TMOUT': '86400', 11:03:55 INFO - 'USER': 'cltbld', 11:03:55 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1460737735.969896-595915507', 11:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:55 INFO - '_': '/tools/buildbot/bin/python'} 11:03:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:03:55 INFO - mozversion application_buildid: 20160415083221 11:03:55 INFO - mozversion application_changeset: fec92924befbea7a0ee52c4cedd531a67b61f2fb 11:03:55 INFO - mozversion application_display_name: Nightly 11:03:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:55 INFO - mozversion application_name: Firefox 11:03:55 INFO - mozversion application_remotingname: firefox 11:03:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:03:55 INFO - mozversion application_vendor: Mozilla 11:03:55 INFO - mozversion application_version: 48.0a1 11:03:55 INFO - mozversion platform_buildid: 20160415083221 11:03:55 INFO - mozversion platform_changeset: fec92924befbea7a0ee52c4cedd531a67b61f2fb 11:03:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:55 INFO - mozversion platform_version: 48.0a1 11:03:55 INFO - using testdate: 1460743435 11:03:55 INFO - actual date: 1460743435 11:03:55 INFO - starting webserver on 'localhost:36230' 11:03:55 INFO - SUITE-START | Running 2 tests 11:03:55 INFO - TEST-START | dromaeo_css 11:03:55 INFO - operating with platform_type : linux_ 11:03:55 INFO - Initialising browser for dromaeo_css test... 11:03:55 INFO - TEST-INFO | started process 5792 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHm1ZLj/profile http://localhost:36230/getInfo.html) 11:04:00 INFO - PROCESS | 5792 | __metrics Screen width/height:1600/1200 11:04:00 INFO - PROCESS | 5792 | colorDepth:24 11:04:00 INFO - PROCESS | 5792 | Browser inner width/height: 1024/697 11:04:00 INFO - PROCESS | 5792 | __metrics 11:04:01 ERROR - PROCESS | 5792 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:04:01 INFO - TEST-INFO | 5792: exit 0 11:04:01 INFO - Browser initialized. 11:04:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:01 INFO - TEST-INFO | started process 5876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHm1ZLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:13 INFO - PROCESS | 5876 | RSS: Main: 152948736 11:04:13 INFO - PROCESS | 5876 | 11:05:05 INFO - PROCESS | 5876 | 1460743505330 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] 11:07:12 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36230/tests/dromaeo/cssquery-ext.html) 11:07:13 INFO - PROCESS | 5876 | RSS: Main: 276819968 11:07:13 INFO - PROCESS | 5876 | 11:10:15 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-ext.html (next: http://localhost:36230/tests/dromaeo/cssquery-jquery.html) 11:10:16 INFO - PROCESS | 5876 | RSS: Main: 236371968 11:10:16 INFO - PROCESS | 5876 | 11:13:18 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36230/tests/dromaeo/cssquery-mootools.html) 11:13:19 INFO - PROCESS | 5876 | RSS: Main: 231841792 11:13:19 INFO - PROCESS | 5876 | 11:16:20 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36230/tests/dromaeo/cssquery-prototype.html) 11:16:21 INFO - PROCESS | 5876 | RSS: Main: 229605376 11:16:21 INFO - PROCESS | 5876 | 11:19:24 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36230/tests/dromaeo/cssquery-yui.html) 11:19:24 INFO - PROCESS | 5876 | RSS: Main: 220561408 11:19:24 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | Cycle 1(1): loaded http://localhost:36230/tests/dromaeo/cssquery-yui.html (next: http://localhost:36230/tests/dromaeo/cssquery-dojo.html) 11:22:27 INFO - PROCESS | 5876 | RSS: Main: 264167424 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | __start_tp_report 11:22:27 INFO - PROCESS | 5876 | _x_x_mozilla_page_load 11:22:27 INFO - PROCESS | 5876 | _x_x_mozilla_page_load_details 11:22:27 INFO - PROCESS | 5876 | |i|pagename|runs| 11:22:27 INFO - PROCESS | 5876 | |0;dojo.html;3014.1861697341715;3057.510798272277;3085.7685673574474;3093.597832281803;3122.250659841637;5179.611529135311;5195.376554813418;5218.425973142951;5237.607179461541;5309.920351194735;5232.555232805206;5261.368635763704;5326.733663316838;5349.54528865046;5351.759170837312;4689.085628302482;4715.2927060940965;4715.740634265106;4727.267273572602;4801.919568097185;4757.833475828346;4786.16242157621;4814.301926220696;4832.516748325174;4856.927146092811;4606.861794146181;4677.111348843709;4706.694064885805;4768.23708206687;4800.159972004903;4757.524247575249;4783.8757891895375;4793.688410253322;4794.568488836021;4795.880102997418;4741.933065060368;4751.667383283171;4762.59517940972;4767.380240568738;4767.76161191939;5111.744412779346;5208.765605547759;5236.188390799432;5237.3453318335205;5271.920921186185;5551.639143455703;5557.888422315553;5565.1374037024325;5566.192902029224;5567.3040869891265;5411.512963833235;5518.862028449281;5552.08390615548;5560.749766260528;5573.749181286852;5156.226566015091;5216.374035115772;5217.3217481727515;5220.765065572058;5232.372115346183;5609.691466969356;5644.350899646511;5649.06790379591;5666.235058267163;5704.600677952587;5536.390996990328;5558.110702287615;5575.191597218381;5575.749091290902;5616.69108199053;5383.865403364947;5632.183333416631;5664.405237450091;5665.433456654301;5668.631538949955;5496.1755736639825;5539.9169012464845;5541.2796336476;5579.302587176603;5586.469285417878;5434.402215756264;5440.6735595864375;5441.211024401518;5444.455554444524;5463.371712253142;4144.191882582867;4183.97908010458;4185.183889141588;4193.287141185945;4230.280852255124;3720.088578298334;3787.0532366908274;3798.3922572388287;3807.2004878975727;3848.5381754189675;5346.4118946915805;5376.650517716336;5386.111291636915;5388.218708287276;5428.430014848463;5431.565474762088;5570.108782594765;5634.661920284796;5652.7173641318595;5658.122990936411;5288.8413347599635;5309.41596424393;5318.547923426475;5321.6540924839765;5339.225812257201;4781.952180478151;4817.710937343771;4822.228443449101;4824.758762061883;4864.173090574611;5558.749856256478;5657.15142728594;5763.452472015152;5766.798162064308;5784.363719990798;5568.1091025435735;5576.749046293007;5600.831975040755;5611.579131565068;5625.381208067191;5761.711914404347;5777.104548794943;5780.855478613068;5786.537077033743;5786.797462088806;5384.111621582551;5448.128299472065;5490.80782172622;5547.861303467445;5552.278203833475;5579.386267510652;5593.216949627137;5595.524380427709;5596.524295434933;5597.104463285855;5416.729163541886;5445.319335083114;5447.070401286842;5448.482394172547;5493.533049690821;5451.155070964007;5477.808276710296;5479.150731636602;5510.972445137749;5526.115821468546;5410.78356865721;5424.186372044225;5438.972805135949;5455.972720136374;5460.099083651312;5385.2191432241325;5396.298481197577;5499.890002199853;5551.611387202857;5613.803516876889;5266;5289.709066001253;5319.148936170194;5349.598780091431;5360.544353729977 11:22:27 INFO - PROCESS | 5876 | |1;ext.html;583.8715482593827;650.9218893732752;651.3519048546697;651.6090345792525;659.2780904909124;25755;35339.46990795137;36270.45594316081;36328.45507317392;36381.27237455249;38447;39569.40645890314;39597.20805583886;39602.20795584094;39618.80190599043;8341.457805242655;8511.27654149398;8525.914740852606;8533.232009119178;8534.70128545501;8385.664573417056;8487.321014318839;8505.85171001913;8518.446300990447;8706.347023973196;8723.476591404504;8778.429402088845;8778.64885404583;8795.560221988875;8797.736067917973;8647.048824629317;8724.781880453007;8733.781655458633;8734.170253825876;8735.475871447734;8595.570221488962;8675.43609665376;8677.956610216908;8679.739607811776;8714.172153645393;37311.626883731085;37561.43657845134;37962.24075518502;38123.42814857779;38203.23593528142;3185.2514659055105;3463.6536346365415;3463.9134021649406;3749.943750843712;3927.626875446828;29202;29480.557791633142;29766.404671906657;29897.55153672675;29900.40199196004;3588.6411358864166;3600.2619463010283;3614.5843228028853;3666.395044817602;3768.924621507582;212344;212729;212820.99999999846;213188.94488440888;215232;49152.50847491479;49519;49709.75145124251;49832.252516212284;50057.49942500601;48675;51862.74068629708;52360.02579754917;52560.21159682608;52725.472745272054;16065;16305.347786088423;16320.918395408184;16350.427735029218;16353.100579468006;11576.768464630828;12416.503339866485;12448.62654120378;12699.746005080031;12704.745905081847;15058.096514208963;15182.848171518144;15223.695526089637;15231.390744370101;15255.313510892036;5420.159875219348;5436.749547603994;5448.83653490396;5560.499555040065;5710.7430165642645;967.8064387122604;973.6738192705523;1059.750958524746;1066.632011955874;1077.6982444915436;30021.849890750407;30040.24899377533;30306.696933030387;31009.257460995428;31223.687763122078;1076.5263284154946;1104.8011357955484;1128.3906690387264;1151.2574389518882;1176.423552459306;15637.921810391103;16100.114493702724;16208.51374458768;16438.342466301452;16514.174291285388;429080;631735;652693;656877;658324;48905.10948905081;49104;49360;49368;49391.50608493941;1233.6360773571819;1311.8360204974379;1316.6576690060463;1331.3875617215995;1437.7196446693004;27121.457570848866;28820.855895721226;28857.567136493388;30544.08367748971;30762.384752305275;42109;42717.78641106775;42779.57220427756;42837.785811070746;42870;228384;232424;233414;233664;234144;23585.764142358355;26919.327016824736;26990.190294291202;27456.45087098207;27914;42842;43067.353989690804;43561.56438435575;44113.117737644425;44292.778536107115;35750.821245894644;36912.81543592265;37156.44265335968;37287.627123728416;37628;36948.44577331289;36951;36956.44565331468;37167.442488362154;37529.4370584436;36755.264894701424;36781.44827827531;37411.812940935124;37673.43489847709;38268.61731382651;33111.66888331086;34020.65979340175;34141;34311.142221444665;34750.82624586962;26255.73744262533;26597.33506662349;26631.20106396811;27087.72912270852;27117.593236101868 11:22:27 INFO - PROCESS | 5876 | |2;jquery.html;384.1586924635048;389.77393111995065;391.9253456632715;398.4680451597118;398.4720245674481;12700.618981430549;13093.47626094955;15971.281292341844;16973.06648134352;16973.405930792425;17416.216270267836;17763.82236177638;17764.200610972504;17948.371806986757;18485.7227141593;5501.14732216506;5590.692511911863;5657.462541058593;5683.744231509592;5695.373508914016;3892.746971446861;5584.916226256589;5614.494695477406;5943.673097979631;6294.307626161119;6309.5267854910835;6354.7458101675875;6383.71273292703;6398.840028999289;6403;6302.653354065525;6366.968165159168;6378.075179099004;6385.521085918552;6392.296847346788;4787.6648634595595;5468.7539060742365;5604.2714447122025;5607.158926161109;5616.354119276295;12593.433295501725;12788.040896932767;12831.10182287231;12933.353332333345;12959.67600809978;2091.5816836632735;2190.7654192723335;2251.7297924249197;2414.903403863861;2675.264302316859;9437.716868493957;9668.661596844076;10027.949860250652;10106.747331316703;10160.288779785418;1859.5932697600317;1889.1309997401213;1925.104826255798;1925.3261358524544;1977.3968939473455;71045;74060;79158.20841791567;81032.59483702543;81267.59366203132;10184.287099902936;10303.433311167957;10688.198385121146;10710.089642380484;10875.673729788119;14837.62905927339;15005.774913376308;15113.773293400607;15139.167345795866;15159.545213643609;7860.3318717909615;7861.135275119732;7867.370610351159;8024.759257222293;8337.499750015018;7568.962155189189;7655.617219139021;7729.961350193213;7761.223877612194;7854.685812567547;4381.824727010948;4476.65342739147;4492.2587773017085;4542.136993971135;4605;1829.795265578594;1861.5811442425345;1873.203888347447;1909.1504280595002;1913.4833594929569;935.8876934767735;956.416585882611;1039.4335087377397;1077.7305673581604;1085.3867564825848;17815.910920445316;18136.727949080774;18317.81682183188;18418.447446576356;18525.35161269376;947.8104379124064;975.190591808797;998.1765043838863;1006.4011912911806;1022.7392015036266;10110.140638045701;10374.066334029974;10418.270721049605;10444.529996150191;10607.363558186533;450735;451555;453412;460004;485762;72316;85451.57274213714;93385;94669.5266523663;96681;1028.2545154762886;1050.411769409118;1051.679237832453;1054.778496515725;1064.4571268653042;15132.869494396096;16823.327066917187;17048.147592620568;17229.91717443332;17274.827251727824;37861.43207851939;38786.2242755149;38882.6111738879;39369.40945885871;41157.588424115376;52061.7396913013;52621;54458;56617.43382566122;60018.09972850498;8448.704295349633;8585.553117361522;8756.605952732016;8807.515586642796;8817.294616430798;12958.67603309887;13814.723705525632;13862.722745545234;13868.653283667585;14238.572842814732;12060;12064.75870482568;12109.33398663082;12212;12300.200486968319;9688.740463739668;11655.125865560287;12155.45300461499;12205.20666156697;12293.44679489443;6692.631905245258;11125.666230013112;11590.884091159318;11749.530018799152;12615.026266725952;7491.475596708178;8364.414490985817;8619.224269815746;8746.69386571467;8832.895888013998;11262.943685281522;11504.654860354203;11646.068314534987;11705.414729263674;11790.882091178979 11:22:27 INFO - PROCESS | 5876 | |3;mootools.html;1163.4357336691708;1385.556621880998;1393.4844107680158;1415.3701602786757;1505.2022428113105;7280.817979550514;8110.675572977081;8298.294644955186;8312.376571757111;8330.750077497669;8079.798005049876;8214.630341634625;8248.711295104673;8253.793655158624;8255.298299644537;2005.1979208316643;2201.3726088064905;2244.2481768607495;2260.2880092770806;2277.646964720471;2292.1404473322505;2301.2750983440246;2306.746257911628;2307.261676263596;2312.7918487336137;2226.4322597737555;2239.74242962059;2244.1808739809935;2245.2253972379503;2248.57277117348;1954.3452943264024;2271.7955384015436;2342.906283748648;2363.9527209455714;2365.3849999000386;2247.381969958258;2257.3228031590456;2265.3090807303765;2277.02088102116;2277.977220227793;8149.103598604208;8164.224398682175;8236.670533178725;8243;8261.049979252402;4786.593139583139;4916.139675556799;4920.926186107175;4923.064617722621;4952.133376659106;3127;3183.0769076967654;3187.1872672468603;3280.097973057428;3316.2041110133637;970.4613939263705;983.2232536296317;985.8619793228954;986.763176837561;1011.4942528735633;10828.187885908588;11123.666290011313;11419.942900285529;11656;11670.533178672842;4329.870103896888;4502.909941801146;4574.039451715177;4631.305304204329;4643.489216186217;9230.076992300716;9256;9294.395864268801;9317.72046838596;9333.113354231336;4648.093621743727;5098.923516147261;5113.411957624847;5123.820666276662;5149.510796474329;4656.254999200111;4744.644151688637;4749.881252968704;4813.374261346003;4824.8793780155775;3803.847846086181;3812.84748610058;3946.309395855714;3962.187751510991;3976.5426975897562;1211.5638370186725;1244.4959791284543;1256.7989121740661;1257.2142410993129;1260.136806287696;859.6346552715071;877.1272583779053;877.7454538183982;891.8662200669952;898.8427025270552;5552.3892371839065;5573.860653483695;5611.242482264924;5617.41017193197;5675.80134695292;863.9891327147253;876.8684697295329;900.9099090090939;915.1763412928418;929.159111004542;3720.9441858372147;3886.203328317688;3909.706771992112;3928.135810121769;3937.822797974098;9999.500024998866;10295.12491438236;10400.427976461217;10448.895511044791;10478.109360704426;10313.9484302578;10316.277860549839;10329.896701033043;10340.37957722539;10354.17166626668;7714.190010048977;7798.883016754753;7886.171951945078;7889.8816517752275;7903.091144518339;5484.7806087757635;5497.697626630414;5514.5864060194845;5650.604457687922;5720.971395142998;9164.266858651425;9197.126273004054;9282.257419406566;9304;9335.25317974574;9048.366614336934;9420.434773913586;9497.14525692691;9528.047195280693;9629.662961796303;7301.780946571611;7383.04020477356;7506.024216851774;7538;7555.508891922007;8004.719834805754;8038.236367545074;8059.798505037421;8068.636911338886;8142.796430089295;7272.709091636275;7339.4862359636445;7498.362639175732;7581.734639287599;7640.312371886334;7235.565866048054;7243.130824301117;7251.1298644163035;7322.121345438369;7409.481336306622;6829.624370659462;6882.380585747307;6890.414314783099;6913.516053876381;6914.688839002157;4698.436187657503;4701.318308845267;4850.975745121252;4865.197242454955;4866.732329721758;4875.488073752205;4925.605951523798;4986.1772807487805;5010.323606313247;5142.280080788618 11:22:27 INFO - PROCESS | 5876 | |4;prototype.html;328.24012411267915;331.2001516338043;331.50605597659484;333.26681301137506;334.4147741452458;5474.945250547494;5547.833564993051;5562.610617256793;5569.805056823012;5602.635828671134;5529.972350138244;5541.944580554194;5556.444355564441;5557.526545908807;5559.861003474915;3941.507311586052;4055.6755459563165;4126.133511962492;4185.330347144458;4221.598948099941;4245.745255284677;4284.935725964113;4289;4315.741055536678;4321.416608757824;4280.678949078816;4282.892927676818;4288.185244803493;4291.206126866539;4297.419848320468;4065.26825171469;4159.292920203573;4262.573742625744;4276.25165596021;4294.355846623016;3768.208676178006;3768.8680896168776;3781.241722598977;3786.2616789726017;3794.3359912015285;5323;5350.892982140335;5384.596155288369;5384.9461505385225;5399.946000539983;4941.9258711119;4962.206047032493;4966.776495057695;4975.776090075955;4980.452150263468;5826.650400975913;5845.444682755132;5851.385604511507;5851.61964472308;5856.180134781134;3926.4306675532175;3951.288768021755;4017.2367250222655;4022.1151346703973;4104.261232978063;5837.620554663933;5979.940200597982;6018.638881667114;6056.547098425189;6056.878862422771;4249.6387807036745;4262.2754131797665;4274.572542745701;4275.636570891447;4282.743035417885;4171.93615628013;4299.903524601269;4326.697131200785;4328.177646247203;4330.978345108254;4901.264810278487;4908.754562271872;4910.558049775537;4915.21356582945;4915.311856340115;5848;5864.38423965486;5867;5894.440028197314;5913.113033045078;1401.7617005109155;1448.7754398068316;1465.6116129225763;1472.271225743264;1474.402866838932;965.9613615455303;966.1932286540817;987.2694206287439;988.3279370028449;990.1682586627123;5642.7178641067785;5643.0249412705225;5649.858753531113;5658.943410565924;5673.177389278531;5950;5955.166276721263;5964.105384192406;5993.250843644544;6005.219321488178;5495.450454954553;5642.322921249476;5655.3779084300695;5816.680082595498;5832.825015249549;3254.414205442996;3256.0557438342616;3258.902232933016;3277.360914621626;3288.845805997076;6219.222597175353;6361.236651601837;6388.904166437507;6390.392912673288;6394.4564712;6169.5064394848305;6188.381161883775;6196.349383314777;6202.751889924352;6208.751649933952;6313.526485513605;6342.39747224013;6347.206599175103;6348.3969022943675;6360.9045864313;5883.616920270776;6108.664023478751;6113.602615829956;6135.723892424762;6141.31521087344;5938.465538101419;5970.791022314198;6005.6396616203165;6006.879862402815;6024.7288872001745;6002.129691194839;6250.156228909039;6254.124422580933;6259.624422534663;6262.405071518198;4136.807492029229;4160.625543701081;4175.8956026099595;4195.853145139906;4206.263903816881;6071.726772295169;6102.969485152724;6106.969465152823;6109.7861574844665;6123.601965872204;5632.6338787980285;5854.590178687451;5936;5944.5838791284195;5962.165296858357;5832.329282132439;5880.794172203952;5906.291245050621;5922.585419020799;5943.603253235573;5636.802711905064;5799.8550036249435;5825.41745825431;5831.763371328953;5837.970810145922;5890.087036509348;5890.381509941394;5905.4685078343155;5955.3746856581165;5956.731947062479;5760.942390576208;5761.48146666802;5797.304323481209;5805.274340707411;5822.184894114912 11:22:27 INFO - PROCESS | 5876 | |5;yui.html;770.710983381232;779.4621711019398;780.2704471319313;785.3795501553773;795.7374066558036;14233.71532569348;14575.635609109777;14600.050996685208;14604.926975365135;14608.634784130401;13861.306934653252;14428.495002674908;14441.63895902603;14467.204303763288;14477.78283325751;588.9941100588982;715.1132595581494;730.5324592260944;735.2206660939421;735.7535225699397;735.8712225360567;741.4624397311933;741.4846681556321;741.8219627289438;742.6323969635012;836.3727204596553;842.0695131879277;842.692417267696;842.8230071684953;843.1863251961855;588.1413136820247;739.5525706947274;760.7527553545065;837.6146972392706;840.7099550655045;558.9580781441408;559.5355854640679;561.2451253064621;561.6377436553441;562.0697745231648;13975;14025.298735063207;14049.859501404957;14080.15519068859;14130.15219086858;13412.329383530785;13751.312434378342;13960.860391396058;14010.159390436504;14132.36404361796;11440.427978601037;11585.420728963518;11589.536418543248;11636.360000199986;11671.883281167164;3826.890201841463;3896.883093507199;3899.98050009751;3938.2123575284772;3946.467226924357;56443;56899.431005689825;56994.715026425016;57205;57988.420115798726;11413.942930285295;11484.138689598314;11501.07991360689;11559.884401156049;11585.362805045803;19318.61362772765;19496.610067798563;19504.90247548753;19512.219511219675;19533.706994395096;8156.510609363457;8274.379421543408;8290.8341833163;8377.958110209533;8533.871991920127;4813.975930120327;4852.369192005017;4866.7566621668775;4908.607311415079;4957.082939656175;3146.197719581492;3224.2423030587793;3242.5784647996084;3249.3988612106837;3259.3970115528705;553.0874057804655;587.1017343464506;591.5799782154633;597.1192491075628;602.2111034544761;672.2739441403272;708.2457183099982;720.4416577152748;729.7117638532856;767.539476314207;9255.53722313895;9356.391834530734;9446.29152813528;9689.079537443931;9707.417554946585;616.6423474384846;620.7827260458803;714.7349191930358;741.9888701669479;746.6117618838174;4361.280388735823;4405.118976204772;4433.645308375322;4486.641068714495;4508.864734057984;56763.71618141883;57333.71333143308;57337.42662573404;57644;58124.70937645285;47607;47805.52194478011;48012.279815802794;49583.256251156265;50707.23939140916;45873.311900321525;45971.77014114908;46369.76815115903;47125.528744712115;47160.52839471561;8892.866607000771;8904.465732056098;8932.28541716674;8957.462552246887;9011.2790976723;30600.693993059784;31045.844770776002;31209.219769505034;31265.68734312628;31269.687303127586;38990;40754.1849163021;41986.37020444635;42383.3642495369;42848.35727464153;10895.128389728961;11014.857618618074;11034.558617655204;11095.548322458972;11218.775624487302;12425.502979880703;12480.75038499243;12672.809907851206;12687.492500299884;12745;11178.832317515407;11181.105511559219;11202;11224.55101795919;11694.941525292319;12196.756064878475;12843.42204600814;13028.088033837541;13507.797383039066;13526.93236533811;11996.700082498008;12250.509979600716;12264.448099835707;12293.692657683629;12703.93648031754;10109.988330809263;10266.897331026892;10329.793404132026;10406.375617462976;10724.463776811284;10229.795404091728;10692.358458492205;10700.732481688021;10772.353658780497;10843.403612801056 11:22:27 INFO - PROCESS | 5876 | __end_tp_report 11:22:27 INFO - PROCESS | 5876 | __start_cc_report 11:22:27 INFO - PROCESS | 5876 | _x_x_mozilla_cycle_collect,1007 11:22:27 INFO - PROCESS | 5876 | __end_cc_report 11:22:27 INFO - PROCESS | 5876 | __startTimestamp1460744547572__endTimestamp 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | ------- Summary: start ------- 11:22:27 INFO - PROCESS | 5876 | Number of tests: 6 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#0] dojo.html Cycles:165 Average:5186.85 Median:5396.30 stddev:582.50 (10.8%) stddev-sans-first:558.79 11:22:27 INFO - PROCESS | 5876 | Values: 3014.2 3057.5 3085.8 3093.6 3122.3 5179.6 5195.4 5218.4 5237.6 5309.9 5232.6 5261.4 5326.7 5349.5 5351.8 4689.1 4715.3 4715.7 4727.3 4801.9 4757.8 4786.2 4814.3 4832.5 4856.9 4606.9 4677.1 4706.7 4768.2 4800.2 4757.5 4783.9 4793.7 4794.6 4795.9 4741.9 4751.7 4762.6 4767.4 4767.8 5111.7 5208.8 5236.2 5237.3 5271.9 5551.6 5557.9 5565.1 5566.2 5567.3 5411.5 5518.9 5552.1 5560.7 5573.7 5156.2 5216.4 5217.3 5220.8 5232.4 5609.7 5644.4 5649.1 5666.2 5704.6 5536.4 5558.1 5575.2 5575.7 5616.7 5383.9 5632.2 5664.4 5665.4 5668.6 5496.2 5539.9 5541.3 5579.3 5586.5 5434.4 5440.7 5441.2 5444.5 5463.4 4144.2 4184.0 4185.2 4193.3 4230.3 3720.1 3787.1 3798.4 3807.2 3848.5 5346.4 5376.7 5386.1 5388.2 5428.4 5431.6 5570.1 5634.7 5652.7 5658.1 5288.8 5309.4 5318.5 5321.7 5339.2 4782.0 4817.7 4822.2 4824.8 4864.2 5558.7 5657.2 5763.5 5766.8 5784.4 5568.1 5576.7 5600.8 5611.6 5625.4 5761.7 5777.1 5780.9 5786.5 5786.8 5384.1 5448.1 5490.8 5547.9 5552.3 5579.4 5593.2 5595.5 5596.5 5597.1 5416.7 5445.3 5447.1 5448.5 5493.5 5451.2 5477.8 5479.2 5511.0 5526.1 5410.8 5424.2 5439.0 5456.0 5460.1 5385.2 5396.3 5499.9 5551.6 5613.8 5266.0 5289.7 5319.1 5349.6 5360.5 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#1] ext.html Cycles:180 Average:50211.53 Median:36953.72 stddev:106980.00 (289.5%) stddev-sans-first:107215.21 11:22:27 INFO - PROCESS | 5876 | Values: 583.9 650.9 651.4 651.6 659.3 25755.0 35339.5 36270.5 36328.5 36381.3 38447.0 39569.4 39597.2 39602.2 39618.8 8341.5 8511.3 8525.9 8533.2 8534.7 8385.7 8487.3 8505.9 8518.4 8706.3 8723.5 8778.4 8778.6 8795.6 8797.7 8647.0 8724.8 8733.8 8734.2 8735.5 8595.6 8675.4 8678.0 8679.7 8714.2 37311.6 37561.4 37962.2 38123.4 38203.2 3185.3 3463.7 3463.9 3749.9 3927.6 29202.0 29480.6 29766.4 29897.6 29900.4 3588.6 3600.3 3614.6 3666.4 3768.9 212344.0 212729.0 212821.0 213188.9 215232.0 49152.5 49519.0 49709.8 49832.3 50057.5 48675.0 51862.7 52360.0 52560.2 52725.5 16065.0 16305.3 16320.9 16350.4 16353.1 11576.8 12416.5 12448.6 12699.7 12704.7 15058.1 15182.8 15223.7 15231.4 15255.3 5420.2 5436.7 5448.8 5560.5 5710.7 967.8 973.7 1059.8 1066.6 1077.7 30021.8 30040.2 30306.7 31009.3 31223.7 1076.5 1104.8 1128.4 1151.3 1176.4 15637.9 16100.1 16208.5 16438.3 16514.2 429080.0 631735.0 652693.0 656877.0 658324.0 48905.1 49104.0 49360.0 49368.0 49391.5 1233.6 1311.8 1316.7 1331.4 1437.7 27121.5 28820.9 28857.6 30544.1 30762.4 42109.0 42717.8 42779.6 42837.8 42870.0 228384.0 232424.0 233414.0 233664.0 234144.0 23585.8 26919.3 26990.2 27456.5 27914.0 42842.0 43067.4 43561.6 44113.1 44292.8 35750.8 36912.8 37156.4 37287.6 37628.0 36948.4 36951.0 36956.4 37167.4 37529.4 36755.3 36781.4 37411.8 37673.4 38268.6 33111.7 34020.7 34141.0 34311.1 34750.8 26255.7 26597.3 26631.2 27087.7 27117.6 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#2] jquery.html Cycles:180 Average:27307.70 Median:20268.35 stddev:75998.21 (375.0%) stddev-sans-first:76184.52 11:22:27 INFO - PROCESS | 5876 | Values: 384.2 389.8 391.9 398.5 398.5 12700.6 13093.5 15971.3 16973.1 16973.4 17416.2 17763.8 17764.2 17948.4 18485.7 5501.1 5590.7 5657.5 5683.7 5695.4 3892.7 5584.9 5614.5 5943.7 6294.3 6309.5 6354.7 6383.7 6398.8 6403.0 6302.7 6367.0 6378.1 6385.5 6392.3 4787.7 5468.8 5604.3 5607.2 5616.4 12593.4 12788.0 12831.1 12933.4 12959.7 2091.6 2190.8 2251.7 2414.9 2675.3 9437.7 9668.7 10027.9 10106.7 10160.3 1859.6 1889.1 1925.1 1925.3 1977.4 71045.0 74060.0 79158.2 81032.6 81267.6 10184.3 10303.4 10688.2 10710.1 10875.7 14837.6 15005.8 15113.8 15139.2 15159.5 7860.3 7861.1 7867.4 8024.8 8337.5 7569.0 7655.6 7730.0 7761.2 7854.7 4381.8 4476.7 4492.3 4542.1 4605.0 1829.8 1861.6 1873.2 1909.2 1913.5 935.9 956.4 1039.4 1077.7 1085.4 17815.9 18136.7 18317.8 18418.4 18525.4 947.8 975.2 998.2 1006.4 1022.7 10110.1 10374.1 10418.3 10444.5 10607.4 450735.0 451555.0 453412.0 460004.0 485762.0 72316.0 85451.6 93385.0 94669.5 96681.0 1028.3 1050.4 1051.7 1054.8 1064.5 15132.9 16823.3 17048.1 17229.9 17274.8 37861.4 38786.2 38882.6 39369.4 41157.6 52061.7 52621.0 54458.0 56617.4 60018.1 8448.7 8585.6 8756.6 8807.5 8817.3 12958.7 13814.7 13862.7 13868.7 14238.6 12060.0 12064.8 12109.3 12212.0 12300.2 9688.7 11655.1 12155.5 12205.2 12293.4 6692.6 11125.7 11590.9 11749.5 12615.0 7491.5 8364.4 8619.2 8746.7 8832.9 11262.9 11504.7 11646.1 11705.4 11790.9 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#3] mootools.html Cycles:180 Average:5480.17 Median:5106.17 stddev:3059.89 (59.9%) stddev-sans-first:3051.28 11:22:27 INFO - PROCESS | 5876 | Values: 1163.4 1385.6 1393.5 1415.4 1505.2 7280.8 8110.7 8298.3 8312.4 8330.8 8079.8 8214.6 8248.7 8253.8 8255.3 2005.2 2201.4 2244.2 2260.3 2277.6 2292.1 2301.3 2306.7 2307.3 2312.8 2226.4 2239.7 2244.2 2245.2 2248.6 1954.3 2271.8 2342.9 2364.0 2365.4 2247.4 2257.3 2265.3 2277.0 2278.0 8149.1 8164.2 8236.7 8243.0 8261.0 4786.6 4916.1 4920.9 4923.1 4952.1 3127.0 3183.1 3187.2 3280.1 3316.2 970.5 983.2 985.9 986.8 1011.5 10828.2 11123.7 11419.9 11656.0 11670.5 4329.9 4502.9 4574.0 4631.3 4643.5 9230.1 9256.0 9294.4 9317.7 9333.1 4648.1 5098.9 5113.4 5123.8 5149.5 4656.3 4744.6 4749.9 4813.4 4824.9 3803.8 3812.8 3946.3 3962.2 3976.5 1211.6 1244.5 1256.8 1257.2 1260.1 859.6 877.1 877.7 891.9 898.8 5552.4 5573.9 5611.2 5617.4 5675.8 864.0 876.9 900.9 915.2 929.2 3720.9 3886.2 3909.7 3928.1 3937.8 9999.5 10295.1 10400.4 10448.9 10478.1 10313.9 10316.3 10329.9 10340.4 10354.2 7714.2 7798.9 7886.2 7889.9 7903.1 5484.8 5497.7 5514.6 5650.6 5721.0 9164.3 9197.1 9282.3 9304.0 9335.3 9048.4 9420.4 9497.1 9528.0 9629.7 7301.8 7383.0 7506.0 7538.0 7555.5 8004.7 8038.2 8059.8 8068.6 8142.8 7272.7 7339.5 7498.4 7581.7 7640.3 7235.6 7243.1 7251.1 7322.1 7409.5 6829.6 6882.4 6890.4 6913.5 6914.7 4698.4 4701.3 4851.0 4865.2 4866.7 4875.5 4925.6 4986.2 5010.3 5142.3 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#4] prototype.html Cycles:180 Average:4926.15 Median:5646.44 stddev:1482.15 (26.2%) stddev-sans-first:1445.58 11:22:27 INFO - PROCESS | 5876 | Values: 328.2 331.2 331.5 333.3 334.4 5474.9 5547.8 5562.6 5569.8 5602.6 5530.0 5541.9 5556.4 5557.5 5559.9 3941.5 4055.7 4126.1 4185.3 4221.6 4245.7 4284.9 4289.0 4315.7 4321.4 4280.7 4282.9 4288.2 4291.2 4297.4 4065.3 4159.3 4262.6 4276.3 4294.4 3768.2 3768.9 3781.2 3786.3 3794.3 5323.0 5350.9 5384.6 5384.9 5399.9 4941.9 4962.2 4966.8 4975.8 4980.5 5826.7 5845.4 5851.4 5851.6 5856.2 3926.4 3951.3 4017.2 4022.1 4104.3 5837.6 5979.9 6018.6 6056.5 6056.9 4249.6 4262.3 4274.6 4275.6 4282.7 4171.9 4299.9 4326.7 4328.2 4331.0 4901.3 4908.8 4910.6 4915.2 4915.3 5848.0 5864.4 5867.0 5894.4 5913.1 1401.8 1448.8 1465.6 1472.3 1474.4 966.0 966.2 987.3 988.3 990.2 5642.7 5643.0 5649.9 5658.9 5673.2 5950.0 5955.2 5964.1 5993.3 6005.2 5495.5 5642.3 5655.4 5816.7 5832.8 3254.4 3256.1 3258.9 3277.4 3288.8 6219.2 6361.2 6388.9 6390.4 6394.5 6169.5 6188.4 6196.3 6202.8 6208.8 6313.5 6342.4 6347.2 6348.4 6360.9 5883.6 6108.7 6113.6 6135.7 6141.3 5938.5 5970.8 6005.6 6006.9 6024.7 6002.1 6250.2 6254.1 6259.6 6262.4 4136.8 4160.6 4175.9 4195.9 4206.3 6071.7 6103.0 6107.0 6109.8 6123.6 5632.6 5854.6 5936.0 5944.6 5962.2 5832.3 5880.8 5906.3 5922.6 5943.6 5636.8 5799.9 5825.4 5831.8 5838.0 5890.1 5890.4 5905.5 5955.4 5956.7 5760.9 5761.5 5797.3 5805.3 5822.2 11:22:27 INFO - PROCESS | 5876 | 11:22:27 INFO - PROCESS | 5876 | [#5] yui.html Cycles:180 Average:14234.91 Median:4383.20 stddev:16033.35 (365.8%) stddev-sans-first:16046.44 11:22:27 INFO - PROCESS | 5876 | Values: 770.7 779.5 780.3 785.4 795.7 14233.7 14575.6 14600.1 14604.9 14608.6 13861.3 14428.5 14441.6 14467.2 14477.8 589.0 715.1 730.5 735.2 735.8 735.9 741.5 741.5 741.8 742.6 836.4 842.1 842.7 842.8 843.2 588.1 739.6 760.8 837.6 840.7 559.0 559.5 561.2 561.6 562.1 13975.0 14025.3 14049.9 14080.2 14130.2 13412.3 13751.3 13960.9 14010.2 14132.4 11440.4 11585.4 11589.5 11636.4 11671.9 3826.9 3896.9 3900.0 3938.2 3946.5 56443.0 56899.4 56994.7 57205.0 57988.4 11413.9 11484.1 11501.1 11559.9 11585.4 19318.6 19496.6 19504.9 19512.2 19533.7 8156.5 8274.4 8290.8 8378.0 8533.9 4814.0 4852.4 4866.8 4908.6 4957.1 3146.2 3224.2 3242.6 3249.4 3259.4 553.1 587.1 591.6 597.1 602.2 672.3 708.2 720.4 729.7 767.5 9255.5 9356.4 9446.3 9689.1 9707.4 616.6 620.8 714.7 742.0 746.6 4361.3 4405.1 4433.6 4486.6 4508.9 56763.7 57333.7 57337.4 57644.0 58124.7 47607.0 47805.5 48012.3 49583.3 50707.2 45873.3 45971.8 46369.8 47125.5 47160.5 8892.9 8904.5 8932.3 8957.5 9011.3 30600.7 31045.8 31209.2 31265.7 31269.7 38990.0 40754.2 41986.4 42383.4 42848.4 10895.1 11014.9 11034.6 11095.5 11218.8 12425.5 12480.8 12672.8 12687.5 12745.0 11178.8 11181.1 11202.0 11224.6 11694.9 12196.8 12843.4 13028.1 13507.8 13526.9 11996.7 12250.5 12264.4 12293.7 12703.9 10110.0 10266.9 10329.8 10406.4 10724.5 10229.8 10692.4 10700.7 10772.4 10843.4 11:22:27 INFO - PROCESS | 5876 | -------- Summary: end -------- 11:22:27 INFO - PROCESS | 5876 | 11:22:28 INFO - TEST-INFO | 5876: exit 0 11:22:28 INFO - TEST-OK | dromaeo_css | took 1112323ms 11:22:28 INFO - TEST-START | kraken 11:22:28 INFO - operating with platform_type : linux_ 11:22:28 INFO - Initialising browser for kraken test... 11:22:28 INFO - TEST-INFO | started process 6056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgX9DB/profile http://localhost:36230/getInfo.html) 11:22:32 INFO - PROCESS | 6056 | __metrics Screen width/height:1600/1200 11:22:32 INFO - PROCESS | 6056 | colorDepth:24 11:22:32 INFO - PROCESS | 6056 | Browser inner width/height: 1024/697 11:22:32 INFO - PROCESS | 6056 | __metrics 11:22:33 ERROR - PROCESS | 6056 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:22:34 INFO - TEST-INFO | 6056: exit 0 11:22:34 INFO - Browser initialized. 11:22:34 INFO - Running cycle 1/1 for kraken test... 11:22:34 INFO - TEST-INFO | started process 6137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgX9DB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:46 INFO - PROCESS | 6137 | RSS: Main: 153497600 11:22:46 INFO - PROCESS | 6137 | 11:22:48 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36230/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:49 INFO - PROCESS | 6137 | RSS: Main: 208130048 11:22:49 INFO - PROCESS | 6137 | 11:22:52 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36230/tests/kraken/driver.html?testName=audio-dft) 11:22:52 INFO - PROCESS | 6137 | RSS: Main: 193900544 11:22:52 INFO - PROCESS | 6137 | 11:22:56 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36230/tests/kraken/driver.html?testName=audio-fft) 11:22:56 INFO - PROCESS | 6137 | RSS: Main: 264757248 11:22:56 INFO - PROCESS | 6137 | 11:22:58 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36230/tests/kraken/driver.html?testName=audio-oscillator) 11:22:59 INFO - PROCESS | 6137 | RSS: Main: 173125632 11:22:59 INFO - PROCESS | 6137 | 11:23:01 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:02 INFO - PROCESS | 6137 | RSS: Main: 177274880 11:23:02 INFO - PROCESS | 6137 | 11:23:05 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36230/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:05 INFO - PROCESS | 6137 | RSS: Main: 213327872 11:23:05 INFO - PROCESS | 6137 | 11:23:09 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36230/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:09 INFO - PROCESS | 6137 | RSS: Main: 212942848 11:23:09 INFO - PROCESS | 6137 | 11:23:12 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36230/tests/kraken/driver.html?testName=json-parse-financial) 11:23:13 INFO - PROCESS | 6137 | RSS: Main: 214343680 11:23:13 INFO - PROCESS | 6137 | 11:23:14 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:15 INFO - PROCESS | 6137 | RSS: Main: 203665408 11:23:15 INFO - PROCESS | 6137 | 11:23:17 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:17 INFO - PROCESS | 6137 | RSS: Main: 206561280 11:23:17 INFO - PROCESS | 6137 | 11:23:19 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:20 INFO - PROCESS | 6137 | RSS: Main: 214921216 11:23:20 INFO - PROCESS | 6137 | 11:23:22 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:23 INFO - PROCESS | 6137 | RSS: Main: 223162368 11:23:23 INFO - PROCESS | 6137 | 11:23:26 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:26 INFO - PROCESS | 6137 | RSS: Main: 218398720 11:23:26 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | Cycle 1(1): loaded http://localhost:36230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36230/tests/kraken/driver.html?testName=ai-astar) 11:23:28 INFO - PROCESS | 6137 | RSS: Main: 282501120 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | __start_tp_report 11:23:28 INFO - PROCESS | 6137 | _x_x_mozilla_page_load 11:23:28 INFO - PROCESS | 6137 | _x_x_mozilla_page_load_details 11:23:28 INFO - PROCESS | 6137 | |i|pagename|runs| 11:23:28 INFO - PROCESS | 6137 | |0;ai-astar;111;111;105;112;112;113;101;111;112;112 11:23:28 INFO - PROCESS | 6137 | |1;audio-beat-detection;164;136;159;180;129;154;159;137;191;129 11:23:28 INFO - PROCESS | 6137 | |2;audio-dft;164;166;161;163;162;163;163;164;164;164 11:23:28 INFO - PROCESS | 6137 | |3;audio-fft;76;77;105;117;77;77;73;122;109;73 11:23:28 INFO - PROCESS | 6137 | |4;audio-oscillator;92;93;147;92;92;94;145;93;93;151 11:23:28 INFO - PROCESS | 6137 | |5;imaging-gaussian-blur;118;117;117;117;118;117;117;117;117;117 11:23:28 INFO - PROCESS | 6137 | |6;imaging-darkroom;147;146;146;146;145;146;146;146;146;146 11:23:28 INFO - PROCESS | 6137 | |7;imaging-desaturate;95;95;95;95;94;95;94;94;95;95 11:23:28 INFO - PROCESS | 6137 | |8;json-parse-financial;59;59;58;57;60;59;59;79;56;55 11:23:28 INFO - PROCESS | 6137 | |9;json-stringify-tinderbox;62;63;62;62;61;62;62;62;62;61 11:23:28 INFO - PROCESS | 6137 | |10;stanford-crypto-aes;76;78;77;77;78;79;78;78;78;80 11:23:28 INFO - PROCESS | 6137 | |11;stanford-crypto-ccm;128;128;126;125;127;127;135;126;169;133 11:23:28 INFO - PROCESS | 6137 | |12;stanford-crypto-pbkdf2;168;170;175;170;167;166;174;176;163;167 11:23:28 INFO - PROCESS | 6137 | |13;stanford-crypto-sha256-iterative;69;67;72;71;70;68;70;69;68;69 11:23:28 INFO - PROCESS | 6137 | __end_tp_report 11:23:28 INFO - PROCESS | 6137 | __start_cc_report 11:23:28 INFO - PROCESS | 6137 | _x_x_mozilla_cycle_collect,1627 11:23:28 INFO - PROCESS | 6137 | __end_cc_report 11:23:28 INFO - PROCESS | 6137 | __startTimestamp1460744608941__endTimestamp 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | ------- Summary: start ------- 11:23:28 INFO - PROCESS | 6137 | Number of tests: 14 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:3.86 (3.4%) stddev-sans-first:4.08 11:23:28 INFO - PROCESS | 6137 | Values: 111.0 111.0 105.0 112.0 112.0 113.0 101.0 111.0 112.0 112.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:159.00 stddev:21.23 (13.4%) stddev-sans-first:22.20 11:23:28 INFO - PROCESS | 6137 | Values: 164.0 136.0 159.0 180.0 129.0 154.0 159.0 137.0 191.0 129.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 11:23:28 INFO - PROCESS | 6137 | Values: 164.0 166.0 161.0 163.0 162.0 163.0 163.0 164.0 164.0 164.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#3] audio-fft Cycles:10 Average:90.60 Median:74.50 stddev:20.05 (26.9%) stddev-sans-first:20.55 11:23:28 INFO - PROCESS | 6137 | Values: 76.0 77.0 105.0 117.0 77.0 77.0 73.0 122.0 109.0 73.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:92.50 stddev:26.59 (28.7%) stddev-sans-first:27.47 11:23:28 INFO - PROCESS | 6137 | Values: 92.0 93.0 147.0 92.0 92.0 94.0 145.0 93.0 93.0 151.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:23:28 INFO - PROCESS | 6137 | Values: 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 11:23:28 INFO - PROCESS | 6137 | Values: 147.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:23:28 INFO - PROCESS | 6137 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 95.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:6.82 (11.6%) stddev-sans-first:7.22 11:23:28 INFO - PROCESS | 6137 | Values: 59.0 59.0 58.0 57.0 60.0 59.0 59.0 79.0 56.0 55.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 11:23:28 INFO - PROCESS | 6137 | Values: 62.0 63.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 61.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.10 (1.4%) stddev-sans-first:0.93 11:23:28 INFO - PROCESS | 6137 | Values: 76.0 78.0 77.0 77.0 78.0 79.0 78.0 78.0 78.0 80.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:128.00 stddev:13.25 (10.4%) stddev-sans-first:13.96 11:23:28 INFO - PROCESS | 6137 | Values: 128.0 128.0 126.0 125.0 127.0 127.0 135.0 126.0 169.0 133.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:4.25 (2.5%) stddev-sans-first:4.47 11:23:28 INFO - PROCESS | 6137 | Values: 168.0 170.0 175.0 170.0 167.0 166.0 174.0 176.0 163.0 167.0 11:23:28 INFO - PROCESS | 6137 | 11:23:28 INFO - PROCESS | 6137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 11:23:28 INFO - PROCESS | 6137 | Values: 69.0 67.0 72.0 71.0 70.0 68.0 70.0 69.0 68.0 69.0 11:23:28 INFO - PROCESS | 6137 | -------- Summary: end -------- 11:23:28 INFO - PROCESS | 6137 | 11:23:29 INFO - TEST-INFO | 6137: exit 0 11:23:29 INFO - TEST-OK | kraken | took 61618ms 11:23:29 INFO - SUITE-END | took 1173s 11:23:30 INFO - Completed test suite (00:19:34) 11:23:30 INFO - javascript benchmark 11:23:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.1861697341715, 3057.510798272277, 3085.7685673574474, 3093.597832281803, 3122.250659841637, 5179.611529135311, 5195.376554813418, 5218.425973142951, 5237.607179461541, 5309.920351194735, 5232.555232805206, 5261.368635763704, 5326.733663316838, 5349.54528865046, 5351.759170837312, 4689.085628302482, 4715.2927060940965, 4715.740634265106, 4727.267273572602, 4801.919568097185, 4757.833475828346, 4786.16242157621, 4814.301926220696, 4832.516748325174, 4856.927146092811, 4606.861794146181, 4677.111348843709, 4706.694064885805, 4768.23708206687, 4800.159972004903, 4757.524247575249, 4783.8757891895375, 4793.688410253322, 4794.568488836021, 4795.880102997418, 4741.933065060368, 4751.667383283171, 4762.59517940972, 4767.380240568738, 4767.76161191939, 5111.744412779346, 5208.765605547759, 5236.188390799432, 5237.3453318335205, 5271.920921186185, 5551.639143455703, 5557.888422315553, 5565.1374037024325, 5566.192902029224, 5567.3040869891265, 5411.512963833235, 5518.862028449281, 5552.08390615548, 5560.749766260528, 5573.749181286852, 5156.226566015091, 5216.374035115772, 5217.3217481727515, 5220.765065572058, 5232.372115346183, 5609.691466969356, 5644.350899646511, 5649.06790379591, 5666.235058267163, 5704.600677952587, 5536.390996990328, 5558.110702287615, 5575.191597218381, 5575.749091290902, 5616.69108199053, 5383.865403364947, 5632.183333416631, 5664.405237450091, 5665.433456654301, 5668.631538949955, 5496.1755736639825, 5539.9169012464845, 5541.2796336476, 5579.302587176603, 5586.469285417878, 5434.402215756264, 5440.6735595864375, 5441.211024401518, 5444.455554444524, 5463.371712253142, 4144.191882582867, 4183.97908010458, 4185.183889141588, 4193.287141185945, 4230.280852255124, 3720.088578298334, 3787.0532366908274, 3798.3922572388287, 3807.2004878975727, 3848.5381754189675, 5346.4118946915805, 5376.650517716336, 5386.111291636915, 5388.218708287276, 5428.430014848463, 5431.565474762088, 5570.108782594765, 5634.661920284796, 5652.7173641318595, 5658.122990936411, 5288.8413347599635, 5309.41596424393, 5318.547923426475, 5321.6540924839765, 5339.225812257201, 4781.952180478151, 4817.710937343771, 4822.228443449101, 4824.758762061883, 4864.173090574611, 5558.749856256478, 5657.15142728594, 5763.452472015152, 5766.798162064308, 5784.363719990798, 5568.1091025435735, 5576.749046293007, 5600.831975040755, 5611.579131565068, 5625.381208067191, 5761.711914404347, 5777.104548794943, 5780.855478613068, 5786.537077033743, 5786.797462088806, 5384.111621582551, 5448.128299472065, 5490.80782172622, 5547.861303467445, 5552.278203833475, 5579.386267510652, 5593.216949627137, 5595.524380427709, 5596.524295434933, 5597.104463285855, 5416.729163541886, 5445.319335083114, 5447.070401286842, 5448.482394172547, 5493.533049690821, 5451.155070964007, 5477.808276710296, 5479.150731636602, 5510.972445137749, 5526.115821468546, 5410.78356865721, 5424.186372044225, 5438.972805135949, 5455.972720136374, 5460.099083651312, 5385.2191432241325, 5396.298481197577, 5499.890002199853, 5551.611387202857, 5613.803516876889, 5266.0, 5289.709066001253, 5319.148936170194, 5349.598780091431, 5360.544353729977], "value": 5148.020151191454, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.8715482593827, 650.9218893732752, 651.3519048546697, 651.6090345792525, 659.2780904909124, 25755.0, 35339.46990795137, 36270.45594316081, 36328.45507317392, 36381.27237455249, 38447.0, 39569.40645890314, 39597.20805583886, 39602.20795584094, 39618.80190599043, 8341.457805242655, 8511.27654149398, 8525.914740852606, 8533.232009119178, 8534.70128545501, 8385.664573417056, 8487.321014318839, 8505.85171001913, 8518.446300990447, 8706.347023973196, 8723.476591404504, 8778.429402088845, 8778.64885404583, 8795.560221988875, 8797.736067917973, 8647.048824629317, 8724.781880453007, 8733.781655458633, 8734.170253825876, 8735.475871447734, 8595.570221488962, 8675.43609665376, 8677.956610216908, 8679.739607811776, 8714.172153645393, 37311.626883731085, 37561.43657845134, 37962.24075518502, 38123.42814857779, 38203.23593528142, 3185.2514659055105, 3463.6536346365415, 3463.9134021649406, 3749.943750843712, 3927.626875446828, 29202.0, 29480.557791633142, 29766.404671906657, 29897.55153672675, 29900.40199196004, 3588.6411358864166, 3600.2619463010283, 3614.5843228028853, 3666.395044817602, 3768.924621507582, 212344.0, 212729.0, 212820.99999999846, 213188.94488440888, 215232.0, 49152.50847491479, 49519.0, 49709.75145124251, 49832.252516212284, 50057.49942500601, 48675.0, 51862.74068629708, 52360.02579754917, 52560.21159682608, 52725.472745272054, 16065.0, 16305.347786088423, 16320.918395408184, 16350.427735029218, 16353.100579468006, 11576.768464630828, 12416.503339866485, 12448.62654120378, 12699.746005080031, 12704.745905081847, 15058.096514208963, 15182.848171518144, 15223.695526089637, 15231.390744370101, 15255.313510892036, 5420.159875219348, 5436.749547603994, 5448.83653490396, 5560.499555040065, 5710.7430165642645, 967.8064387122604, 973.6738192705523, 1059.750958524746, 1066.632011955874, 1077.6982444915436, 30021.849890750407, 30040.24899377533, 30306.696933030387, 31009.257460995428, 31223.687763122078, 1076.5263284154946, 1104.8011357955484, 1128.3906690387264, 1151.2574389518882, 1176.423552459306, 15637.921810391103, 16100.114493702724, 16208.51374458768, 16438.342466301452, 16514.174291285388, 429080.0, 631735.0, 652693.0, 656877.0, 658324.0, 48905.10948905081, 49104.0, 49360.0, 49368.0, 49391.50608493941, 1233.6360773571819, 1311.8360204974379, 1316.6576690060463, 1331.3875617215995, 1437.7196446693004, 27121.457570848866, 28820.855895721226, 28857.567136493388, 30544.08367748971, 30762.384752305275, 42109.0, 42717.78641106775, 42779.57220427756, 42837.785811070746, 42870.0, 228384.0, 232424.0, 233414.0, 233664.0, 234144.0, 23585.764142358355, 26919.327016824736, 26990.190294291202, 27456.45087098207, 27914.0, 42842.0, 43067.353989690804, 43561.56438435575, 44113.117737644425, 44292.778536107115, 35750.821245894644, 36912.81543592265, 37156.44265335968, 37287.627123728416, 37628.0, 36948.44577331289, 36951.0, 36956.44565331468, 37167.442488362154, 37529.4370584436, 36755.264894701424, 36781.44827827531, 37411.812940935124, 37673.43489847709, 38268.61731382651, 33111.66888331086, 34020.65979340175, 34141.0, 34311.142221444665, 34750.82624586962, 26255.73744262533, 26597.33506662349, 26631.20106396811, 27087.72912270852, 27117.593236101868], "value": 18119.624432166675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1586924635048, 389.77393111995065, 391.9253456632715, 398.4680451597118, 398.4720245674481, 12700.618981430549, 13093.47626094955, 15971.281292341844, 16973.06648134352, 16973.405930792425, 17416.216270267836, 17763.82236177638, 17764.200610972504, 17948.371806986757, 18485.7227141593, 5501.14732216506, 5590.692511911863, 5657.462541058593, 5683.744231509592, 5695.373508914016, 3892.746971446861, 5584.916226256589, 5614.494695477406, 5943.673097979631, 6294.307626161119, 6309.5267854910835, 6354.7458101675875, 6383.71273292703, 6398.840028999289, 6403.0, 6302.653354065525, 6366.968165159168, 6378.075179099004, 6385.521085918552, 6392.296847346788, 4787.6648634595595, 5468.7539060742365, 5604.2714447122025, 5607.158926161109, 5616.354119276295, 12593.433295501725, 12788.040896932767, 12831.10182287231, 12933.353332333345, 12959.67600809978, 2091.5816836632735, 2190.7654192723335, 2251.7297924249197, 2414.903403863861, 2675.264302316859, 9437.716868493957, 9668.661596844076, 10027.949860250652, 10106.747331316703, 10160.288779785418, 1859.5932697600317, 1889.1309997401213, 1925.104826255798, 1925.3261358524544, 1977.3968939473455, 71045.0, 74060.0, 79158.20841791567, 81032.59483702543, 81267.59366203132, 10184.287099902936, 10303.433311167957, 10688.198385121146, 10710.089642380484, 10875.673729788119, 14837.62905927339, 15005.774913376308, 15113.773293400607, 15139.167345795866, 15159.545213643609, 7860.3318717909615, 7861.135275119732, 7867.370610351159, 8024.759257222293, 8337.499750015018, 7568.962155189189, 7655.617219139021, 7729.961350193213, 7761.223877612194, 7854.685812567547, 4381.824727010948, 4476.65342739147, 4492.2587773017085, 4542.136993971135, 4605.0, 1829.795265578594, 1861.5811442425345, 1873.203888347447, 1909.1504280595002, 1913.4833594929569, 935.8876934767735, 956.416585882611, 1039.4335087377397, 1077.7305673581604, 1085.3867564825848, 17815.910920445316, 18136.727949080774, 18317.81682183188, 18418.447446576356, 18525.35161269376, 947.8104379124064, 975.190591808797, 998.1765043838863, 1006.4011912911806, 1022.7392015036266, 10110.140638045701, 10374.066334029974, 10418.270721049605, 10444.529996150191, 10607.363558186533, 450735.0, 451555.0, 453412.0, 460004.0, 485762.0, 72316.0, 85451.57274213714, 93385.0, 94669.5266523663, 96681.0, 1028.2545154762886, 1050.411769409118, 1051.679237832453, 1054.778496515725, 1064.4571268653042, 15132.869494396096, 16823.327066917187, 17048.147592620568, 17229.91717443332, 17274.827251727824, 37861.43207851939, 38786.2242755149, 38882.6111738879, 39369.40945885871, 41157.588424115376, 52061.7396913013, 52621.0, 54458.0, 56617.43382566122, 60018.09972850498, 8448.704295349633, 8585.553117361522, 8756.605952732016, 8807.515586642796, 8817.294616430798, 12958.67603309887, 13814.723705525632, 13862.722745545234, 13868.653283667585, 14238.572842814732, 12060.0, 12064.75870482568, 12109.33398663082, 12212.0, 12300.200486968319, 9688.740463739668, 11655.125865560287, 12155.45300461499, 12205.20666156697, 12293.44679489443, 6692.631905245258, 11125.666230013112, 11590.884091159318, 11749.530018799152, 12615.026266725952, 7491.475596708178, 8364.414490985817, 8619.224269815746, 8746.69386571467, 8832.895888013998, 11262.943685281522, 11504.654860354203, 11646.068314534987, 11705.414729263674, 11790.882091178979], "value": 8873.863057345301, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1163.4357336691708, 1385.556621880998, 1393.4844107680158, 1415.3701602786757, 1505.2022428113105, 7280.817979550514, 8110.675572977081, 8298.294644955186, 8312.376571757111, 8330.750077497669, 8079.798005049876, 8214.630341634625, 8248.711295104673, 8253.793655158624, 8255.298299644537, 2005.1979208316643, 2201.3726088064905, 2244.2481768607495, 2260.2880092770806, 2277.646964720471, 2292.1404473322505, 2301.2750983440246, 2306.746257911628, 2307.261676263596, 2312.7918487336137, 2226.4322597737555, 2239.74242962059, 2244.1808739809935, 2245.2253972379503, 2248.57277117348, 1954.3452943264024, 2271.7955384015436, 2342.906283748648, 2363.9527209455714, 2365.3849999000386, 2247.381969958258, 2257.3228031590456, 2265.3090807303765, 2277.02088102116, 2277.977220227793, 8149.103598604208, 8164.224398682175, 8236.670533178725, 8243.0, 8261.049979252402, 4786.593139583139, 4916.139675556799, 4920.926186107175, 4923.064617722621, 4952.133376659106, 3127.0, 3183.0769076967654, 3187.1872672468603, 3280.097973057428, 3316.2041110133637, 970.4613939263705, 983.2232536296317, 985.8619793228954, 986.763176837561, 1011.4942528735633, 10828.187885908588, 11123.666290011313, 11419.942900285529, 11656.0, 11670.533178672842, 4329.870103896888, 4502.909941801146, 4574.039451715177, 4631.305304204329, 4643.489216186217, 9230.076992300716, 9256.0, 9294.395864268801, 9317.72046838596, 9333.113354231336, 4648.093621743727, 5098.923516147261, 5113.411957624847, 5123.820666276662, 5149.510796474329, 4656.254999200111, 4744.644151688637, 4749.881252968704, 4813.374261346003, 4824.8793780155775, 3803.847846086181, 3812.84748610058, 3946.309395855714, 3962.187751510991, 3976.5426975897562, 1211.5638370186725, 1244.4959791284543, 1256.7989121740661, 1257.2142410993129, 1260.136806287696, 859.6346552715071, 877.1272583779053, 877.7454538183982, 891.8662200669952, 898.8427025270552, 5552.3892371839065, 5573.860653483695, 5611.242482264924, 5617.41017193197, 5675.80134695292, 863.9891327147253, 876.8684697295329, 900.9099090090939, 915.1763412928418, 929.159111004542, 3720.9441858372147, 3886.203328317688, 3909.706771992112, 3928.135810121769, 3937.822797974098, 9999.500024998866, 10295.12491438236, 10400.427976461217, 10448.895511044791, 10478.109360704426, 10313.9484302578, 10316.277860549839, 10329.896701033043, 10340.37957722539, 10354.17166626668, 7714.190010048977, 7798.883016754753, 7886.171951945078, 7889.8816517752275, 7903.091144518339, 5484.7806087757635, 5497.697626630414, 5514.5864060194845, 5650.604457687922, 5720.971395142998, 9164.266858651425, 9197.126273004054, 9282.257419406566, 9304.0, 9335.25317974574, 9048.366614336934, 9420.434773913586, 9497.14525692691, 9528.047195280693, 9629.662961796303, 7301.780946571611, 7383.04020477356, 7506.024216851774, 7538.0, 7555.508891922007, 8004.719834805754, 8038.236367545074, 8059.798505037421, 8068.636911338886, 8142.796430089295, 7272.709091636275, 7339.4862359636445, 7498.362639175732, 7581.734639287599, 7640.312371886334, 7235.565866048054, 7243.130824301117, 7251.1298644163035, 7322.121345438369, 7409.481336306622, 6829.624370659462, 6882.380585747307, 6890.414314783099, 6913.516053876381, 6914.688839002157, 4698.436187657503, 4701.318308845267, 4850.975745121252, 4865.197242454955, 4866.732329721758, 4875.488073752205, 4925.605951523798, 4986.1772807487805, 5010.323606313247, 5142.280080788618], "value": 4396.302345927833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.24012411267915, 331.2001516338043, 331.50605597659484, 333.26681301137506, 334.4147741452458, 5474.945250547494, 5547.833564993051, 5562.610617256793, 5569.805056823012, 5602.635828671134, 5529.972350138244, 5541.944580554194, 5556.444355564441, 5557.526545908807, 5559.861003474915, 3941.507311586052, 4055.6755459563165, 4126.133511962492, 4185.330347144458, 4221.598948099941, 4245.745255284677, 4284.935725964113, 4289.0, 4315.741055536678, 4321.416608757824, 4280.678949078816, 4282.892927676818, 4288.185244803493, 4291.206126866539, 4297.419848320468, 4065.26825171469, 4159.292920203573, 4262.573742625744, 4276.25165596021, 4294.355846623016, 3768.208676178006, 3768.8680896168776, 3781.241722598977, 3786.2616789726017, 3794.3359912015285, 5323.0, 5350.892982140335, 5384.596155288369, 5384.9461505385225, 5399.946000539983, 4941.9258711119, 4962.206047032493, 4966.776495057695, 4975.776090075955, 4980.452150263468, 5826.650400975913, 5845.444682755132, 5851.385604511507, 5851.61964472308, 5856.180134781134, 3926.4306675532175, 3951.288768021755, 4017.2367250222655, 4022.1151346703973, 4104.261232978063, 5837.620554663933, 5979.940200597982, 6018.638881667114, 6056.547098425189, 6056.878862422771, 4249.6387807036745, 4262.2754131797665, 4274.572542745701, 4275.636570891447, 4282.743035417885, 4171.93615628013, 4299.903524601269, 4326.697131200785, 4328.177646247203, 4330.978345108254, 4901.264810278487, 4908.754562271872, 4910.558049775537, 4915.21356582945, 4915.311856340115, 5848.0, 5864.38423965486, 5867.0, 5894.440028197314, 5913.113033045078, 1401.7617005109155, 1448.7754398068316, 1465.6116129225763, 1472.271225743264, 1474.402866838932, 965.9613615455303, 966.1932286540817, 987.2694206287439, 988.3279370028449, 990.1682586627123, 5642.7178641067785, 5643.0249412705225, 5649.858753531113, 5658.943410565924, 5673.177389278531, 5950.0, 5955.166276721263, 5964.105384192406, 5993.250843644544, 6005.219321488178, 5495.450454954553, 5642.322921249476, 5655.3779084300695, 5816.680082595498, 5832.825015249549, 3254.414205442996, 3256.0557438342616, 3258.902232933016, 3277.360914621626, 3288.845805997076, 6219.222597175353, 6361.236651601837, 6388.904166437507, 6390.392912673288, 6394.4564712, 6169.5064394848305, 6188.381161883775, 6196.349383314777, 6202.751889924352, 6208.751649933952, 6313.526485513605, 6342.39747224013, 6347.206599175103, 6348.3969022943675, 6360.9045864313, 5883.616920270776, 6108.664023478751, 6113.602615829956, 6135.723892424762, 6141.31521087344, 5938.465538101419, 5970.791022314198, 6005.6396616203165, 6006.879862402815, 6024.7288872001745, 6002.129691194839, 6250.156228909039, 6254.124422580933, 6259.624422534663, 6262.405071518198, 4136.807492029229, 4160.625543701081, 4175.8956026099595, 4195.853145139906, 4206.263903816881, 6071.726772295169, 6102.969485152724, 6106.969465152823, 6109.7861574844665, 6123.601965872204, 5632.6338787980285, 5854.590178687451, 5936.0, 5944.5838791284195, 5962.165296858357, 5832.329282132439, 5880.794172203952, 5906.291245050621, 5922.585419020799, 5943.603253235573, 5636.802711905064, 5799.8550036249435, 5825.41745825431, 5831.763371328953, 5837.970810145922, 5890.087036509348, 5890.381509941394, 5905.4685078343155, 5955.3746856581165, 5956.731947062479, 5760.942390576208, 5761.48146666802, 5797.304323481209, 5805.274340707411, 5822.184894114912], "value": 4447.183214818334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.710983381232, 779.4621711019398, 780.2704471319313, 785.3795501553773, 795.7374066558036, 14233.71532569348, 14575.635609109777, 14600.050996685208, 14604.926975365135, 14608.634784130401, 13861.306934653252, 14428.495002674908, 14441.63895902603, 14467.204303763288, 14477.78283325751, 588.9941100588982, 715.1132595581494, 730.5324592260944, 735.2206660939421, 735.7535225699397, 735.8712225360567, 741.4624397311933, 741.4846681556321, 741.8219627289438, 742.6323969635012, 836.3727204596553, 842.0695131879277, 842.692417267696, 842.8230071684953, 843.1863251961855, 588.1413136820247, 739.5525706947274, 760.7527553545065, 837.6146972392706, 840.7099550655045, 558.9580781441408, 559.5355854640679, 561.2451253064621, 561.6377436553441, 562.0697745231648, 13975.0, 14025.298735063207, 14049.859501404957, 14080.15519068859, 14130.15219086858, 13412.329383530785, 13751.312434378342, 13960.860391396058, 14010.159390436504, 14132.36404361796, 11440.427978601037, 11585.420728963518, 11589.536418543248, 11636.360000199986, 11671.883281167164, 3826.890201841463, 3896.883093507199, 3899.98050009751, 3938.2123575284772, 3946.467226924357, 56443.0, 56899.431005689825, 56994.715026425016, 57205.0, 57988.420115798726, 11413.942930285295, 11484.138689598314, 11501.07991360689, 11559.884401156049, 11585.362805045803, 19318.61362772765, 19496.610067798563, 19504.90247548753, 19512.219511219675, 19533.706994395096, 8156.510609363457, 8274.379421543408, 8290.8341833163, 8377.958110209533, 8533.871991920127, 4813.975930120327, 4852.369192005017, 4866.7566621668775, 4908.607311415079, 4957.082939656175, 3146.197719581492, 3224.2423030587793, 3242.5784647996084, 3249.3988612106837, 3259.3970115528705, 553.0874057804655, 587.1017343464506, 591.5799782154633, 597.1192491075628, 602.2111034544761, 672.2739441403272, 708.2457183099982, 720.4416577152748, 729.7117638532856, 767.539476314207, 9255.53722313895, 9356.391834530734, 9446.29152813528, 9689.079537443931, 9707.417554946585, 616.6423474384846, 620.7827260458803, 714.7349191930358, 741.9888701669479, 746.6117618838174, 4361.280388735823, 4405.118976204772, 4433.645308375322, 4486.641068714495, 4508.864734057984, 56763.71618141883, 57333.71333143308, 57337.42662573404, 57644.0, 58124.70937645285, 47607.0, 47805.52194478011, 48012.279815802794, 49583.256251156265, 50707.23939140916, 45873.311900321525, 45971.77014114908, 46369.76815115903, 47125.528744712115, 47160.52839471561, 8892.866607000771, 8904.465732056098, 8932.28541716674, 8957.462552246887, 9011.2790976723, 30600.693993059784, 31045.844770776002, 31209.219769505034, 31265.68734312628, 31269.687303127586, 38990.0, 40754.1849163021, 41986.37020444635, 42383.3642495369, 42848.35727464153, 10895.128389728961, 11014.857618618074, 11034.558617655204, 11095.548322458972, 11218.775624487302, 12425.502979880703, 12480.75038499243, 12672.809907851206, 12687.492500299884, 12745.0, 11178.832317515407, 11181.105511559219, 11202.0, 11224.55101795919, 11694.941525292319, 12196.756064878475, 12843.42204600814, 13028.088033837541, 13507.797383039066, 13526.93236533811, 11996.700082498008, 12250.509979600716, 12264.448099835707, 12293.692657683629, 12703.93648031754, 10109.988330809263, 10266.897331026892, 10329.793404132026, 10406.375617462976, 10724.463776811284, 10229.795404091728, 10692.358458492205, 10700.732481688021, 10772.353658780497, 10843.403612801056], "value": 6538.987021042626, "unit": "score"}], "name": "dromaeo_css", "value": 6877.613092981905, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 112.0, 112.0, 113.0, 101.0, 111.0, 112.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 136.0, 159.0, 180.0, 129.0, 154.0, 159.0, 137.0, 191.0, 129.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 161.0, 163.0, 162.0, 163.0, 163.0, 164.0, 164.0, 164.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 105.0, 117.0, 77.0, 77.0, 73.0, 122.0, 109.0, 73.0], "value": 90.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 147.0, 92.0, 92.0, 94.0, 145.0, 93.0, 93.0, 151.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 57.0, 60.0, 59.0, 59.0, 79.0, 56.0, 55.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 77.0, 78.0, 79.0, 78.0, 78.0, 78.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 126.0, 125.0, 127.0, 127.0, 135.0, 126.0, 169.0, 133.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 175.0, 170.0, 167.0, 166.0, 174.0, 176.0, 163.0, 167.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 72.0, 71.0, 70.0, 68.0, 70.0, 69.0, 68.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1556.1000000000004, "alertThreshold": 2.0}]} 11:23:30 INFO - Return code: 0 11:23:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:23:30 ERROR - # TBPL SUCCESS # 11:23:30 INFO - Running post-action listener: _resource_record_post_action 11:23:30 INFO - Running post-run listener: _resource_record_post_run 11:23:31 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 533336064; Read time: 0; Write time: 491544 11:23:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244396032; Read time: 0; Write time: 288788 11:23:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 288940032; Read time: 0; Write time: 202756 11:23:31 INFO - Running post-run listener: _upload_blobber_files 11:23:31 INFO - Blob upload gear active. 11:23:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:31 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 11:23:31 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:31 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:31 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:32 INFO - (blobuploader) - INFO - Done attempting. 11:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:33 INFO - (blobuploader) - INFO - Done attempting. 11:23:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:33 INFO - Return code: 0 11:23:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71058bc88b6f6d6ee3aed6e6fad27dfcc4e2f239faabadc4063920f74d7fddc8eb0c519411429d27a40c68a544a30a03f7eecd94bac1bb9ba7d276a822d2dd2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a16a2be72674960cc8f265667e396b9a1e78b380beed99b736d0e55566859d724e803c99ef4f99f23aef28a521cb9018250e4483f5680297421effd8421619b"} 11:23:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:33 INFO - Contents: 11:23:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71058bc88b6f6d6ee3aed6e6fad27dfcc4e2f239faabadc4063920f74d7fddc8eb0c519411429d27a40c68a544a30a03f7eecd94bac1bb9ba7d276a822d2dd2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a16a2be72674960cc8f265667e396b9a1e78b380beed99b736d0e55566859d724e803c99ef4f99f23aef28a521cb9018250e4483f5680297421effd8421619b"} 11:23:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:33 INFO - Copying logs to upload dir... 11:23:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.975505 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-15 11:23:32.337643) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:32.341470) ========= 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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71058bc88b6f6d6ee3aed6e6fad27dfcc4e2f239faabadc4063920f74d7fddc8eb0c519411429d27a40c68a544a30a03f7eecd94bac1bb9ba7d276a822d2dd2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a16a2be72674960cc8f265667e396b9a1e78b380beed99b736d0e55566859d724e803c99ef4f99f23aef28a521cb9018250e4483f5680297421effd8421619b"} build_url:https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71058bc88b6f6d6ee3aed6e6fad27dfcc4e2f239faabadc4063920f74d7fddc8eb0c519411429d27a40c68a544a30a03f7eecd94bac1bb9ba7d276a822d2dd2a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a16a2be72674960cc8f265667e396b9a1e78b380beed99b736d0e55566859d724e803c99ef4f99f23aef28a521cb9018250e4483f5680297421effd8421619b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:32.365910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:32.366208) ========= 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=52faae308a556c440401f8e5000001e8-1460737735.969896-595915507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:32.448937) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 11:23:32.449268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 11:23:32.449546) ========= ========= Total master_lag: 0.16 =========