builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1460743364.7 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.701687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.702137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.702419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.722162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.722425) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 11:02:44-- 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% 222M=0s 2016-04-15 11:02:45 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.809524) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.809811) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016868 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.858796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:44.859161) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 11:02:45,153 truncating revision to first 12 chars 2016-04-15 11:02:45,153 Setting DEBUG logging. 2016-04-15 11:02:45,153 attempt 1/10 2016-04-15 11:02:45,153 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:45,533 unpacking tar archive at: fx-team-fec92924befb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681655 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:45.554910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:45.555348) ========= script_repo_revision: fec92924befbea7a0ee52c4cedd531a67b61f2fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:45.555871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:45.556266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 11:02:45.566772) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-15 11:02:45.567178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:45 INFO - MultiFileLogger online at 20160415 11:02:45 in /builds/slave/test 11:02:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:45 INFO - {'append_to_log': False, 11:02:45 INFO - 'base_work_dir': '/builds/slave/test', 11:02:45 INFO - 'blob_upload_branch': 'Fx-Team', 11:02:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:45 INFO - 'branch': 'Fx-Team', 11:02:45 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:45 INFO - 'config_files': ('talos/linux_config.py',), 11:02:45 INFO - 'default_actions': ('clobber', 11:02:45 INFO - 'read-buildbot-config', 11:02:45 INFO - 'download-and-extract', 11:02:45 INFO - 'populate-webroot', 11:02:45 INFO - 'create-virtualenv', 11:02:45 INFO - 'install', 11:02:45 INFO - 'run-tests'), 11:02:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:45 INFO - 'download_minidump_stackwalk': True, 11:02:45 INFO - 'download_symbols': 'ondemand', 11:02:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:45 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:45 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:45 INFO - 'installer_path': 'installer.exe', 11:02:45 INFO - 'log_level': 'info', 11:02:45 INFO - 'log_name': 'talos', 11:02:45 INFO - 'log_to_console': True, 11:02:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:45 INFO - 'opt_config_files': (), 11:02:45 INFO - 'pip_index': False, 11:02:45 INFO - 'sps_profile': False, 11:02:45 INFO - 'sps_profile_interval': 0, 11:02:45 INFO - 'suite': 'dromaeojs-e10s', 11:02:45 INFO - 'system_bits': '32', 11:02:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:45 INFO - 'title': 'talos-linux64-ix-049', 11:02:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:45 INFO - 'use_talos_json': True, 11:02:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:45 INFO - 'work_dir': 'build'} 11:02:45 INFO - ##### 11:02:45 INFO - ##### Running clobber step. 11:02:45 INFO - ##### 11:02:45 INFO - Running pre-action listener: _resource_record_pre_action 11:02:45 INFO - Running main action method: clobber 11:02:45 INFO - rmtree: /builds/slave/test/build 11:02:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:46 INFO - Running post-action listener: _resource_record_post_action 11:02:46 INFO - ##### 11:02:46 INFO - ##### Running read-buildbot-config step. 11:02:46 INFO - ##### 11:02:46 INFO - Running pre-action listener: _resource_record_pre_action 11:02:46 INFO - Running main action method: read_buildbot_config 11:02:46 INFO - Using buildbot properties: 11:02:46 INFO - { 11:02:46 INFO - "project": "", 11:02:46 INFO - "product": "firefox", 11:02:46 INFO - "script_repo_revision": "production", 11:02:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:02:46 INFO - "repository": "", 11:02:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:02:46 INFO - "buildid": "20160415083221", 11:02:46 INFO - "pgo_build": "True", 11:02:46 INFO - "basedir": "/builds/slave/test", 11:02:46 INFO - "buildnumber": 657, 11:02:46 INFO - "slavename": "talos-linux64-ix-049", 11:02:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:02:46 INFO - "platform": "ubuntu64_hw", 11:02:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:02:46 INFO - "branch": "fx-team", 11:02:46 INFO - "repo_path": "integration/fx-team", 11:02:46 INFO - "revision": "fec92924befbea7a0ee52c4cedd531a67b61f2fb", 11:02:46 INFO - "stage_platform": "linux64-pgo", 11:02:46 INFO - "builduid": "dd653251b9544cc397dacba4285e386f", 11:02:46 INFO - "slavebuilddir": "test" 11:02:46 INFO - } 11:02:46 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:46 INFO - Running post-action listener: _resource_record_post_action 11:02:46 INFO - ##### 11:02:46 INFO - ##### Running download-and-extract step. 11:02:46 INFO - ##### 11:02:46 INFO - Running pre-action listener: _resource_record_pre_action 11:02:46 INFO - Running main action method: download_and_extract 11:02:46 INFO - mkdir: /builds/slave/test/build/tests 11:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:46 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:46 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:46 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:46 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:46 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:47 INFO - Downloaded 1361 bytes. 11:02:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:02:47 INFO - Using the following test package requirements: 11:02:47 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:02:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:02:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'jsshell-linux-x86_64.zip'], 11:02:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:02:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:02:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:02:47 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:02:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:02:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:02:47 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:02:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip 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.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:02:47 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:02:48 INFO - Downloaded 23776862 bytes. 11:02:48 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:02:48 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:02:49 INFO - Return code: 0 11:02:49 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:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:49 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:49 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:49 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:49 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:49 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:02:50 INFO - Downloaded 23776862 bytes. 11:02:50 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:02:50 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:02:51 INFO - Return code: 0 11:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:53 INFO - Downloaded 10841076 bytes. 11:02:53 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:02:53 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:02:53 INFO - Return code: 0 11:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:02:53 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:02:53 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:02:53 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:02:53 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:02:53 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:02:56 INFO - Downloaded 58241221 bytes. 11:02:56 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:02:56 INFO - mkdir: /builds/slave/test/properties 11:02:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:02:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:02:56 INFO - Contents: 11:02:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TSPsNQwNQxmbG4cSDYlvNQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:02:56 INFO - Running post-action listener: _resource_record_post_action 11:02:56 INFO - Running post-action listener: set_extra_try_arguments 11:02:56 INFO - ##### 11:02:56 INFO - ##### Running populate-webroot step. 11:02:56 INFO - ##### 11:02:56 INFO - Running pre-action listener: _resource_record_pre_action 11:02:56 INFO - Running main action method: populate_webroot 11:02:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:02:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:02:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:02:56 INFO - '--tppagecycles', 11:02:56 INFO - '7'], 11:02:56 INFO - 'tests': ['tsvgm']}}, 11:02:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:02:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:02:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:02:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:02:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:02:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:02:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:56 INFO - 'talos_options': ['--disable-e10s'], 11:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:02:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:56 INFO - 'talos_options': ['--disable-e10s'], 11:02:56 INFO - 'tests': ['damp', 'tps']}, 11:02:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:57 INFO - 'tests': ['damp', 'tps']}, 11:02:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['dromaeo_dom']}, 11:02:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:02:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['a11yr', 11:02:57 INFO - 'ts_paint', 11:02:57 INFO - 'tpaint', 11:02:57 INFO - 'sessionrestore', 11:02:57 INFO - 'sessionrestore_no_auto_restore', 11:02:57 INFO - 'tabpaint']}, 11:02:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['tsvgx', 11:02:57 INFO - 'tsvgr_opacity', 11:02:57 INFO - 'tart', 11:02:57 INFO - 'tscrollx', 11:02:57 INFO - 'cart']}, 11:02:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:02:57 INFO - 'tsvgr_opacity', 11:02:57 INFO - 'tart', 11:02:57 INFO - 'tscrollx', 11:02:57 INFO - 'cart']}, 11:02:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:57 INFO - 'talos_options': ['--disable-e10s'], 11:02:57 INFO - 'tests': ['tp5o']}, 11:02:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:57 INFO - 'tests': ['tp5o']}, 11:02:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:57 INFO - 'talos_options': ['--disable-e10s', 11:02:57 INFO - '--xperf_path', 11:02:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:57 INFO - 'tests': ['tp5n']}, 11:02:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:02:57 INFO - 'talos_options': ['--xperf_path', 11:02:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:02:57 INFO - 'tests': ['tp5n']}}, 11:02:57 INFO - 'talos.zip': {'path': '', 11:02:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:02:57 INFO - Running post-action listener: _resource_record_post_action 11:02:57 INFO - ##### 11:02:57 INFO - ##### Running create-virtualenv step. 11:02:57 INFO - ##### 11:02:57 INFO - Running pre-action listener: _resource_record_pre_action 11:02:57 INFO - Running main action method: create_virtualenv 11:02:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:02:57 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:02:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:02:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:02:57 INFO - Using real prefix '/usr' 11:02:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:02:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:02:59 INFO - Installing pip.................done. 11:02:59 INFO - Return code: 0 11:02:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:02:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:59 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:02:59 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:02:59 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:02:59 INFO - Using env: {'DISPLAY': ':0', 11:02:59 INFO - 'HOME': '/home/cltbld', 11:02:59 INFO - 'LANG': 'en_US.UTF-8', 11:02:59 INFO - 'LANGUAGE': 'en_US:en', 11:02:59 INFO - 'LOGNAME': 'cltbld', 11:02:59 INFO - 'MAIL': '/var/mail/cltbld', 11:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:59 INFO - 'MOZ_NO_REMOTE': '1', 11:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:59 INFO - 'NO_EM_RESTART': '1', 11:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:59 INFO - 'PWD': '/builds/slave/test', 11:02:59 INFO - 'SHELL': '/bin/bash', 11:02:59 INFO - 'SHLVL': '1', 11:02:59 INFO - 'TERM': 'linux', 11:02:59 INFO - 'TMOUT': '86400', 11:02:59 INFO - 'USER': 'cltbld', 11:02:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:59 INFO - '_': '/tools/buildbot/bin/python'} 11:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:02:59 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:02:59 INFO - Cleaning up... 11:02:59 INFO - Return code: 0 11:02:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:02:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:02:59 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:02:59 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:02:59 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:02:59 INFO - Using env: {'DISPLAY': ':0', 11:02:59 INFO - 'HOME': '/home/cltbld', 11:02:59 INFO - 'LANG': 'en_US.UTF-8', 11:02:59 INFO - 'LANGUAGE': 'en_US:en', 11:02:59 INFO - 'LOGNAME': 'cltbld', 11:02:59 INFO - 'MAIL': '/var/mail/cltbld', 11:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:02:59 INFO - 'MOZ_NO_REMOTE': '1', 11:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:02:59 INFO - 'NO_EM_RESTART': '1', 11:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:02:59 INFO - 'PWD': '/builds/slave/test', 11:02:59 INFO - 'SHELL': '/bin/bash', 11:02:59 INFO - 'SHLVL': '1', 11:02:59 INFO - 'TERM': 'linux', 11:02:59 INFO - 'TMOUT': '86400', 11:02:59 INFO - 'USER': 'cltbld', 11:02:59 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:02:59 INFO - '_': '/tools/buildbot/bin/python'} 11:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:00 INFO - Downloading/unpacking psutil>=0.7.1 11:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:01 INFO - Installing collected packages: psutil 11:03:01 INFO - Running setup.py install for psutil 11:03:02 INFO - building 'psutil._psutil_linux' extension 11:03:02 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:02 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:02 INFO - building 'psutil._psutil_posix' extension 11:03:02 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:02 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:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:02 INFO - Successfully installed psutil 11:03:02 INFO - Cleaning up... 11:03:02 INFO - Return code: 0 11:03:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:03:02 INFO - Using env: {'DISPLAY': ':0', 11:03:02 INFO - 'HOME': '/home/cltbld', 11:03:02 INFO - 'LANG': 'en_US.UTF-8', 11:03:02 INFO - 'LANGUAGE': 'en_US:en', 11:03:02 INFO - 'LOGNAME': 'cltbld', 11:03:02 INFO - 'MAIL': '/var/mail/cltbld', 11:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:02 INFO - 'MOZ_NO_REMOTE': '1', 11:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:02 INFO - 'NO_EM_RESTART': '1', 11:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:02 INFO - 'PWD': '/builds/slave/test', 11:03:02 INFO - 'SHELL': '/bin/bash', 11:03:02 INFO - 'SHLVL': '1', 11:03:02 INFO - 'TERM': 'linux', 11:03:02 INFO - 'TMOUT': '86400', 11:03:02 INFO - 'USER': 'cltbld', 11:03:02 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:02 INFO - '_': '/tools/buildbot/bin/python'} 11:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:04 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:04 INFO - Installing collected packages: mozsystemmonitor 11:03:04 INFO - Running setup.py install for mozsystemmonitor 11:03:04 INFO - Successfully installed mozsystemmonitor 11:03:04 INFO - Cleaning up... 11:03:04 INFO - Return code: 0 11:03:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:04 INFO - Using env: {'DISPLAY': ':0', 11:03:04 INFO - 'HOME': '/home/cltbld', 11:03:04 INFO - 'LANG': 'en_US.UTF-8', 11:03:04 INFO - 'LANGUAGE': 'en_US:en', 11:03:04 INFO - 'LOGNAME': 'cltbld', 11:03:04 INFO - 'MAIL': '/var/mail/cltbld', 11:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:04 INFO - 'MOZ_NO_REMOTE': '1', 11:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:04 INFO - 'NO_EM_RESTART': '1', 11:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:04 INFO - 'PWD': '/builds/slave/test', 11:03:04 INFO - 'SHELL': '/bin/bash', 11:03:04 INFO - 'SHLVL': '1', 11:03:04 INFO - 'TERM': 'linux', 11:03:04 INFO - 'TMOUT': '86400', 11:03:04 INFO - 'USER': 'cltbld', 11:03:04 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:04 INFO - '_': '/tools/buildbot/bin/python'} 11:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:05 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:05 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:05 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:05 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:05 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:05 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:05 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:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:08 INFO - Downloading docopt-0.6.1.tar.gz 11:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:08 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:08 INFO - Running setup.py install for blobuploader 11:03:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:08 INFO - Running setup.py install for requests 11:03:08 INFO - Running setup.py install for docopt 11:03:08 INFO - Successfully installed blobuploader requests docopt 11:03:08 INFO - Cleaning up... 11:03:09 INFO - Return code: 0 11:03:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:09 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:09 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:09 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:09 INFO - Using env: {'DISPLAY': ':0', 11:03:09 INFO - 'HOME': '/home/cltbld', 11:03:09 INFO - 'LANG': 'en_US.UTF-8', 11:03:09 INFO - 'LANGUAGE': 'en_US:en', 11:03:09 INFO - 'LOGNAME': 'cltbld', 11:03:09 INFO - 'MAIL': '/var/mail/cltbld', 11:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:09 INFO - 'MOZ_NO_REMOTE': '1', 11:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:09 INFO - 'NO_EM_RESTART': '1', 11:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:09 INFO - 'PWD': '/builds/slave/test', 11:03:09 INFO - 'SHELL': '/bin/bash', 11:03:09 INFO - 'SHLVL': '1', 11:03:09 INFO - 'TERM': 'linux', 11:03:09 INFO - 'TMOUT': '86400', 11:03:09 INFO - 'USER': 'cltbld', 11:03:09 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:09 INFO - '_': '/tools/buildbot/bin/python'} 11:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:09 INFO - Running setup.py (path:/tmp/pip-OX5lIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:09 INFO - Running setup.py (path:/tmp/pip-GGATQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:09 INFO - Running setup.py (path:/tmp/pip-OkvwT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:09 INFO - Running setup.py (path:/tmp/pip-ACXosW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:09 INFO - Running setup.py (path:/tmp/pip-olIxxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:09 INFO - Running setup.py (path:/tmp/pip-r9p_Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:09 INFO - Running setup.py (path:/tmp/pip-2jsIbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:09 INFO - Running setup.py (path:/tmp/pip-1NDe7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:09 INFO - Running setup.py (path:/tmp/pip-BWH5U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:09 INFO - Running setup.py (path:/tmp/pip-KGnNqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:09 INFO - Running setup.py (path:/tmp/pip-XRUaAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:09 INFO - Running setup.py (path:/tmp/pip-BwnwXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:10 INFO - Running setup.py (path:/tmp/pip-HkWAX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:10 INFO - Running setup.py (path:/tmp/pip-g9PNkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:10 INFO - Running setup.py (path:/tmp/pip-1aX7_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:10 INFO - Running setup.py (path:/tmp/pip-r0m3Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:10 INFO - Running setup.py (path:/tmp/pip-EdPEGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:10 INFO - Running setup.py install for manifestparser 11:03:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:10 INFO - Running setup.py install for mozcrash 11:03:10 INFO - Running setup.py install for mozdebug 11:03:10 INFO - Running setup.py install for mozdevice 11:03:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:03:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:10 INFO - Running setup.py install for mozfile 11:03:10 INFO - Running setup.py install for mozhttpd 11:03:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozinfo 11:03:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozInstall 11:03:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozleak 11:03:11 INFO - Running setup.py install for mozlog 11:03:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for moznetwork 11:03:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozprocess 11:03:11 INFO - Running setup.py install for mozprofile 11:03:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozrunner 11:03:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:11 INFO - Running setup.py install for mozscreenshot 11:03:11 INFO - Running setup.py install for moztest 11:03:12 INFO - Running setup.py install for mozversion 11:03:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:12 INFO - Cleaning up... 11:03:12 INFO - Return code: 0 11:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:12 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 11:03:12 INFO - 'HOME': '/home/cltbld', 11:03:12 INFO - 'LANG': 'en_US.UTF-8', 11:03:12 INFO - 'LANGUAGE': 'en_US:en', 11:03:12 INFO - 'LOGNAME': 'cltbld', 11:03:12 INFO - 'MAIL': '/var/mail/cltbld', 11:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:12 INFO - 'MOZ_NO_REMOTE': '1', 11:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:12 INFO - 'NO_EM_RESTART': '1', 11:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:12 INFO - 'PWD': '/builds/slave/test', 11:03:12 INFO - 'SHELL': '/bin/bash', 11:03:12 INFO - 'SHLVL': '1', 11:03:12 INFO - 'TERM': 'linux', 11:03:12 INFO - 'TMOUT': '86400', 11:03:12 INFO - 'USER': 'cltbld', 11:03:12 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:12 INFO - '_': '/tools/buildbot/bin/python'} 11:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:12 INFO - Running setup.py (path:/tmp/pip-79yCtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:12 INFO - Running setup.py (path:/tmp/pip-VYgwWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:12 INFO - Running setup.py (path:/tmp/pip-zVnhNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:12 INFO - Running setup.py (path:/tmp/pip-zZ2dmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:12 INFO - Running setup.py (path:/tmp/pip-qwJlrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:12 INFO - Running setup.py (path:/tmp/pip-so_JNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:12 INFO - Running setup.py (path:/tmp/pip-2QF2bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:12 INFO - Running setup.py (path:/tmp/pip-LT0H_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:12 INFO - Running setup.py (path:/tmp/pip-tdUpyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:13 INFO - Running setup.py (path:/tmp/pip-S160WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:13 INFO - Running setup.py (path:/tmp/pip-87FIR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:13 INFO - Running setup.py (path:/tmp/pip-AfpedC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:13 INFO - Running setup.py (path:/tmp/pip-nsc2KL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:13 INFO - Running setup.py (path:/tmp/pip-d1eRSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:13 INFO - Running setup.py (path:/tmp/pip-LtIUQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:13 INFO - Running setup.py (path:/tmp/pip-tIbA0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:13 INFO - Running setup.py (path:/tmp/pip-a06Py9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:13 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:13 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:13 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:13 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:13 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:13 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:15 INFO - Downloading blessings-1.6.tar.gz 11:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:15 INFO - Installing collected packages: blessings 11:03:15 INFO - Running setup.py install for blessings 11:03:15 INFO - Successfully installed blessings 11:03:15 INFO - Cleaning up... 11:03:15 INFO - Return code: 0 11:03:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:15 INFO - Reading from file tmpfile_stdout 11:03:15 INFO - Current package versions: 11:03:15 INFO - argparse == 1.2.1 11:03:15 INFO - blessings == 1.6 11:03:15 INFO - blobuploader == 1.2.4 11:03:15 INFO - docopt == 0.6.1 11:03:15 INFO - manifestparser == 1.1 11:03:15 INFO - mozInstall == 1.12 11:03:15 INFO - mozcrash == 0.17 11:03:15 INFO - mozdebug == 0.1 11:03:15 INFO - mozdevice == 0.48 11:03:15 INFO - mozfile == 1.2 11:03:15 INFO - mozhttpd == 0.7 11:03:15 INFO - mozinfo == 0.9 11:03:15 INFO - mozleak == 0.1 11:03:15 INFO - mozlog == 3.1 11:03:15 INFO - moznetwork == 0.27 11:03:15 INFO - mozprocess == 0.22 11:03:15 INFO - mozprofile == 0.28 11:03:15 INFO - mozrunner == 6.11 11:03:15 INFO - mozscreenshot == 0.1 11:03:15 INFO - mozsystemmonitor == 0.0 11:03:15 INFO - moztest == 0.7 11:03:15 INFO - mozversion == 1.4 11:03:15 INFO - psutil == 3.1.1 11:03:15 INFO - requests == 1.2.3 11:03:15 INFO - wsgiref == 0.1.2 11:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:15 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 11:03:15 INFO - 'HOME': '/home/cltbld', 11:03:15 INFO - 'LANG': 'en_US.UTF-8', 11:03:15 INFO - 'LANGUAGE': 'en_US:en', 11:03:15 INFO - 'LOGNAME': 'cltbld', 11:03:15 INFO - 'MAIL': '/var/mail/cltbld', 11:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:15 INFO - 'MOZ_NO_REMOTE': '1', 11:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:15 INFO - 'NO_EM_RESTART': '1', 11:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:15 INFO - 'PWD': '/builds/slave/test', 11:03:15 INFO - 'SHELL': '/bin/bash', 11:03:15 INFO - 'SHLVL': '1', 11:03:15 INFO - 'TERM': 'linux', 11:03:15 INFO - 'TMOUT': '86400', 11:03:15 INFO - 'USER': 'cltbld', 11:03:15 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:15 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): 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Cleaning up... 11:03:16 INFO - Return code: 0 11:03:16 INFO - Installing jsonschema 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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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', 'jsonschema'] 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 jsonschema 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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 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 jsonschema 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:18 INFO - Downloading/unpacking functools32 (from jsonschema) 11:03:18 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:18 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 - 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:18 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:18 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:18 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 - Downloading functools32-3.2.3-2.tar.gz 11:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:18 INFO - warning: no files found matching '*.txt' 11:03:18 INFO - no previously-included directories found matching 'build' 11:03:18 INFO - no previously-included directories found matching 'dist' 11:03:18 INFO - no previously-included directories found matching '.git*' 11:03:18 INFO - Installing collected packages: jsonschema, functools32 11:03:18 INFO - Running setup.py install for functools32 11:03:18 INFO - warning: no files found matching '*.txt' 11:03:18 INFO - no previously-included directories found matching 'build' 11:03:18 INFO - no previously-included directories found matching 'dist' 11:03:18 INFO - no previously-included directories found matching '.git*' 11:03:18 INFO - Successfully installed jsonschema functools32 11:03:18 INFO - Cleaning up... 11:03:18 INFO - Return code: 0 11:03:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:03:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:03:18 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 0x7fcc00c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbd5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, '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': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 11:03:18 INFO - 'HOME': '/home/cltbld', 11:03:18 INFO - 'LANG': 'en_US.UTF-8', 11:03:18 INFO - 'LANGUAGE': 'en_US:en', 11:03:18 INFO - 'LOGNAME': 'cltbld', 11:03:18 INFO - 'MAIL': '/var/mail/cltbld', 11:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:18 INFO - 'MOZ_NO_REMOTE': '1', 11:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:18 INFO - 'NO_EM_RESTART': '1', 11:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:18 INFO - 'PWD': '/builds/slave/test', 11:03:18 INFO - 'SHELL': '/bin/bash', 11:03:18 INFO - 'SHLVL': '1', 11:03:18 INFO - 'TERM': 'linux', 11:03:18 INFO - 'TMOUT': '86400', 11:03:18 INFO - 'USER': 'cltbld', 11:03:18 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:18 INFO - '_': '/tools/buildbot/bin/python'} 11:03:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:18 INFO - Downloading/unpacking flake8 11:03:18 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:18 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 - 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:18 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:18 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:18 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:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:03:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:03:20 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:20 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:20 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:20 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:20 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:20 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 mccabe-0.3.1-py2.py3-none-any.whl 11:03:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:21 INFO - no previously-included directories found matching 'docs/_build' 11:03:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:03:21 INFO - Running setup.py install for pep8 11:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:03:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:03:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:03:21 INFO - no previously-included directories found matching 'docs/_build' 11:03:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:03:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:03:21 INFO - Cleaning up... 11:03:21 INFO - Return code: 0 11:03:21 INFO - Running post-action listener: _resource_record_post_action 11:03:21 INFO - Running post-action listener: _start_resource_monitoring 11:03:21 INFO - Starting resource monitoring. 11:03:21 INFO - ##### 11:03:21 INFO - ##### Running install step. 11:03:21 INFO - ##### 11:03:21 INFO - Running pre-action listener: _resource_record_pre_action 11:03:21 INFO - Running main action method: install 11:03:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:22 INFO - Reading from file tmpfile_stdout 11:03:22 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:22 INFO - Reading from file tmpfile_stdout 11:03:22 INFO - Output received: 11:03:22 INFO - Usage: mozinstall [options] installer 11:03:22 INFO - Options: 11:03:22 INFO - -h, --help show this help message and exit 11:03:22 INFO - -d DEST, --destination=DEST 11:03:22 INFO - Directory to install application into. [default: 11:03:22 INFO - "/builds/slave/test"] 11:03:22 INFO - --app=APP Application being installed. [default: firefox] 11:03:22 INFO - mkdir: /builds/slave/test/build/application 11:03:22 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:22 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:38 INFO - Reading from file tmpfile_stdout 11:03:38 INFO - Output received: 11:03:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:38 INFO - Running post-action listener: _resource_record_post_action 11:03:38 INFO - ##### 11:03:38 INFO - ##### Running run-tests step. 11:03:38 INFO - ##### 11:03:38 INFO - Running pre-action listener: _resource_record_pre_action 11:03:38 INFO - Running main action method: run_tests 11:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:38 INFO - Python 2.7.3 11:03:38 INFO - Return code: 0 11:03:38 INFO - grabbing minidump binary from tooltool 11:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:03:38 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 0xe4c410>, '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 0xe4d310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:38 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:38 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:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:38 INFO - Return code: 0 11:03:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:03:39 INFO - Return code: 0 11:03:39 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-e10s', '--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-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:03:39 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-e10s --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-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:03:39 INFO - Using env: {'DISPLAY': ':0', 11:03:39 INFO - 'HOME': '/home/cltbld', 11:03:39 INFO - 'LANG': 'en_US.UTF-8', 11:03:39 INFO - 'LANGUAGE': 'en_US:en', 11:03:39 INFO - 'LOGNAME': 'cltbld', 11:03:39 INFO - 'MAIL': '/var/mail/cltbld', 11:03:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:39 INFO - 'MOZ_NO_REMOTE': '1', 11:03:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:39 INFO - 'NO_EM_RESTART': '1', 11:03:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:39 INFO - 'PWD': '/builds/slave/test', 11:03:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:39 INFO - 'SHELL': '/bin/bash', 11:03:39 INFO - 'SHLVL': '1', 11:03:39 INFO - 'TERM': 'linux', 11:03:39 INFO - 'TMOUT': '86400', 11:03:39 INFO - 'USER': 'cltbld', 11:03:39 INFO - 'XDG_SESSION_COOKIE': '8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892', 11:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:39 INFO - '_': '/tools/buildbot/bin/python'} 11:03:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--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-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:03:39 INFO - mozversion application_buildid: 20160415083221 11:03:39 INFO - mozversion application_changeset: fec92924befbea7a0ee52c4cedd531a67b61f2fb 11:03:39 INFO - mozversion application_display_name: Nightly 11:03:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:39 INFO - mozversion application_name: Firefox 11:03:39 INFO - mozversion application_remotingname: firefox 11:03:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:03:39 INFO - mozversion application_vendor: Mozilla 11:03:39 INFO - mozversion application_version: 48.0a1 11:03:39 INFO - mozversion platform_buildid: 20160415083221 11:03:39 INFO - mozversion platform_changeset: fec92924befbea7a0ee52c4cedd531a67b61f2fb 11:03:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:03:39 INFO - mozversion platform_version: 48.0a1 11:03:39 INFO - using testdate: 1460743419 11:03:39 INFO - actual date: 1460743419 11:03:39 INFO - starting webserver on 'localhost:56404' 11:03:39 INFO - SUITE-START | Running 2 tests 11:03:39 INFO - TEST-START | dromaeo_css 11:03:39 INFO - operating with platform_type : linux_ 11:03:39 INFO - Initialising browser for dromaeo_css test... 11:03:39 INFO - TEST-INFO | started process 8177 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuWQjHs/profile http://localhost:56404/getInfo.html) 11:03:43 INFO - PROCESS | 8177 | 11:03:43 INFO - PROCESS | 8177 | (process:8247): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:03:44 INFO - PROCESS | 8177 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:03:44 INFO - PROCESS | 8177 | __metrics Screen width/height:1600/1200 11:03:44 INFO - PROCESS | 8177 | colorDepth:24 11:03:44 INFO - PROCESS | 8177 | Browser inner width/height: 1024/697 11:03:44 INFO - PROCESS | 8177 | __metrics 11:03:45 ERROR - PROCESS | 8177 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:03:45 INFO - TEST-INFO | 8177: exit 0 11:03:45 INFO - Browser initialized. 11:03:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:03:46 INFO - TEST-INFO | started process 8298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuWQjHs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:03:47 INFO - PROCESS | 8298 | 11:03:47 INFO - PROCESS | 8298 | (process:8357): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:03:57 INFO - PROCESS | 8298 | RSS: Main: 163475456 11:03:57 INFO - PROCESS | 8298 | 11:04:47 INFO - PROCESS | 8298 | 1460743487430 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:06:54 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56404/tests/dromaeo/cssquery-ext.html) 11:06:55 INFO - PROCESS | 8298 | RSS: Main: 168706048 11:06:55 INFO - PROCESS | 8298 | 11:09:57 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-ext.html (next: http://localhost:56404/tests/dromaeo/cssquery-jquery.html) 11:09:58 INFO - PROCESS | 8298 | RSS: Main: 166166528 11:09:58 INFO - PROCESS | 8298 | 11:13:00 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56404/tests/dromaeo/cssquery-mootools.html) 11:13:00 INFO - PROCESS | 8298 | RSS: Main: 166641664 11:13:00 INFO - PROCESS | 8298 | 11:16:02 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56404/tests/dromaeo/cssquery-prototype.html) 11:16:03 INFO - PROCESS | 8298 | RSS: Main: 164245504 11:16:03 INFO - PROCESS | 8298 | 11:19:05 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56404/tests/dromaeo/cssquery-yui.html) 11:19:06 INFO - PROCESS | 8298 | RSS: Main: 165343232 11:19:06 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-yui.html (next: http://localhost:56404/tests/dromaeo/cssquery-dojo.html) 11:22:08 INFO - PROCESS | 8298 | RSS: Main: 167477248 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | __start_tp_report 11:22:08 INFO - PROCESS | 8298 | _x_x_mozilla_page_load 11:22:08 INFO - PROCESS | 8298 | _x_x_mozilla_page_load_details 11:22:08 INFO - PROCESS | 8298 | |i|pagename|runs| 11:22:08 INFO - PROCESS | 8298 | |0;dojo.html;3071.769617278704;3131.53027045943;3141.4345417824784;3180.125465496988;3187.9043628691147;5424.132138857779;5430.8913821723545;5434.157705555635;5437.564994800417;5440.91838622421;5343.171808369709;5358.946410535894;5408.918866217;5489.313835770528;5497.642653227537;4833.685810422329;4850.417949846014;4886.438059623153;4930.408350997867;4943.258511223309;4809.230523116302;5046.97476512617;5055.4186268579215;5056;5057.898842023157;4818.590419814303;4875.902481950377;4902.240152776325;4940.061388336223;4955.950440495585;4838.709677419366;4854.247591623269;4861.756912154414;4892.021595680842;4906.435759887588;4839.153148199086;4839.830605928811;4841.612670986313;4847.12751704693;4898.093852637274;5052.9242061369105;5261.237120617528;5295.205719142121;5300.310959575269;5316.9202461963105;5733.569982251348;5763.452472015152;5776.306843178803;5781.682007489587;5814.273215848019;5678;5812.970935145339;5816.069428891357;5823.767049318022;5831.679257640828;5384.865378365572;5433.646812957106;5434.347878254634;5482;5486.451354864522;5777.277840269966;5797.913031304533;5809.82570522885;5823.679697616672;5833.474987251083;5433.26650902131;5568.554515638739;5585.106382978704;5598.356189038313;5694.174344720075;5711.428857114255;5718.942810571924;5733.77064917407;5738.856528586735;5759.136129580596;5685.602007859493;5699.686517241508;5720.141978703228;5727.8568035799435;5769.07694768835;5703.058995265817;5720.342160651495;5720.3421606515785;5733.971330143323;5768.711564421762;4270.679699022586;4331.913361732811;4333.696641235083;4337.544557821447;4366.956330436718;3813.046738315421;3884.592117827644;3900.4539364488996;3913.1195481016543;3984.103576695278;5617.297837770278;5622.662640241599;5623;5628.774849006076;5667.3482549507335;5853.239078919713;5860.622753652973;5870.295564532198;5879.823605291763;5884.08796636522;5468.234447177399;5520.392756796749;5585.994520986262;5592.384837667853;5627.549796016391;4959.603231741452;4974.502549744997;4978.850634480971;4992.900141997213;5050.444451110375;5988.191594134823;6058.454739073504;6058.848528786815;6064.575479716377;6075.179850720185;5701;5866.6480011199465;5903.793367232126;5929.762809487572;5943.762249510144;5911.438413350725;5930.970345148419;5939.970300148471;5952.464278214981;5960.612560183574;5636.267285252891;5641.548676105819;5643.379228284967;5647.040003199384;5693.772249109989;5851.297844258716;5887.941120588911;5919.200907877382;5935.881282374415;5965.28416590012;5618.915716264178;5631.915521267266;5644.096944488862;5652.434756524314;5677.801276955452;5438.10271305246;5625.915611265917;5650.350209725934;5653.491185793298;5678.829635110953;5337.412884582771;5556.611037227355;5573.749181286771;5596.776128954796;5669;5642.23829782974;5671.971640141773;5675.829725108253;5723.456271654186;5739.512141468022;5428.67427954324;5580.023495888285;5584.274044374205;5585.776568937197;5592.273004509388 11:22:08 INFO - PROCESS | 8298 | |1;ext.html;610.0544156557338;626.4894111299288;645.4255712415951;652.0838222297672;662.6289278004316;34069;35389.46915796265;35487.82256088722;35582.644173558256;35679.10802229942;38271.42592861109;38870.41694374587;38974.61025389745;38976;39176.216475670466;8327.333813294952;8564.657413703444;8569.785755356104;8584.356173286997;8602.182792634721;8342.249197572217;8472.237498625123;8520.147985201462;8522.105178956213;8537.402381833273;8722.520261385622;8764.123587641248;8798.076201998794;8803.559822008907;8825.51459669718;8711.651533938635;8768.693095741619;8779.429337093068;8798.86801697975;8820.073892241351;8522.87215691765;8598.05421403645;8607.311415086779;8651.091635378258;8651.394402391836;37127.4430883537;37511;37673;37774.811125944194;37810.81094594537;3387.7120444762227;3392.9990652757497;3410.420228561126;3456.0150357148345;3689.8893033209047;29805.552916706267;30560.69439305601;30667;30692.311922844234;31194.220144496343;4266.786660666954;4284.164587905359;4348.608625223745;4379.540148284416;4398.516163222043;280064;281189;281879;283264;285659;33828;34264.828675856465;34283.14292142716;53030.73484632552;53924.46075539273;33851;33951.4907276391;33969;33994.83002584971;33999.32001360008;14423.49517766873;14579.92710036443;14633.926830365994;14647.560573182822;14686;12276.32480213579;12296.20074695142;12332;12332.753344933051;12337.876621233852;8049.356051515982;8076.596170191467;8131.674733010614;8272.1727827218;8372.958135209406;3146.24490122369;3210.6628803975245;3244.4808830586994;3255.7395408367747;3261.2010057536054;995.2225345397864;1022.1873610479687;1112.0158659586325;1187.625897842177;1200.5257923120319;29675.554866677016;29878.551821722693;30057.849710751743;30146;30302.090937271918;1052.4634034309993;1125.6454216921643;1145.4272863568217;1165.904050192816;1168.1822724093;15481.458148964732;15641.452549160726;15787.68424631501;16053;16116.75824862628;411063.9446802807;414782;415182;416299;417120;48361.27458088131;49271.75364123157;49315.753421232665;49488;49566.25650615244;1280.5006047641427;1318.9142705724098;1340.6179238917057;1341.3829638366265;1363.9113457625222;29418.55872161962;29890.953816616315;30253.697463025088;30448.238794030327;30769.384612308077;43688.56311436845;44004.259637931136;44117.11765764731;44174;44304.556954430045;379714;381765;382228;382350;382604;27072.32319191957;27390.178294651192;27417;40593.18813623652;41995.58004419917;39551.60448395479;39742.80128599339;39948.201035978534;40078;40346;34492.65507344894;35218.64781352256;35880.4617930726;36795.81602091972;37400;35935;36154.8192259037;36204;36353;36571.45142822913;36957.81521092377;37655;38024;38160;38675.61324386833;31367.86135883399;31818.38619910994;32537.837310813295;32551.18622034468;32918.506222406206;26688.866555667097;26750.59874101851;26755;26883.193504194904;27102.322441938322 11:22:08 INFO - PROCESS | 8298 | |2;jquery.html;389.16524055900095;389.5773086201471;395.20958083832335;396.3400937439164;396.87300063979524;13527.594172174826;13859;16604.83395166048;17399.304027838887;17477.38829140979;16444.67110657786;16856.66286674266;17015.744763828523;17187.140642967865;17885.105744712746;5531.3915469298445;5686.402927692595;5695.401982791809;5698.544116470673;5699.886002279973;5418.187271909206;5664.688442135681;5684.289463817023;5684.914726279109;5694.288213973254;5554.777808887639;5558.972205138989;5625.80309689161;5636.239107720467;5653.858653533674;5128.71792051437;5298.443663415363;5420.647657902224;5427.050266203419;5446.891062178754;5144.639875208737;5256.6057545684225;5595.160725891108;5611.859703507404;5644.209810626516;13363.465461381533;13502;13612.795808062887;15584.376624934988;19158.80841191584;2161.8702877827222;2227.988860055689;2250.5043460935103;2265.0713207584977;2494.4761600064007;9486.430814151174;9775.853362199572;9812.705618831447;9955;10281.331713438603;1838.586318078435;1897.7153426985924;1962.2151139544153;1970.2611520679745;1971.7436733224733;68326.3167368325;78395.21604783936;79731.6013419935;79761.60119199367;79926.60036699838;10087.142592879542;10588.4705764713;10598.629047983284;10621.468926553796;10829.620963266405;14828.851711482963;14882.925585372004;14907.627309317137;14922.35854056053;14948.775768363483;7907.090684571348;8130.634121464548;8210.671573137008;8278;8296.875546866802;7900.091489478784;7964.362850971908;8008.439409241414;8114.594270286462;8179.141190175065;4480.708753930984;4505.346724724896;4519.796609152596;4544.863654090383;4567.474740404829;1874.6250749850085;1909.3889955214477;1926.5376309685855;1950.951226219356;1966.469053355586;907.3603109807569;992.6426486464867;1030.2685093583489;1042.7341028037802;1044.9811433851933;17890.153616972413;18489.352872649662;18961;19009.42971710851;19196.136173872208;1003.7390278527636;1017.5980487707315;1024.5799222318813;1034.6533911139702;1070;10504.317219380715;10655.094316983143;10750.516226769658;10755.83866242007;10781.137508999262;458674;493247;496631;507538;510218;93053.5347323259;94912.52543737376;95230;95322;95349.5232523833;1000.3847633705219;1002.1210230817218;1012.8987101289812;1024.8616436781087;1027.0294571629738;16507.58731031734;17013.74479382835;17025.914870425568;17095.743563846303;17172.141392930054;37466.25067498689;37506.24987500289;38468.42297365598;39699.60300396959;39763.60236397599;55193.172102417695;56909.43090569042;57861;58400.415995839496;58416;8261.628226729932;8310.768589877176;8326.417150799385;8648.610812513578;8653.653853846028;12050.216735912138;12661.556845510362;12752.298623575422;12846.550370736979;12914.67713307175;11692.47383867711;11797.29216247028;11808.291502509877;12000.819987700366;12109.636710898687;11476.598319058792;11699.941500292443;11820.82268765952;11850.170488065753;11866.40667966581;11399.544018239178;11734.70663233426;12084.758304833678;12108;12200.87799122033;7260.092488438945;8244.051934027424;8253.711120110767;8322.292605128632;8780.736577902673;10355;11353.772924541629;11420.428978550874;11734.354610496162;12089.516419343128 11:22:08 INFO - PROCESS | 8298 | |3;mootools.html;1294.1458637299384;1383.6610030542518;1385.570473153322;1600.5358446050645;1608.8712902967764;7411.814704632387;8024.759257222286;8067.798305042377;8340.666373345066;8360.707375241867;8154.429189956705;8158.632861521231;8161.795955101111;8212.260896519312;8236.341092712584;2327.453048533593;2350.7766762157567;2350.894209760565;2355;2356.575816353056;2257.571061498318;2274.0221704666988;2311.087120587367;2311.9768802312014;2314.9582687790476;2284.8629082255034;2313.9884300578474;2316.108298305148;2322.84901481404;2325.662778897059;2208.194009186643;2228;2235.5305385868987;2255.334676270504;2269.7730226977337;2201.4606421426693;2206;2223.655333423306;2227.276135256032;2230.2863083813186;8331.208535189147;8335.249827515492;8380.622871970776;8441.324694024463;8446.535440550768;5087.829799146217;5185.988732197223;5193.792248310063;5241.528262456397;5254.133068043769;3194.6965038321323;3269.8365081746056;3351.6815902489225;3354.685267165648;3357.697807197364;1004.8593196952432;1012.4380968562444;1026.163676603573;1036.4972988100765;1037.6938803053117;11275.830862537068;11350.432478376048;11445.25605835618;11470.369129697863;11571.884281157165;4297.505786834491;4443.244648409778;4571.702839315501;4651.116287905287;4664.253719404879;9755.512224388753;9823.705288841204;9867.30928834989;9920.355176913477;9954.751131221632;5006.0989021975665;5032.7735251913755;5043.646944713835;5045.84862454127;5052.7726252318735;4232.217039847638;4581.977090114528;4606.309053641913;4763.618910487153;4774.236122220497;3672.247189326182;3688.907777305535;3776.8300426480873;3792.60177681345;3795.4686343911876;1244.7883859743865;1250.06245316013;1258.930758808256;1261.8927391171853;1262.7663882181826;871.5772850167664;887.4143065576689;890.6882591093066;896.9998451726278;898.2679116520015;5452.291202143696;5467.617266791366;5628.85927851807;5677.034904066319;5714.542836573064;398.5118230168079;399.1000294336253;408.86303088465104;421.25017468905395;428.37671188420774;3827.349350610403;3855.8072096395067;3857.3828187489867;3900.7074469414906;3924.9018774530864;9903.306768526134;10314.535845886952;10339.379637221791;10354;10400.271980961412;9878.851817222747;10229.232807539463;10262.640807571699;10267.332623379456;10325.690229293134;7662.693492260359;7723.691052357843;7781.26078022587;7818.843623127392;7824.647890844812;5546.500814926676;5608.298962629671;5683.943160568341;5692.857678558069;5734.311882574118;9334.06659334061;9426.387284826464;9432.811343773223;9442.575084121094;9560.426374417557;8925.73222803317;9270.351075424656;9322.627094916128;9361.344705870795;9440.858387124335;6763.763268285783;7176.318249766264;7226.783196504113;7317.853642927218;7435.33082022599;7936.166702496154;7960.442769006114;7982.680692772224;8013.3589312856;8015.83968320642;7087.114110736158;7327.596982165819;7332.413406927326;7363.079615048119;7439.776806695808;7218.494705370574;7223.638818059181;7352.632368381666;7387.8153046174275;7568.508046976929;6801.727930882709;6802.489813263926;6862.451003919575;6887.690053947485;6903.0680858083515;4775.21209000511;4812.446568644651;4815.109204797123;4865.756712164449;4916.115099282163;4879.463259041431;4971.975140124277;4980.526849949394;5025.346704928336;5032.270320803536 11:22:08 INFO - PROCESS | 8298 | |4;prototype.html;321.95331676906846;328.7846460568327;329.9752518561107;341.4076577138664;344.43512639271586;6014.879702405955;6038.909416358752;6091.360407157251;6105.633661980284;6120.908186377197;5946.672932988684;5954.761809527614;5955.464008239258;5977.163197152402;5995.880082398349;4314.697971142014;4364.010652702908;4491.730496170224;4530.7087480068185;4538.841140560081;4489.326601009842;4504.617107545862;4525.9547404525865;4533.659975501834;4533.818647254106;4493.191225579394;4494.438195225597;4507.211238033331;4510.661700372485;4512.278035514319;4343.370211319357;4485.34962430449;4500.469840254329;4501.617362524156;4522.977385113069;3930.6265904739003;3933.409988501719;3946.1910308386714;3949.3483575210057;3951.38753493209;5686.658800471985;5726.942730572682;5737.110747834093;5776.516098077825;5777.826665200051;5097.541221290102;5246.160614301693;5263.684178949237;5279.920801187947;5281.36623605166;6240.625562466266;6242.937570624326;6258.311585725566;6284.905726414107;6304.401081897213;4065.9593404065877;4362.934555981663;4362.934555981663;4381.3208952612395;4389.539098394686;6470.411835265884;6588.769393071219;6590.439812615933;6608.1409416776;6610.603363798187;4314.784260787011;4337.804798784062;4356.825726970949;4360.65114790816;4381.518033016366;4302.913941721211;4409.470863496401;4439.467263928349;4453.665975051884;4454.1982443159895;5121.3854337479;5159.097157997336;5169.715665638426;5182.766775495036;5193.0652482553505;6306.873862522724;6333.303336632966;6339.587926784837;6348.269948955929;6390.552661313756;1470.5588323502907;1523.2536057331827;1540.776587394844;1550.1706586975913;1552.7127481415748;938.1556599060764;1013.2451323763696;1045.8169820281573;1068.8129577323937;1075.096918588374;6061.4544690977145;6099.207103076572;6109.633421994695;6119.265688117454;6134.141220229171;6307.810765676945;6418.775342862978;6427.58220715652;6429.742810287629;6449.097126402307;6016.819495415145;6070.817875463743;6076.210092687922;6097.725602347905;6129.448349648553;3416.8895109089644;3449.896503104911;3459.238967427212;3478.80866552337;3497.755157139027;6590.538662293689;6594.7032383542855;6686.465082793365;6693.765718199937;6695.698693558801;6500.6424646643945;6530.836729081716;6531.281559028503;6540.70566824494;6557.573757705829;6495.8700825983215;6661.935509665511;6683.4987375947;6829.190264579791;6891.27641597625;6564;6564.409203171737;6565.621219543949;6587.769428069994;6589.308122647053;6235.282942461494;6479.546431749733;6494.817539405752;6524;6534.607923524603;6830.897536537055;6831.726730930707;6848.486363522856;6857.177138743383;6895.379415852597;4396.406485124595;4422.579854913778;4423.093265880551;4425.6238219751685;4434.201843668042;6371.598248385348;6532.281449040697;6538.542302038812;6587.374199451045;6633.469322454095;6370.872582548416;6372.936270637234;6381.329960354096;6408.519361048034;6414.743410263537;6280.152179455715;6315.621062736251;6370.8088757337355;6407.263164736115;6426.132472116205;6055.485283750754;6206.348333425106;6238.157848690369;6244.250689917239;6303.527235457267;6321.30465648769;6383.234011918599;6383.36166383358;6413.903791443226;6425.58233714807;6034.24571928509;6231.158793562811;6268.811935641938;6272.937270627235;6277.403646653561 11:22:08 INFO - PROCESS | 8298 | |5;yui.html;722.3390597603191;726.6403130450426;737.7159793479509;759.4000739415861;831.7130589946469;13984.160950342986;14363.856361436383;14372.496962606285;14372.49696260631;14409.78385324221;13094;13205.603831885035;13210.867891321084;13225.801612975813;13243;574.6063946196848;705.6789160931789;719.6905330707793;727.1528669100518;729.9087614048244;713.8072720365499;721.2967356827104;721.9963900180492;722.6097907130144;725.1877896755641;758.7420277105783;763.0957315581027;763.1833937686678;763.7632333976458;765.7779244019227;754.5849782619565;755.50891920252;755.5731011978214;757.307064036406;760.0916904299364;557.4704031170404;557.877267001259;560.1317957166376;560.2688491518567;560.8233406476946;13014.674633134247;13039.478420863154;13069.542566010145;13092.934535327358;13112;13991;14024.509142180077;14144.504942326968;14170.29148542579;14261.714765704732;11113.166512511512;11122.61070862516;11368.261063030877;11467.885321146765;11611;3817.8854634361014;3874.8643797467234;3891.8443262269475;3928.7839168845703;3986.66113380363;54221;54242.18636720413;54520.90958180854;54532;54856.72571637116;10792.406417647106;10811.35131892089;10884.346939183675;10952.616658417077;10961.232713710124;19636.901815491117;19640.508987275145;19647.803521964885;19671;19719.40841774749;7891.329237014918;7966.920330796734;8174.83650327002;8284.378671599654;8337;4678.1813182692895;4697.78859951303;4726.314684370747;4749.905001899942;4830.734309612934;3178.984105079506;3286.8027918324497;3293.127321259868;3293.4730443128983;3296.225387034045;566.1960016776105;591.393821333137;592.238972919796;593.6289818863211;605.8757954619292;648.3127884442506;661.3617858766218;676.5737585321315;676.8307923019245;750.1261030898942;8868.911310886808;8886.422382545114;9115.817683646423;9128.26973842091;9189.40268882534;651.840299126717;651.9576227545194;726.8836986082307;745.4483682075225;774.0556521044317;4210.157968406331;4432.889177770581;4464.464264288306;4474.507804141542;4487.820487180476;59087;59384.10923836146;59647.10529342063;60063;60171.39828601746;49949.25076123861;49974.002079833524;50347.74826125846;50752.238716419284;52445.47554524406;46799.5320046802;46842.29736553955;46844;46921;47215.5278447218;8634.654613815377;8761.737147885573;8797.296216302808;8928.10718928128;8964.506952117696;31426.842865785526;31781.36437271288;32309.676903230666;32339.514907275938;32727.836360818044;39357;40076;40285.59714402936;40503.1899362017;41269.38095928504;12109.152359334763;12291.815622765487;12450.688732781753;12503.937480312541;12649.494020239088;13424.664383390493;13859.792103118663;13950.441982320594;14204;14575.198364089652;13363.1313964592;13523.053386262867;13544.93227533856;13578.25319607431;13674.453021879013;13067.34663266814;13146.408411621309;13242;13570.05009649315;13714.725705486035;11279.436028198721;12192.085593580694;12689.23864568129;13286.468541258242;13590;10259;10476.313130312325;10906.454677265947;10942.835857462303;11035.503402346752;10928.617498387519;10948.288361256493;11011.834822477509;11141.275817071864;11384.260023098472 11:22:08 INFO - PROCESS | 8298 | __end_tp_report 11:22:08 INFO - PROCESS | 8298 | __start_cc_report 11:22:08 INFO - PROCESS | 8298 | _x_x_mozilla_cycle_collect,335 11:22:08 INFO - PROCESS | 8298 | __end_cc_report 11:22:08 INFO - PROCESS | 8298 | __startTimestamp1460744528691__endTimestamp 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | ------- Summary: start ------- 11:22:08 INFO - PROCESS | 8298 | Number of tests: 6 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#0] dojo.html Cycles:165 Average:5366.08 Median:5598.36 stddev:619.70 (11.1%) stddev-sans-first:594.89 11:22:08 INFO - PROCESS | 8298 | Values: 3071.8 3131.5 3141.4 3180.1 3187.9 5424.1 5430.9 5434.2 5437.6 5440.9 5343.2 5358.9 5408.9 5489.3 5497.6 4833.7 4850.4 4886.4 4930.4 4943.3 4809.2 5047.0 5055.4 5056.0 5057.9 4818.6 4875.9 4902.2 4940.1 4956.0 4838.7 4854.2 4861.8 4892.0 4906.4 4839.2 4839.8 4841.6 4847.1 4898.1 5052.9 5261.2 5295.2 5300.3 5316.9 5733.6 5763.5 5776.3 5781.7 5814.3 5678.0 5813.0 5816.1 5823.8 5831.7 5384.9 5433.6 5434.3 5482.0 5486.5 5777.3 5797.9 5809.8 5823.7 5833.5 5433.3 5568.6 5585.1 5598.4 5694.2 5711.4 5718.9 5733.8 5738.9 5759.1 5685.6 5699.7 5720.1 5727.9 5769.1 5703.1 5720.3 5720.3 5734.0 5768.7 4270.7 4331.9 4333.7 4337.5 4367.0 3813.0 3884.6 3900.5 3913.1 3984.1 5617.3 5622.7 5623.0 5628.8 5667.3 5853.2 5860.6 5870.3 5879.8 5884.1 5468.2 5520.4 5586.0 5592.4 5627.5 4959.6 4974.5 4978.9 4992.9 5050.4 5988.2 6058.5 6058.8 6064.6 6075.2 5701.0 5866.6 5903.8 5929.8 5943.8 5911.4 5931.0 5940.0 5952.5 5960.6 5636.3 5641.5 5643.4 5647.0 5693.8 5851.3 5887.9 5919.2 5935.9 5965.3 5618.9 5631.9 5644.1 5652.4 5677.8 5438.1 5625.9 5650.4 5653.5 5678.8 5337.4 5556.6 5573.7 5596.8 5669.0 5642.2 5672.0 5675.8 5723.5 5739.5 5428.7 5580.0 5584.3 5585.8 5592.3 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#1] ext.html Cycles:180 Average:50051.21 Median:36462.23 stddev:96203.01 (263.8%) stddev-sans-first:96401.26 11:22:08 INFO - PROCESS | 8298 | Values: 610.1 626.5 645.4 652.1 662.6 34069.0 35389.5 35487.8 35582.6 35679.1 38271.4 38870.4 38974.6 38976.0 39176.2 8327.3 8564.7 8569.8 8584.4 8602.2 8342.2 8472.2 8520.1 8522.1 8537.4 8722.5 8764.1 8798.1 8803.6 8825.5 8711.7 8768.7 8779.4 8798.9 8820.1 8522.9 8598.1 8607.3 8651.1 8651.4 37127.4 37511.0 37673.0 37774.8 37810.8 3387.7 3393.0 3410.4 3456.0 3689.9 29805.6 30560.7 30667.0 30692.3 31194.2 4266.8 4284.2 4348.6 4379.5 4398.5 280064.0 281189.0 281879.0 283264.0 285659.0 33828.0 34264.8 34283.1 53030.7 53924.5 33851.0 33951.5 33969.0 33994.8 33999.3 14423.5 14579.9 14633.9 14647.6 14686.0 12276.3 12296.2 12332.0 12332.8 12337.9 8049.4 8076.6 8131.7 8272.2 8373.0 3146.2 3210.7 3244.5 3255.7 3261.2 995.2 1022.2 1112.0 1187.6 1200.5 29675.6 29878.6 30057.8 30146.0 30302.1 1052.5 1125.6 1145.4 1165.9 1168.2 15481.5 15641.5 15787.7 16053.0 16116.8 411063.9 414782.0 415182.0 416299.0 417120.0 48361.3 49271.8 49315.8 49488.0 49566.3 1280.5 1318.9 1340.6 1341.4 1363.9 29418.6 29891.0 30253.7 30448.2 30769.4 43688.6 44004.3 44117.1 44174.0 44304.6 379714.0 381765.0 382228.0 382350.0 382604.0 27072.3 27390.2 27417.0 40593.2 41995.6 39551.6 39742.8 39948.2 40078.0 40346.0 34492.7 35218.6 35880.5 36795.8 37400.0 35935.0 36154.8 36204.0 36353.0 36571.5 36957.8 37655.0 38024.0 38160.0 38675.6 31367.9 31818.4 32537.8 32551.2 32918.5 26688.9 26750.6 26755.0 26883.2 27102.3 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#2] jquery.html Cycles:180 Average:28470.26 Median:2239.25 stddev:81422.89 (3636.2%) stddev-sans-first:81624.00 11:22:08 INFO - PROCESS | 8298 | Values: 389.2 389.6 395.2 396.3 396.9 13527.6 13859.0 16604.8 17399.3 17477.4 16444.7 16856.7 17015.7 17187.1 17885.1 5531.4 5686.4 5695.4 5698.5 5699.9 5418.2 5664.7 5684.3 5684.9 5694.3 5554.8 5559.0 5625.8 5636.2 5653.9 5128.7 5298.4 5420.6 5427.1 5446.9 5144.6 5256.6 5595.2 5611.9 5644.2 13363.5 13502.0 13612.8 15584.4 19158.8 2161.9 2228.0 2250.5 2265.1 2494.5 9486.4 9775.9 9812.7 9955.0 10281.3 1838.6 1897.7 1962.2 1970.3 1971.7 68326.3 78395.2 79731.6 79761.6 79926.6 10087.1 10588.5 10598.6 10621.5 10829.6 14828.9 14882.9 14907.6 14922.4 14948.8 7907.1 8130.6 8210.7 8278.0 8296.9 7900.1 7964.4 8008.4 8114.6 8179.1 4480.7 4505.3 4519.8 4544.9 4567.5 1874.6 1909.4 1926.5 1951.0 1966.5 907.4 992.6 1030.3 1042.7 1045.0 17890.2 18489.4 18961.0 19009.4 19196.1 1003.7 1017.6 1024.6 1034.7 1070.0 10504.3 10655.1 10750.5 10755.8 10781.1 458674.0 493247.0 496631.0 507538.0 510218.0 93053.5 94912.5 95230.0 95322.0 95349.5 1000.4 1002.1 1012.9 1024.9 1027.0 16507.6 17013.7 17025.9 17095.7 17172.1 37466.3 37506.2 38468.4 39699.6 39763.6 55193.2 56909.4 57861.0 58400.4 58416.0 8261.6 8310.8 8326.4 8648.6 8653.7 12050.2 12661.6 12752.3 12846.6 12914.7 11692.5 11797.3 11808.3 12000.8 12109.6 11476.6 11699.9 11820.8 11850.2 11866.4 11399.5 11734.7 12084.8 12108.0 12200.9 7260.1 8244.1 8253.7 8322.3 8780.7 10355.0 11353.8 11420.4 11734.4 12089.5 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#3] mootools.html Cycles:180 Average:5479.73 Median:4993.31 stddev:3083.06 (61.7%) stddev-sans-first:3075.66 11:22:08 INFO - PROCESS | 8298 | Values: 1294.1 1383.7 1385.6 1600.5 1608.9 7411.8 8024.8 8067.8 8340.7 8360.7 8154.4 8158.6 8161.8 8212.3 8236.3 2327.5 2350.8 2350.9 2355.0 2356.6 2257.6 2274.0 2311.1 2312.0 2315.0 2284.9 2314.0 2316.1 2322.8 2325.7 2208.2 2228.0 2235.5 2255.3 2269.8 2201.5 2206.0 2223.7 2227.3 2230.3 8331.2 8335.2 8380.6 8441.3 8446.5 5087.8 5186.0 5193.8 5241.5 5254.1 3194.7 3269.8 3351.7 3354.7 3357.7 1004.9 1012.4 1026.2 1036.5 1037.7 11275.8 11350.4 11445.3 11470.4 11571.9 4297.5 4443.2 4571.7 4651.1 4664.3 9755.5 9823.7 9867.3 9920.4 9954.8 5006.1 5032.8 5043.6 5045.8 5052.8 4232.2 4582.0 4606.3 4763.6 4774.2 3672.2 3688.9 3776.8 3792.6 3795.5 1244.8 1250.1 1258.9 1261.9 1262.8 871.6 887.4 890.7 897.0 898.3 5452.3 5467.6 5628.9 5677.0 5714.5 398.5 399.1 408.9 421.3 428.4 3827.3 3855.8 3857.4 3900.7 3924.9 9903.3 10314.5 10339.4 10354.0 10400.3 9878.9 10229.2 10262.6 10267.3 10325.7 7662.7 7723.7 7781.3 7818.8 7824.6 5546.5 5608.3 5683.9 5692.9 5734.3 9334.1 9426.4 9432.8 9442.6 9560.4 8925.7 9270.4 9322.6 9361.3 9440.9 6763.8 7176.3 7226.8 7317.9 7435.3 7936.2 7960.4 7982.7 8013.4 8015.8 7087.1 7327.6 7332.4 7363.1 7439.8 7218.5 7223.6 7352.6 7387.8 7568.5 6801.7 6802.5 6862.5 6887.7 6903.1 4775.2 4812.4 4815.1 4865.8 4916.1 4879.5 4972.0 4980.5 5025.3 5032.3 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#4] prototype.html Cycles:180 Average:5265.33 Median:6073.51 stddev:1614.49 (26.6%) stddev-sans-first:1575.80 11:22:08 INFO - PROCESS | 8298 | Values: 322.0 328.8 330.0 341.4 344.4 6014.9 6038.9 6091.4 6105.6 6120.9 5946.7 5954.8 5955.5 5977.2 5995.9 4314.7 4364.0 4491.7 4530.7 4538.8 4489.3 4504.6 4526.0 4533.7 4533.8 4493.2 4494.4 4507.2 4510.7 4512.3 4343.4 4485.3 4500.5 4501.6 4523.0 3930.6 3933.4 3946.2 3949.3 3951.4 5686.7 5726.9 5737.1 5776.5 5777.8 5097.5 5246.2 5263.7 5279.9 5281.4 6240.6 6242.9 6258.3 6284.9 6304.4 4066.0 4362.9 4362.9 4381.3 4389.5 6470.4 6588.8 6590.4 6608.1 6610.6 4314.8 4337.8 4356.8 4360.7 4381.5 4302.9 4409.5 4439.5 4453.7 4454.2 5121.4 5159.1 5169.7 5182.8 5193.1 6306.9 6333.3 6339.6 6348.3 6390.6 1470.6 1523.3 1540.8 1550.2 1552.7 938.2 1013.2 1045.8 1068.8 1075.1 6061.5 6099.2 6109.6 6119.3 6134.1 6307.8 6418.8 6427.6 6429.7 6449.1 6016.8 6070.8 6076.2 6097.7 6129.4 3416.9 3449.9 3459.2 3478.8 3497.8 6590.5 6594.7 6686.5 6693.8 6695.7 6500.6 6530.8 6531.3 6540.7 6557.6 6495.9 6661.9 6683.5 6829.2 6891.3 6564.0 6564.4 6565.6 6587.8 6589.3 6235.3 6479.5 6494.8 6524.0 6534.6 6830.9 6831.7 6848.5 6857.2 6895.4 4396.4 4422.6 4423.1 4425.6 4434.2 6371.6 6532.3 6538.5 6587.4 6633.5 6370.9 6372.9 6381.3 6408.5 6414.7 6280.2 6315.6 6370.8 6407.3 6426.1 6055.5 6206.3 6238.2 6244.3 6303.5 6321.3 6383.2 6383.4 6413.9 6425.6 6034.2 6231.2 6268.8 6272.9 6277.4 11:22:08 INFO - PROCESS | 8298 | 11:22:08 INFO - PROCESS | 8298 | [#5] yui.html Cycles:180 Average:14360.49 Median:4321.52 stddev:16136.73 (373.4%) stddev-sans-first:16149.49 11:22:08 INFO - PROCESS | 8298 | Values: 722.3 726.6 737.7 759.4 831.7 13984.2 14363.9 14372.5 14372.5 14409.8 13094.0 13205.6 13210.9 13225.8 13243.0 574.6 705.7 719.7 727.2 729.9 713.8 721.3 722.0 722.6 725.2 758.7 763.1 763.2 763.8 765.8 754.6 755.5 755.6 757.3 760.1 557.5 557.9 560.1 560.3 560.8 13014.7 13039.5 13069.5 13092.9 13112.0 13991.0 14024.5 14144.5 14170.3 14261.7 11113.2 11122.6 11368.3 11467.9 11611.0 3817.9 3874.9 3891.8 3928.8 3986.7 54221.0 54242.2 54520.9 54532.0 54856.7 10792.4 10811.4 10884.3 10952.6 10961.2 19636.9 19640.5 19647.8 19671.0 19719.4 7891.3 7966.9 8174.8 8284.4 8337.0 4678.2 4697.8 4726.3 4749.9 4830.7 3179.0 3286.8 3293.1 3293.5 3296.2 566.2 591.4 592.2 593.6 605.9 648.3 661.4 676.6 676.8 750.1 8868.9 8886.4 9115.8 9128.3 9189.4 651.8 652.0 726.9 745.4 774.1 4210.2 4432.9 4464.5 4474.5 4487.8 59087.0 59384.1 59647.1 60063.0 60171.4 49949.3 49974.0 50347.7 50752.2 52445.5 46799.5 46842.3 46844.0 46921.0 47215.5 8634.7 8761.7 8797.3 8928.1 8964.5 31426.8 31781.4 32309.7 32339.5 32727.8 39357.0 40076.0 40285.6 40503.2 41269.4 12109.2 12291.8 12450.7 12503.9 12649.5 13424.7 13859.8 13950.4 14204.0 14575.2 13363.1 13523.1 13544.9 13578.3 13674.5 13067.3 13146.4 13242.0 13570.1 13714.7 11279.4 12192.1 12689.2 13286.5 13590.0 10259.0 10476.3 10906.5 10942.8 11035.5 10928.6 10948.3 11011.8 11141.3 11384.3 11:22:08 INFO - PROCESS | 8298 | -------- Summary: end -------- 11:22:08 INFO - PROCESS | 8298 | 11:22:09 INFO - TEST-INFO | 8298: exit 0 11:22:09 INFO - TEST-OK | dromaeo_css | took 1109492ms 11:22:09 INFO - TEST-START | kraken 11:22:09 INFO - operating with platform_type : linux_ 11:22:09 INFO - Initialising browser for kraken test... 11:22:09 INFO - TEST-INFO | started process 8535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzq_dtD/profile http://localhost:56404/getInfo.html) 11:22:12 INFO - PROCESS | 8535 | 11:22:12 INFO - PROCESS | 8535 | (process:8602): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:12 INFO - PROCESS | 8535 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 11:22:13 INFO - PROCESS | 8535 | __metrics Screen width/height:1600/1200 11:22:13 INFO - PROCESS | 8535 | colorDepth:24 11:22:13 INFO - PROCESS | 8535 | Browser inner width/height: 1024/697 11:22:13 INFO - PROCESS | 8535 | __metrics 11:22:14 ERROR - PROCESS | 8535 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 11:22:14 INFO - TEST-INFO | 8535: exit 0 11:22:14 INFO - Browser initialized. 11:22:14 INFO - Running cycle 1/1 for kraken test... 11:22:14 INFO - TEST-INFO | started process 8653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzq_dtD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:16 INFO - PROCESS | 8653 | 11:22:16 INFO - PROCESS | 8653 | (process:8711): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:22:26 INFO - PROCESS | 8653 | RSS: Main: 164061184 11:22:26 INFO - PROCESS | 8653 | 11:22:29 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:30 INFO - PROCESS | 8653 | RSS: Main: 168030208 11:22:30 INFO - PROCESS | 8653 | 11:22:32 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-dft) 11:22:33 INFO - PROCESS | 8653 | RSS: Main: 171765760 11:22:33 INFO - PROCESS | 8653 | 11:22:36 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-fft) 11:22:36 INFO - PROCESS | 8653 | RSS: Main: 162926592 11:22:36 INFO - PROCESS | 8653 | 11:22:39 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-oscillator) 11:22:39 INFO - PROCESS | 8653 | RSS: Main: 164089856 11:22:39 INFO - PROCESS | 8653 | 11:22:41 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:22:42 INFO - PROCESS | 8653 | RSS: Main: 164098048 11:22:42 INFO - PROCESS | 8653 | 11:22:45 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-darkroom) 11:22:46 INFO - PROCESS | 8653 | RSS: Main: 164089856 11:22:46 INFO - PROCESS | 8653 | 11:22:49 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-desaturate) 11:22:50 INFO - PROCESS | 8653 | RSS: Main: 164159488 11:22:50 INFO - PROCESS | 8653 | 11:22:52 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56404/tests/kraken/driver.html?testName=json-parse-financial) 11:22:53 INFO - PROCESS | 8653 | RSS: Main: 166281216 11:22:53 INFO - PROCESS | 8653 | 11:22:55 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:22:55 INFO - PROCESS | 8653 | RSS: Main: 166416384 11:22:55 INFO - PROCESS | 8653 | 11:22:57 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:22:58 INFO - PROCESS | 8653 | RSS: Main: 166096896 11:22:58 INFO - PROCESS | 8653 | 11:23:00 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:00 INFO - PROCESS | 8653 | RSS: Main: 166703104 11:23:00 INFO - PROCESS | 8653 | 11:23:03 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:04 INFO - PROCESS | 8653 | RSS: Main: 167301120 11:23:04 INFO - PROCESS | 8653 | 11:23:07 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:07 INFO - PROCESS | 8653 | RSS: Main: 167333888 11:23:07 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56404/tests/kraken/driver.html?testName=ai-astar) 11:23:09 INFO - PROCESS | 8653 | RSS: Main: 168906752 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | __start_tp_report 11:23:09 INFO - PROCESS | 8653 | _x_x_mozilla_page_load 11:23:09 INFO - PROCESS | 8653 | _x_x_mozilla_page_load_details 11:23:09 INFO - PROCESS | 8653 | |i|pagename|runs| 11:23:09 INFO - PROCESS | 8653 | |0;ai-astar;111;105;113;112;114;127;111;113;113;113 11:23:09 INFO - PROCESS | 8653 | |1;audio-beat-detection;155;129;152;188;132;148;165;131;186;128 11:23:09 INFO - PROCESS | 8653 | |2;audio-dft;163;161;162;162;162;165;168;165;165;162 11:23:09 INFO - PROCESS | 8653 | |3;audio-fft;77;75;73;157;77;76;76;72;155;77 11:23:09 INFO - PROCESS | 8653 | |4;audio-oscillator;92;92;155;92;95;93;146;92;92;140 11:23:09 INFO - PROCESS | 8653 | |5;imaging-gaussian-blur;116;117;117;117;117;118;118;117;118;118 11:23:09 INFO - PROCESS | 8653 | |6;imaging-darkroom;148;146;146;146;148;146;147;147;147;147 11:23:09 INFO - PROCESS | 8653 | |7;imaging-desaturate;95;95;95;95;96;96;94;95;96;95 11:23:09 INFO - PROCESS | 8653 | |8;json-parse-financial;60;61;58;58;58;57;59;77;62;57 11:23:09 INFO - PROCESS | 8653 | |9;json-stringify-tinderbox;61;61;62;62;62;62;61;69;62;62 11:23:09 INFO - PROCESS | 8653 | |10;stanford-crypto-aes;79;76;76;77;79;77;78;79;78;78 11:23:09 INFO - PROCESS | 8653 | |11;stanford-crypto-ccm;133;137;128;127;132;133;129;135;198;125 11:23:09 INFO - PROCESS | 8653 | |12;stanford-crypto-pbkdf2;176;170;167;167;171;178;168;170;170;165 11:23:09 INFO - PROCESS | 8653 | |13;stanford-crypto-sha256-iterative;68;69;74;68;68;67;71;67;67;70 11:23:09 INFO - PROCESS | 8653 | __end_tp_report 11:23:09 INFO - PROCESS | 8653 | __start_cc_report 11:23:09 INFO - PROCESS | 8653 | _x_x_mozilla_cycle_collect,840 11:23:09 INFO - PROCESS | 8653 | __end_cc_report 11:23:09 INFO - PROCESS | 8653 | __startTimestamp1460744589630__endTimestamp 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | ------- Summary: start ------- 11:23:09 INFO - PROCESS | 8653 | Number of tests: 14 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:5.47 (4.8%) stddev-sans-first:5.75 11:23:09 INFO - PROCESS | 8653 | Values: 111.0 105.0 113.0 112.0 114.0 127.0 111.0 113.0 113.0 113.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#1] audio-beat-detection Cycles:10 Average:151.40 Median:153.50 stddev:22.58 (14.7%) stddev-sans-first:23.91 11:23:09 INFO - PROCESS | 8653 | Values: 155.0 129.0 152.0 188.0 132.0 148.0 165.0 131.0 186.0 128.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 11:23:09 INFO - PROCESS | 8653 | Values: 163.0 161.0 162.0 162.0 162.0 165.0 168.0 165.0 165.0 162.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#3] audio-fft Cycles:10 Average:91.50 Median:76.00 stddev:34.04 (44.8%) stddev-sans-first:35.70 11:23:09 INFO - PROCESS | 8653 | Values: 77.0 75.0 73.0 157.0 77.0 76.0 76.0 72.0 155.0 77.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:92.00 stddev:26.55 (28.9%) stddev-sans-first:27.44 11:23:09 INFO - PROCESS | 8653 | Values: 92.0 92.0 155.0 92.0 95.0 93.0 146.0 92.0 92.0 140.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 11:23:09 INFO - PROCESS | 8653 | Values: 116.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 11:23:09 INFO - PROCESS | 8653 | Values: 148.0 146.0 146.0 146.0 148.0 146.0 147.0 147.0 147.0 147.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:23:09 INFO - PROCESS | 8653 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 94.0 95.0 96.0 95.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:59.50 stddev:5.96 (10.0%) stddev-sans-first:6.32 11:23:09 INFO - PROCESS | 8653 | Values: 60.0 61.0 58.0 58.0 58.0 57.0 59.0 77.0 62.0 57.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.00 stddev:2.37 (3.8%) stddev-sans-first:2.46 11:23:09 INFO - PROCESS | 8653 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 61.0 69.0 62.0 62.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:1.16 (1.5%) stddev-sans-first:1.13 11:23:09 INFO - PROCESS | 8653 | Values: 79.0 76.0 76.0 77.0 79.0 77.0 78.0 79.0 78.0 78.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#11] stanford-crypto-ccm Cycles:10 Average:137.70 Median:133.00 stddev:21.52 (16.2%) stddev-sans-first:22.75 11:23:09 INFO - PROCESS | 8653 | Values: 133.0 137.0 128.0 127.0 132.0 133.0 129.0 135.0 198.0 125.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.00 stddev:4.05 (2.4%) stddev-sans-first:3.71 11:23:09 INFO - PROCESS | 8653 | Values: 176.0 170.0 167.0 167.0 171.0 178.0 168.0 170.0 170.0 165.0 11:23:09 INFO - PROCESS | 8653 | 11:23:09 INFO - PROCESS | 8653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.23 (3.3%) stddev-sans-first:2.35 11:23:09 INFO - PROCESS | 8653 | Values: 68.0 69.0 74.0 68.0 68.0 67.0 71.0 67.0 67.0 70.0 11:23:09 INFO - PROCESS | 8653 | -------- Summary: end -------- 11:23:09 INFO - PROCESS | 8653 | 11:23:10 INFO - TEST-INFO | 8653: exit 0 11:23:10 INFO - TEST-OK | kraken | took 61186ms 11:23:10 INFO - SUITE-END | took 1170s 11:23:10 INFO - Completed test suite (00:19:30) 11:23:10 INFO - javascript benchmark 11:23:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.769617278704, 3131.53027045943, 3141.4345417824784, 3180.125465496988, 3187.9043628691147, 5424.132138857779, 5430.8913821723545, 5434.157705555635, 5437.564994800417, 5440.91838622421, 5343.171808369709, 5358.946410535894, 5408.918866217, 5489.313835770528, 5497.642653227537, 4833.685810422329, 4850.417949846014, 4886.438059623153, 4930.408350997867, 4943.258511223309, 4809.230523116302, 5046.97476512617, 5055.4186268579215, 5056.0, 5057.898842023157, 4818.590419814303, 4875.902481950377, 4902.240152776325, 4940.061388336223, 4955.950440495585, 4838.709677419366, 4854.247591623269, 4861.756912154414, 4892.021595680842, 4906.435759887588, 4839.153148199086, 4839.830605928811, 4841.612670986313, 4847.12751704693, 4898.093852637274, 5052.9242061369105, 5261.237120617528, 5295.205719142121, 5300.310959575269, 5316.9202461963105, 5733.569982251348, 5763.452472015152, 5776.306843178803, 5781.682007489587, 5814.273215848019, 5678.0, 5812.970935145339, 5816.069428891357, 5823.767049318022, 5831.679257640828, 5384.865378365572, 5433.646812957106, 5434.347878254634, 5482.0, 5486.451354864522, 5777.277840269966, 5797.913031304533, 5809.82570522885, 5823.679697616672, 5833.474987251083, 5433.26650902131, 5568.554515638739, 5585.106382978704, 5598.356189038313, 5694.174344720075, 5711.428857114255, 5718.942810571924, 5733.77064917407, 5738.856528586735, 5759.136129580596, 5685.602007859493, 5699.686517241508, 5720.141978703228, 5727.8568035799435, 5769.07694768835, 5703.058995265817, 5720.342160651495, 5720.3421606515785, 5733.971330143323, 5768.711564421762, 4270.679699022586, 4331.913361732811, 4333.696641235083, 4337.544557821447, 4366.956330436718, 3813.046738315421, 3884.592117827644, 3900.4539364488996, 3913.1195481016543, 3984.103576695278, 5617.297837770278, 5622.662640241599, 5623.0, 5628.774849006076, 5667.3482549507335, 5853.239078919713, 5860.622753652973, 5870.295564532198, 5879.823605291763, 5884.08796636522, 5468.234447177399, 5520.392756796749, 5585.994520986262, 5592.384837667853, 5627.549796016391, 4959.603231741452, 4974.502549744997, 4978.850634480971, 4992.900141997213, 5050.444451110375, 5988.191594134823, 6058.454739073504, 6058.848528786815, 6064.575479716377, 6075.179850720185, 5701.0, 5866.6480011199465, 5903.793367232126, 5929.762809487572, 5943.762249510144, 5911.438413350725, 5930.970345148419, 5939.970300148471, 5952.464278214981, 5960.612560183574, 5636.267285252891, 5641.548676105819, 5643.379228284967, 5647.040003199384, 5693.772249109989, 5851.297844258716, 5887.941120588911, 5919.200907877382, 5935.881282374415, 5965.28416590012, 5618.915716264178, 5631.915521267266, 5644.096944488862, 5652.434756524314, 5677.801276955452, 5438.10271305246, 5625.915611265917, 5650.350209725934, 5653.491185793298, 5678.829635110953, 5337.412884582771, 5556.611037227355, 5573.749181286771, 5596.776128954796, 5669.0, 5642.23829782974, 5671.971640141773, 5675.829725108253, 5723.456271654186, 5739.512141468022, 5428.67427954324, 5580.023495888285, 5584.274044374205, 5585.776568937197, 5592.273004509388], "value": 5323.678441508589, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.0544156557338, 626.4894111299288, 645.4255712415951, 652.0838222297672, 662.6289278004316, 34069.0, 35389.46915796265, 35487.82256088722, 35582.644173558256, 35679.10802229942, 38271.42592861109, 38870.41694374587, 38974.61025389745, 38976.0, 39176.216475670466, 8327.333813294952, 8564.657413703444, 8569.785755356104, 8584.356173286997, 8602.182792634721, 8342.249197572217, 8472.237498625123, 8520.147985201462, 8522.105178956213, 8537.402381833273, 8722.520261385622, 8764.123587641248, 8798.076201998794, 8803.559822008907, 8825.51459669718, 8711.651533938635, 8768.693095741619, 8779.429337093068, 8798.86801697975, 8820.073892241351, 8522.87215691765, 8598.05421403645, 8607.311415086779, 8651.091635378258, 8651.394402391836, 37127.4430883537, 37511.0, 37673.0, 37774.811125944194, 37810.81094594537, 3387.7120444762227, 3392.9990652757497, 3410.420228561126, 3456.0150357148345, 3689.8893033209047, 29805.552916706267, 30560.69439305601, 30667.0, 30692.311922844234, 31194.220144496343, 4266.786660666954, 4284.164587905359, 4348.608625223745, 4379.540148284416, 4398.516163222043, 280064.0, 281189.0, 281879.0, 283264.0, 285659.0, 33828.0, 34264.828675856465, 34283.14292142716, 53030.73484632552, 53924.46075539273, 33851.0, 33951.4907276391, 33969.0, 33994.83002584971, 33999.32001360008, 14423.49517766873, 14579.92710036443, 14633.926830365994, 14647.560573182822, 14686.0, 12276.32480213579, 12296.20074695142, 12332.0, 12332.753344933051, 12337.876621233852, 8049.356051515982, 8076.596170191467, 8131.674733010614, 8272.1727827218, 8372.958135209406, 3146.24490122369, 3210.6628803975245, 3244.4808830586994, 3255.7395408367747, 3261.2010057536054, 995.2225345397864, 1022.1873610479687, 1112.0158659586325, 1187.625897842177, 1200.5257923120319, 29675.554866677016, 29878.551821722693, 30057.849710751743, 30146.0, 30302.090937271918, 1052.4634034309993, 1125.6454216921643, 1145.4272863568217, 1165.904050192816, 1168.1822724093, 15481.458148964732, 15641.452549160726, 15787.68424631501, 16053.0, 16116.75824862628, 411063.9446802807, 414782.0, 415182.0, 416299.0, 417120.0, 48361.27458088131, 49271.75364123157, 49315.753421232665, 49488.0, 49566.25650615244, 1280.5006047641427, 1318.9142705724098, 1340.6179238917057, 1341.3829638366265, 1363.9113457625222, 29418.55872161962, 29890.953816616315, 30253.697463025088, 30448.238794030327, 30769.384612308077, 43688.56311436845, 44004.259637931136, 44117.11765764731, 44174.0, 44304.556954430045, 379714.0, 381765.0, 382228.0, 382350.0, 382604.0, 27072.32319191957, 27390.178294651192, 27417.0, 40593.18813623652, 41995.58004419917, 39551.60448395479, 39742.80128599339, 39948.201035978534, 40078.0, 40346.0, 34492.65507344894, 35218.64781352256, 35880.4617930726, 36795.81602091972, 37400.0, 35935.0, 36154.8192259037, 36204.0, 36353.0, 36571.45142822913, 36957.81521092377, 37655.0, 38024.0, 38160.0, 38675.61324386833, 31367.86135883399, 31818.38619910994, 32537.837310813295, 32551.18622034468, 32918.506222406206, 26688.866555667097, 26750.59874101851, 26755.0, 26883.193504194904, 27102.322441938322], "value": 17559.590423010555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.16524055900095, 389.5773086201471, 395.20958083832335, 396.3400937439164, 396.87300063979524, 13527.594172174826, 13859.0, 16604.83395166048, 17399.304027838887, 17477.38829140979, 16444.67110657786, 16856.66286674266, 17015.744763828523, 17187.140642967865, 17885.105744712746, 5531.3915469298445, 5686.402927692595, 5695.401982791809, 5698.544116470673, 5699.886002279973, 5418.187271909206, 5664.688442135681, 5684.289463817023, 5684.914726279109, 5694.288213973254, 5554.777808887639, 5558.972205138989, 5625.80309689161, 5636.239107720467, 5653.858653533674, 5128.71792051437, 5298.443663415363, 5420.647657902224, 5427.050266203419, 5446.891062178754, 5144.639875208737, 5256.6057545684225, 5595.160725891108, 5611.859703507404, 5644.209810626516, 13363.465461381533, 13502.0, 13612.795808062887, 15584.376624934988, 19158.80841191584, 2161.8702877827222, 2227.988860055689, 2250.5043460935103, 2265.0713207584977, 2494.4761600064007, 9486.430814151174, 9775.853362199572, 9812.705618831447, 9955.0, 10281.331713438603, 1838.586318078435, 1897.7153426985924, 1962.2151139544153, 1970.2611520679745, 1971.7436733224733, 68326.3167368325, 78395.21604783936, 79731.6013419935, 79761.60119199367, 79926.60036699838, 10087.142592879542, 10588.4705764713, 10598.629047983284, 10621.468926553796, 10829.620963266405, 14828.851711482963, 14882.925585372004, 14907.627309317137, 14922.35854056053, 14948.775768363483, 7907.090684571348, 8130.634121464548, 8210.671573137008, 8278.0, 8296.875546866802, 7900.091489478784, 7964.362850971908, 8008.439409241414, 8114.594270286462, 8179.141190175065, 4480.708753930984, 4505.346724724896, 4519.796609152596, 4544.863654090383, 4567.474740404829, 1874.6250749850085, 1909.3889955214477, 1926.5376309685855, 1950.951226219356, 1966.469053355586, 907.3603109807569, 992.6426486464867, 1030.2685093583489, 1042.7341028037802, 1044.9811433851933, 17890.153616972413, 18489.352872649662, 18961.0, 19009.42971710851, 19196.136173872208, 1003.7390278527636, 1017.5980487707315, 1024.5799222318813, 1034.6533911139702, 1070.0, 10504.317219380715, 10655.094316983143, 10750.516226769658, 10755.83866242007, 10781.137508999262, 458674.0, 493247.0, 496631.0, 507538.0, 510218.0, 93053.5347323259, 94912.52543737376, 95230.0, 95322.0, 95349.5232523833, 1000.3847633705219, 1002.1210230817218, 1012.8987101289812, 1024.8616436781087, 1027.0294571629738, 16507.58731031734, 17013.74479382835, 17025.914870425568, 17095.743563846303, 17172.141392930054, 37466.25067498689, 37506.24987500289, 38468.42297365598, 39699.60300396959, 39763.60236397599, 55193.172102417695, 56909.43090569042, 57861.0, 58400.415995839496, 58416.0, 8261.628226729932, 8310.768589877176, 8326.417150799385, 8648.610812513578, 8653.653853846028, 12050.216735912138, 12661.556845510362, 12752.298623575422, 12846.550370736979, 12914.67713307175, 11692.47383867711, 11797.29216247028, 11808.291502509877, 12000.819987700366, 12109.636710898687, 11476.598319058792, 11699.941500292443, 11820.82268765952, 11850.170488065753, 11866.40667966581, 11399.544018239178, 11734.70663233426, 12084.758304833678, 12108.0, 12200.87799122033, 7260.092488438945, 8244.051934027424, 8253.711120110767, 8322.292605128632, 8780.736577902673, 10355.0, 11353.772924541629, 11420.428978550874, 11734.354610496162, 12089.516419343128], "value": 8902.493073114476, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.1458637299384, 1383.6610030542518, 1385.570473153322, 1600.5358446050645, 1608.8712902967764, 7411.814704632387, 8024.759257222286, 8067.798305042377, 8340.666373345066, 8360.707375241867, 8154.429189956705, 8158.632861521231, 8161.795955101111, 8212.260896519312, 8236.341092712584, 2327.453048533593, 2350.7766762157567, 2350.894209760565, 2355.0, 2356.575816353056, 2257.571061498318, 2274.0221704666988, 2311.087120587367, 2311.9768802312014, 2314.9582687790476, 2284.8629082255034, 2313.9884300578474, 2316.108298305148, 2322.84901481404, 2325.662778897059, 2208.194009186643, 2228.0, 2235.5305385868987, 2255.334676270504, 2269.7730226977337, 2201.4606421426693, 2206.0, 2223.655333423306, 2227.276135256032, 2230.2863083813186, 8331.208535189147, 8335.249827515492, 8380.622871970776, 8441.324694024463, 8446.535440550768, 5087.829799146217, 5185.988732197223, 5193.792248310063, 5241.528262456397, 5254.133068043769, 3194.6965038321323, 3269.8365081746056, 3351.6815902489225, 3354.685267165648, 3357.697807197364, 1004.8593196952432, 1012.4380968562444, 1026.163676603573, 1036.4972988100765, 1037.6938803053117, 11275.830862537068, 11350.432478376048, 11445.25605835618, 11470.369129697863, 11571.884281157165, 4297.505786834491, 4443.244648409778, 4571.702839315501, 4651.116287905287, 4664.253719404879, 9755.512224388753, 9823.705288841204, 9867.30928834989, 9920.355176913477, 9954.751131221632, 5006.0989021975665, 5032.7735251913755, 5043.646944713835, 5045.84862454127, 5052.7726252318735, 4232.217039847638, 4581.977090114528, 4606.309053641913, 4763.618910487153, 4774.236122220497, 3672.247189326182, 3688.907777305535, 3776.8300426480873, 3792.60177681345, 3795.4686343911876, 1244.7883859743865, 1250.06245316013, 1258.930758808256, 1261.8927391171853, 1262.7663882181826, 871.5772850167664, 887.4143065576689, 890.6882591093066, 896.9998451726278, 898.2679116520015, 5452.291202143696, 5467.617266791366, 5628.85927851807, 5677.034904066319, 5714.542836573064, 398.5118230168079, 399.1000294336253, 408.86303088465104, 421.25017468905395, 428.37671188420774, 3827.349350610403, 3855.8072096395067, 3857.3828187489867, 3900.7074469414906, 3924.9018774530864, 9903.306768526134, 10314.535845886952, 10339.379637221791, 10354.0, 10400.271980961412, 9878.851817222747, 10229.232807539463, 10262.640807571699, 10267.332623379456, 10325.690229293134, 7662.693492260359, 7723.691052357843, 7781.26078022587, 7818.843623127392, 7824.647890844812, 5546.500814926676, 5608.298962629671, 5683.943160568341, 5692.857678558069, 5734.311882574118, 9334.06659334061, 9426.387284826464, 9432.811343773223, 9442.575084121094, 9560.426374417557, 8925.73222803317, 9270.351075424656, 9322.627094916128, 9361.344705870795, 9440.858387124335, 6763.763268285783, 7176.318249766264, 7226.783196504113, 7317.853642927218, 7435.33082022599, 7936.166702496154, 7960.442769006114, 7982.680692772224, 8013.3589312856, 8015.83968320642, 7087.114110736158, 7327.596982165819, 7332.413406927326, 7363.079615048119, 7439.776806695808, 7218.494705370574, 7223.638818059181, 7352.632368381666, 7387.8153046174275, 7568.508046976929, 6801.727930882709, 6802.489813263926, 6862.451003919575, 6887.690053947485, 6903.0680858083515, 4775.21209000511, 4812.446568644651, 4815.109204797123, 4865.756712164449, 4916.115099282163, 4879.463259041431, 4971.975140124277, 4980.526849949394, 5025.346704928336, 5032.270320803536], "value": 4324.732685122489, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.95331676906846, 328.7846460568327, 329.9752518561107, 341.4076577138664, 344.43512639271586, 6014.879702405955, 6038.909416358752, 6091.360407157251, 6105.633661980284, 6120.908186377197, 5946.672932988684, 5954.761809527614, 5955.464008239258, 5977.163197152402, 5995.880082398349, 4314.697971142014, 4364.010652702908, 4491.730496170224, 4530.7087480068185, 4538.841140560081, 4489.326601009842, 4504.617107545862, 4525.9547404525865, 4533.659975501834, 4533.818647254106, 4493.191225579394, 4494.438195225597, 4507.211238033331, 4510.661700372485, 4512.278035514319, 4343.370211319357, 4485.34962430449, 4500.469840254329, 4501.617362524156, 4522.977385113069, 3930.6265904739003, 3933.409988501719, 3946.1910308386714, 3949.3483575210057, 3951.38753493209, 5686.658800471985, 5726.942730572682, 5737.110747834093, 5776.516098077825, 5777.826665200051, 5097.541221290102, 5246.160614301693, 5263.684178949237, 5279.920801187947, 5281.36623605166, 6240.625562466266, 6242.937570624326, 6258.311585725566, 6284.905726414107, 6304.401081897213, 4065.9593404065877, 4362.934555981663, 4362.934555981663, 4381.3208952612395, 4389.539098394686, 6470.411835265884, 6588.769393071219, 6590.439812615933, 6608.1409416776, 6610.603363798187, 4314.784260787011, 4337.804798784062, 4356.825726970949, 4360.65114790816, 4381.518033016366, 4302.913941721211, 4409.470863496401, 4439.467263928349, 4453.665975051884, 4454.1982443159895, 5121.3854337479, 5159.097157997336, 5169.715665638426, 5182.766775495036, 5193.0652482553505, 6306.873862522724, 6333.303336632966, 6339.587926784837, 6348.269948955929, 6390.552661313756, 1470.5588323502907, 1523.2536057331827, 1540.776587394844, 1550.1706586975913, 1552.7127481415748, 938.1556599060764, 1013.2451323763696, 1045.8169820281573, 1068.8129577323937, 1075.096918588374, 6061.4544690977145, 6099.207103076572, 6109.633421994695, 6119.265688117454, 6134.141220229171, 6307.810765676945, 6418.775342862978, 6427.58220715652, 6429.742810287629, 6449.097126402307, 6016.819495415145, 6070.817875463743, 6076.210092687922, 6097.725602347905, 6129.448349648553, 3416.8895109089644, 3449.896503104911, 3459.238967427212, 3478.80866552337, 3497.755157139027, 6590.538662293689, 6594.7032383542855, 6686.465082793365, 6693.765718199937, 6695.698693558801, 6500.6424646643945, 6530.836729081716, 6531.281559028503, 6540.70566824494, 6557.573757705829, 6495.8700825983215, 6661.935509665511, 6683.4987375947, 6829.190264579791, 6891.27641597625, 6564.0, 6564.409203171737, 6565.621219543949, 6587.769428069994, 6589.308122647053, 6235.282942461494, 6479.546431749733, 6494.817539405752, 6524.0, 6534.607923524603, 6830.897536537055, 6831.726730930707, 6848.486363522856, 6857.177138743383, 6895.379415852597, 4396.406485124595, 4422.579854913778, 4423.093265880551, 4425.6238219751685, 4434.201843668042, 6371.598248385348, 6532.281449040697, 6538.542302038812, 6587.374199451045, 6633.469322454095, 6370.872582548416, 6372.936270637234, 6381.329960354096, 6408.519361048034, 6414.743410263537, 6280.152179455715, 6315.621062736251, 6370.8088757337355, 6407.263164736115, 6426.132472116205, 6055.485283750754, 6206.348333425106, 6238.157848690369, 6244.250689917239, 6303.527235457267, 6321.30465648769, 6383.234011918599, 6383.36166383358, 6413.903791443226, 6425.58233714807, 6034.24571928509, 6231.158793562811, 6268.811935641938, 6272.937270627235, 6277.403646653561], "value": 4735.45946809472, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.3390597603191, 726.6403130450426, 737.7159793479509, 759.4000739415861, 831.7130589946469, 13984.160950342986, 14363.856361436383, 14372.496962606285, 14372.49696260631, 14409.78385324221, 13094.0, 13205.603831885035, 13210.867891321084, 13225.801612975813, 13243.0, 574.6063946196848, 705.6789160931789, 719.6905330707793, 727.1528669100518, 729.9087614048244, 713.8072720365499, 721.2967356827104, 721.9963900180492, 722.6097907130144, 725.1877896755641, 758.7420277105783, 763.0957315581027, 763.1833937686678, 763.7632333976458, 765.7779244019227, 754.5849782619565, 755.50891920252, 755.5731011978214, 757.307064036406, 760.0916904299364, 557.4704031170404, 557.877267001259, 560.1317957166376, 560.2688491518567, 560.8233406476946, 13014.674633134247, 13039.478420863154, 13069.542566010145, 13092.934535327358, 13112.0, 13991.0, 14024.509142180077, 14144.504942326968, 14170.29148542579, 14261.714765704732, 11113.166512511512, 11122.61070862516, 11368.261063030877, 11467.885321146765, 11611.0, 3817.8854634361014, 3874.8643797467234, 3891.8443262269475, 3928.7839168845703, 3986.66113380363, 54221.0, 54242.18636720413, 54520.90958180854, 54532.0, 54856.72571637116, 10792.406417647106, 10811.35131892089, 10884.346939183675, 10952.616658417077, 10961.232713710124, 19636.901815491117, 19640.508987275145, 19647.803521964885, 19671.0, 19719.40841774749, 7891.329237014918, 7966.920330796734, 8174.83650327002, 8284.378671599654, 8337.0, 4678.1813182692895, 4697.78859951303, 4726.314684370747, 4749.905001899942, 4830.734309612934, 3178.984105079506, 3286.8027918324497, 3293.127321259868, 3293.4730443128983, 3296.225387034045, 566.1960016776105, 591.393821333137, 592.238972919796, 593.6289818863211, 605.8757954619292, 648.3127884442506, 661.3617858766218, 676.5737585321315, 676.8307923019245, 750.1261030898942, 8868.911310886808, 8886.422382545114, 9115.817683646423, 9128.26973842091, 9189.40268882534, 651.840299126717, 651.9576227545194, 726.8836986082307, 745.4483682075225, 774.0556521044317, 4210.157968406331, 4432.889177770581, 4464.464264288306, 4474.507804141542, 4487.820487180476, 59087.0, 59384.10923836146, 59647.10529342063, 60063.0, 60171.39828601746, 49949.25076123861, 49974.002079833524, 50347.74826125846, 50752.238716419284, 52445.47554524406, 46799.5320046802, 46842.29736553955, 46844.0, 46921.0, 47215.5278447218, 8634.654613815377, 8761.737147885573, 8797.296216302808, 8928.10718928128, 8964.506952117696, 31426.842865785526, 31781.36437271288, 32309.676903230666, 32339.514907275938, 32727.836360818044, 39357.0, 40076.0, 40285.59714402936, 40503.1899362017, 41269.38095928504, 12109.152359334763, 12291.815622765487, 12450.688732781753, 12503.937480312541, 12649.494020239088, 13424.664383390493, 13859.792103118663, 13950.441982320594, 14204.0, 14575.198364089652, 13363.1313964592, 13523.053386262867, 13544.93227533856, 13578.25319607431, 13674.453021879013, 13067.34663266814, 13146.408411621309, 13242.0, 13570.05009649315, 13714.725705486035, 11279.436028198721, 12192.085593580694, 12689.23864568129, 13286.468541258242, 13590.0, 10259.0, 10476.313130312325, 10906.454677265947, 10942.835857462303, 11035.503402346752, 10928.617498387519, 10948.288361256493, 11011.834822477509, 11141.275817071864, 11384.260023098472], "value": 6548.898272199516, "unit": "score"}], "name": "dromaeo_css", "value": 6938.957813349434, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 113.0, 112.0, 114.0, 127.0, 111.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 152.0, 188.0, 132.0, 148.0, 165.0, 131.0, 186.0, 128.0], "value": 151.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 165.0, 168.0, 165.0, 165.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 73.0, 157.0, 77.0, 76.0, 76.0, 72.0, 155.0, 77.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 155.0, 92.0, 95.0, 93.0, 146.0, 92.0, 92.0, 140.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 58.0, 58.0, 58.0, 57.0, 59.0, 77.0, 62.0, 57.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 69.0, 62.0, 62.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 76.0, 77.0, 79.0, 77.0, 78.0, 79.0, 78.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 137.0, 128.0, 127.0, 132.0, 133.0, 129.0, 135.0, 198.0, 125.0], "value": 137.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 167.0, 167.0, 171.0, 178.0, 168.0, 170.0, 170.0, 165.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 68.0, 68.0, 67.0, 71.0, 67.0, 67.0, 70.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1565.4000000000003, "alertThreshold": 2.0}]} 11:23:10 INFO - Return code: 0 11:23:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:23:10 ERROR - # TBPL SUCCESS # 11:23:10 INFO - Running post-action listener: _resource_record_post_action 11:23:10 INFO - Running post-run listener: _resource_record_post_run 11:23:11 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292089856; Read time: 8; Write time: 186768 11:23:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1245184; Read time: 0; Write time: 44 11:23:12 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290844672; Read time: 8; Write time: 186724 11:23:12 INFO - Running post-run listener: _upload_blobber_files 11:23:12 INFO - Blob upload gear active. 11:23:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:12 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:12 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:12 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:12 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:13 INFO - (blobuploader) - INFO - Done attempting. 11:23:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:14 INFO - (blobuploader) - INFO - Done attempting. 11:23:14 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:14 INFO - Return code: 0 11:23:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c668a4293d562a45f47a529f521d253385bf32192257824b2b4b7a24267cab1dba8d20d36b11fb372a1344b8cc201a795237ce4f09e77832e4c1b03af0644c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f836c4674e8ea9ed43d535ce12c1dc176793c2e45da8937c38497ee89209074676224d678902bd3cef83672cc03d7a448f6add3f562df7f8345cd030a0366b1f"} 11:23:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:14 INFO - Contents: 11:23:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c668a4293d562a45f47a529f521d253385bf32192257824b2b4b7a24267cab1dba8d20d36b11fb372a1344b8cc201a795237ce4f09e77832e4c1b03af0644c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f836c4674e8ea9ed43d535ce12c1dc176793c2e45da8937c38497ee89209074676224d678902bd3cef83672cc03d7a448f6add3f562df7f8345cd030a0366b1f"} 11:23:14 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:14 INFO - Copying logs to upload dir... 11:23:14 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.370445 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-04-15 11:23:13.952347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:13.955543) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c668a4293d562a45f47a529f521d253385bf32192257824b2b4b7a24267cab1dba8d20d36b11fb372a1344b8cc201a795237ce4f09e77832e4c1b03af0644c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f836c4674e8ea9ed43d535ce12c1dc176793c2e45da8937c38497ee89209074676224d678902bd3cef83672cc03d7a448f6add3f562df7f8345cd030a0366b1f"} 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.011246 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c668a4293d562a45f47a529f521d253385bf32192257824b2b4b7a24267cab1dba8d20d36b11fb372a1344b8cc201a795237ce4f09e77832e4c1b03af0644c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f836c4674e8ea9ed43d535ce12c1dc176793c2e45da8937c38497ee89209074676224d678902bd3cef83672cc03d7a448f6add3f562df7f8345cd030a0366b1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:13.981307) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:13.981697) ========= 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=8c719f637fb0c43bc4e5671e000001d0-1460734990.427608-234553892 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 11:23:14.064732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 11:23:14.065226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 11:23:14.065709) ========= ========= Total master_lag: 0.17 =========