builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-027 starttime: 1469835176.91 results: success (0) buildid: 20160729135425 builduid: 12dba7d178a64792a5a81ee1ed1bb132 revision: 42c3abe40b3bbea3611cde618c150dbff8c68542 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:56.909324) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:56.909840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:56.910144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:56.929160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:56.929476) ========= 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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-29 16:32:57-- 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% 43.1M=0s 2016-07-29 16:32:57 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195805 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:57.139083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:57.139421) ========= 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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:57.189166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 16:32:57.189572) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 42c3abe40b3bbea3611cde618c150dbff8c68542 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 42c3abe40b3bbea3611cde618c150dbff8c68542 --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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-29 16:32:57,345 truncating revision to first 12 chars 2016-07-29 16:32:57,345 Setting DEBUG logging. 2016-07-29 16:32:57,345 attempt 1/10 2016-07-29 16:32:57,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/42c3abe40b3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-29 16:32:58,625 unpacking tar archive at: mozilla-aurora-42c3abe40b3b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624966 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-29 16:32:58.828401) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:58.828748) ========= script_repo_revision: 42c3abe40b3bbea3611cde618c150dbff8c68542 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:58.829181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:58.829467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-29 16:32:58.839193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 16:32:58.839489) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:32:59 INFO - MultiFileLogger online at 20160729 16:32:59 in /builds/slave/test 16:32:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:32:59 INFO - {'append_to_log': False, 16:32:59 INFO - 'base_work_dir': '/builds/slave/test', 16:32:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:32:59 INFO - 'branch': 'Mozilla-Aurora', 16:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:32:59 INFO - 'config_files': ('talos/linux_config.py',), 16:32:59 INFO - 'default_actions': ('clobber', 16:32:59 INFO - 'read-buildbot-config', 16:32:59 INFO - 'download-and-extract', 16:32:59 INFO - 'populate-webroot', 16:32:59 INFO - 'create-virtualenv', 16:32:59 INFO - 'install', 16:32:59 INFO - 'run-tests'), 16:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:32:59 INFO - 'download_minidump_stackwalk': True, 16:32:59 INFO - 'download_symbols': 'ondemand', 16:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:32:59 INFO - 'installer_path': 'installer.exe', 16:32:59 INFO - 'log_level': 'info', 16:32:59 INFO - 'log_name': 'talos', 16:32:59 INFO - 'log_to_console': True, 16:32:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:32:59 INFO - 'opt_config_files': (), 16:32:59 INFO - 'pip_index': False, 16:32:59 INFO - 'sps_profile': False, 16:32:59 INFO - 'sps_profile_interval': 0, 16:32:59 INFO - 'suite': 'dromaeojs-e10s', 16:32:59 INFO - 'system_bits': '32', 16:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:32:59 INFO - 'title': 'talos-linux64-ix-027', 16:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:32:59 INFO - 'use_talos_json': True, 16:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:32:59 INFO - 'work_dir': 'build'} 16:32:59 INFO - ##### 16:32:59 INFO - ##### Running clobber step. 16:32:59 INFO - ##### 16:32:59 INFO - Running pre-action listener: _resource_record_pre_action 16:32:59 INFO - Running main action method: clobber 16:32:59 INFO - rmtree: /builds/slave/test/build 16:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:32:59 INFO - Running post-action listener: _resource_record_post_action 16:32:59 INFO - ##### 16:32:59 INFO - ##### Finished clobber step (success) 16:32:59 INFO - ##### 16:32:59 INFO - ##### 16:32:59 INFO - ##### Running read-buildbot-config step. 16:32:59 INFO - ##### 16:32:59 INFO - Running pre-action listener: _resource_record_pre_action 16:32:59 INFO - Running main action method: read_buildbot_config 16:32:59 INFO - Using buildbot properties: 16:32:59 INFO - { 16:32:59 INFO - "project": "", 16:32:59 INFO - "product": "firefox", 16:32:59 INFO - "script_repo_revision": "production", 16:32:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 16:32:59 INFO - "repository": "", 16:32:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 16:32:59 INFO - "buildid": "20160729135425", 16:32:59 INFO - "pgo_build": "True", 16:32:59 INFO - "basedir": "/builds/slave/test", 16:32:59 INFO - "buildnumber": 474, 16:32:59 INFO - "slavename": "talos-linux64-ix-027", 16:32:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:32:59 INFO - "platform": "ubuntu64_hw", 16:32:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 16:32:59 INFO - "branch": "mozilla-aurora", 16:32:59 INFO - "repo_path": "releases/mozilla-aurora", 16:32:59 INFO - "revision": "42c3abe40b3bbea3611cde618c150dbff8c68542", 16:32:59 INFO - "stage_platform": "linux64-pgo", 16:32:59 INFO - "builduid": "12dba7d178a64792a5a81ee1ed1bb132", 16:32:59 INFO - "slavebuilddir": "test" 16:32:59 INFO - } 16:32:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 16:32:59 INFO - Running post-action listener: _resource_record_post_action 16:32:59 INFO - ##### 16:32:59 INFO - ##### Finished read-buildbot-config step (success) 16:32:59 INFO - ##### 16:32:59 INFO - ##### 16:32:59 INFO - ##### Running download-and-extract step. 16:32:59 INFO - ##### 16:32:59 INFO - Running pre-action listener: _resource_record_pre_action 16:32:59 INFO - Running main action method: download_and_extract 16:32:59 INFO - mkdir: /builds/slave/test/build/tests 16:32: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')]} 16:32:59 INFO - https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:32:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 16:32:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 16:32:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 16:32:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:33:05 INFO - Downloaded 1361 bytes. 16:33:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 16:33:05 INFO - Using the following test package requirements: 16:33:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 16:33:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 16:33:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 16:33:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'jsshell-linux-x86_64.zip'], 16:33:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 16:33:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 16:33:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 16:33:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 16:33:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 16:33:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 16:33:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 16:33:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:05 INFO - https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:33:08 INFO - Downloaded 24493801 bytes. 16:33:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:33:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:33:09 INFO - Return code: 0 16:33:09 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:33: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')]} 16:33:09 INFO - https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:33:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 16:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:33:14 INFO - Downloaded 24493801 bytes. 16:33:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:33:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:33:16 INFO - Return code: 0 16:33: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')]} 16:33:16 INFO - https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:33:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 16:33:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 16:33:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 16:33:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:33:17 INFO - Downloaded 10833369 bytes. 16:33:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:33:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 16:33:17 INFO - Return code: 0 16:33:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:17 INFO - https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:33:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 16:33:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 16:33:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 16:33:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:33:18 INFO - Downloaded 63645120 bytes. 16:33:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 16:33:18 INFO - mkdir: /builds/slave/test/properties 16:33:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:33:18 INFO - Writing to file /builds/slave/test/properties/build_url 16:33:18 INFO - Contents: 16:33:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 16:33:19 INFO - Running post-action listener: _resource_record_post_action 16:33:19 INFO - Running post-action listener: set_extra_try_arguments 16:33:19 INFO - ##### 16:33:19 INFO - ##### Finished download-and-extract step (success) 16:33:19 INFO - ##### 16:33:19 INFO - ##### 16:33:19 INFO - ##### Running populate-webroot step. 16:33:19 INFO - ##### 16:33:19 INFO - Running pre-action listener: _resource_record_pre_action 16:33:19 INFO - Running main action method: populate_webroot 16:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:33:19 INFO - '--tppagecycles', 16:33:19 INFO - '7'], 16:33:19 INFO - 'tests': ['tsvgm']}}, 16:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:33:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:33:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['damp', 'tps']}, 16:33:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'tests': ['damp', 'tps']}, 16:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['dromaeo_dom']}, 16:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['a11yr', 16:33:19 INFO - 'ts_paint', 16:33:19 INFO - 'tpaint', 16:33:19 INFO - 'sessionrestore', 16:33:19 INFO - 'sessionrestore_no_auto_restore', 16:33:19 INFO - 'tabpaint']}, 16:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['tsvgx', 16:33:19 INFO - 'tsvgr_opacity', 16:33:19 INFO - 'tart', 16:33:19 INFO - 'tscrollx', 16:33:19 INFO - 'cart']}, 16:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:33:19 INFO - 'tsvgr_opacity', 16:33:19 INFO - 'tart', 16:33:19 INFO - 'tscrollx', 16:33:19 INFO - 'cart']}, 16:33:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'talos_options': ['--disable-e10s'], 16:33:19 INFO - 'tests': ['tp5o']}, 16:33:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'tests': ['tp5o']}, 16:33:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'talos_options': ['--disable-e10s', 16:33:19 INFO - '--xperf_path', 16:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:19 INFO - 'tests': ['tp5n']}, 16:33:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:33:19 INFO - 'talos_options': ['--xperf_path', 16:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:33:19 INFO - 'tests': ['tp5n']}}, 16:33:19 INFO - 'talos.zip': {'path': '', 16:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:33:19 INFO - Running post-action listener: _resource_record_post_action 16:33:19 INFO - ##### 16:33:19 INFO - ##### Finished populate-webroot step (success) 16:33:19 INFO - ##### 16:33:19 INFO - ##### 16:33:19 INFO - ##### Running create-virtualenv step. 16:33:19 INFO - ##### 16:33:19 INFO - Running pre-action listener: _resource_record_pre_action 16:33:19 INFO - Running main action method: create_virtualenv 16:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 16:33:19 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 16:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:33:19 INFO - Using real prefix '/usr' 16:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 16:33:22 INFO - Installing pip.................done. 16:33:22 INFO - Return code: 0 16:33:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:33:22 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')]} 16:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:22 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')]} 16:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:22 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:22 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 16:33:22 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 16:33:22 INFO - Using env: {'DISPLAY': ':0', 16:33:22 INFO - 'HOME': '/home/cltbld', 16:33:22 INFO - 'LANG': 'en_US.UTF-8', 16:33:22 INFO - 'LANGUAGE': 'en_US:en', 16:33:22 INFO - 'LOGNAME': 'cltbld', 16:33:22 INFO - 'MAIL': '/var/mail/cltbld', 16:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:22 INFO - 'MOZ_NO_REMOTE': '1', 16:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:22 INFO - 'NO_EM_RESTART': '1', 16:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:22 INFO - 'PWD': '/builds/slave/test', 16:33:22 INFO - 'SHELL': '/bin/bash', 16:33:22 INFO - 'SHLVL': '1', 16:33:22 INFO - 'TERM': 'linux', 16:33:22 INFO - 'TMOUT': '86400', 16:33:22 INFO - 'USER': 'cltbld', 16:33:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:22 INFO - '_': '/tools/buildbot/bin/python'} 16:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:22 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 16:33:22 INFO - Cleaning up... 16:33:22 INFO - Return code: 0 16:33:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:33:22 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')]} 16:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:22 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')]} 16:33:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:22 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:22 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>=3.1.1'] in /builds/slave/test/build 16:33:22 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>=3.1.1 16:33:22 INFO - Using env: {'DISPLAY': ':0', 16:33:22 INFO - 'HOME': '/home/cltbld', 16:33:22 INFO - 'LANG': 'en_US.UTF-8', 16:33:22 INFO - 'LANGUAGE': 'en_US:en', 16:33:22 INFO - 'LOGNAME': 'cltbld', 16:33:22 INFO - 'MAIL': '/var/mail/cltbld', 16:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:22 INFO - 'MOZ_NO_REMOTE': '1', 16:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:22 INFO - 'NO_EM_RESTART': '1', 16:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:22 INFO - 'PWD': '/builds/slave/test', 16:33:22 INFO - 'SHELL': '/bin/bash', 16:33:22 INFO - 'SHLVL': '1', 16:33:22 INFO - 'TERM': 'linux', 16:33:22 INFO - 'TMOUT': '86400', 16:33:22 INFO - 'USER': 'cltbld', 16:33:22 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:22 INFO - '_': '/tools/buildbot/bin/python'} 16:33:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:22 INFO - Downloading/unpacking psutil>=3.1.1 16:33:22 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 16:33:22 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 16:33:22 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 16:33:22 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 16:33:22 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 16:33:22 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 16:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:33:24 INFO - Installing collected packages: psutil 16:33:24 INFO - Running setup.py install for psutil 16:33:24 INFO - building 'psutil._psutil_linux' extension 16:33:24 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 16:33:25 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 16:33:25 INFO - building 'psutil._psutil_posix' extension 16:33:25 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 16:33:25 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 16:33:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:33:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:33:25 INFO - Successfully installed psutil 16:33:25 INFO - Cleaning up... 16:33:25 INFO - Return code: 0 16:33:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:33:25 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')]} 16:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:25 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')]} 16:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:25 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:25 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.3'] in /builds/slave/test/build 16:33:25 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.3 16:33:25 INFO - Using env: {'DISPLAY': ':0', 16:33:25 INFO - 'HOME': '/home/cltbld', 16:33:25 INFO - 'LANG': 'en_US.UTF-8', 16:33:25 INFO - 'LANGUAGE': 'en_US:en', 16:33:25 INFO - 'LOGNAME': 'cltbld', 16:33:25 INFO - 'MAIL': '/var/mail/cltbld', 16:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:25 INFO - 'MOZ_NO_REMOTE': '1', 16:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:25 INFO - 'NO_EM_RESTART': '1', 16:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:25 INFO - 'PWD': '/builds/slave/test', 16:33:25 INFO - 'SHELL': '/bin/bash', 16:33:25 INFO - 'SHLVL': '1', 16:33:25 INFO - 'TERM': 'linux', 16:33:25 INFO - 'TMOUT': '86400', 16:33:25 INFO - 'USER': 'cltbld', 16:33:25 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:25 INFO - '_': '/tools/buildbot/bin/python'} 16:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:33:25 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 16:33:25 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 16:33:25 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 16:33:25 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 16:33:25 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 16:33:25 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 16:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:33:27 INFO - Installing collected packages: mozsystemmonitor 16:33:27 INFO - Running setup.py install for mozsystemmonitor 16:33:27 INFO - Successfully installed mozsystemmonitor 16:33:27 INFO - Cleaning up... 16:33:27 INFO - Return code: 0 16:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:33:27 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')]} 16:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:27 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')]} 16:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:27 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:27 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==2.5.1'] in /builds/slave/test/build 16:33:27 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==2.5.1 16:33:27 INFO - Using env: {'DISPLAY': ':0', 16:33:27 INFO - 'HOME': '/home/cltbld', 16:33:27 INFO - 'LANG': 'en_US.UTF-8', 16:33:27 INFO - 'LANGUAGE': 'en_US:en', 16:33:27 INFO - 'LOGNAME': 'cltbld', 16:33:27 INFO - 'MAIL': '/var/mail/cltbld', 16:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:27 INFO - 'MOZ_NO_REMOTE': '1', 16:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:27 INFO - 'NO_EM_RESTART': '1', 16:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:27 INFO - 'PWD': '/builds/slave/test', 16:33:27 INFO - 'SHELL': '/bin/bash', 16:33:27 INFO - 'SHLVL': '1', 16:33:27 INFO - 'TERM': 'linux', 16:33:27 INFO - 'TMOUT': '86400', 16:33:27 INFO - 'USER': 'cltbld', 16:33:27 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:27 INFO - '_': '/tools/buildbot/bin/python'} 16:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:33:27 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 16:33:27 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 16:33:27 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 16:33:27 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 16:33:27 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 16:33:27 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 16:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:33:30 INFO - warning: no files found matching '*.txt' 16:33:30 INFO - no previously-included directories found matching 'build' 16:33:30 INFO - no previously-included directories found matching 'dist' 16:33:30 INFO - no previously-included directories found matching '.git*' 16:33:30 INFO - Installing collected packages: jsonschema, functools32 16:33:30 INFO - Running setup.py install for functools32 16:33:30 INFO - warning: no files found matching '*.txt' 16:33:30 INFO - no previously-included directories found matching 'build' 16:33:30 INFO - no previously-included directories found matching 'dist' 16:33:30 INFO - no previously-included directories found matching '.git*' 16:33:30 INFO - Successfully installed jsonschema functools32 16:33:30 INFO - Cleaning up... 16:33:30 INFO - Return code: 0 16:33:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:33:30 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')]} 16:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:30 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')]} 16:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:30 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:30 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 16:33:30 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 16:33:30 INFO - Using env: {'DISPLAY': ':0', 16:33:30 INFO - 'HOME': '/home/cltbld', 16:33:30 INFO - 'LANG': 'en_US.UTF-8', 16:33:30 INFO - 'LANGUAGE': 'en_US:en', 16:33:30 INFO - 'LOGNAME': 'cltbld', 16:33:30 INFO - 'MAIL': '/var/mail/cltbld', 16:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:30 INFO - 'MOZ_NO_REMOTE': '1', 16:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:30 INFO - 'NO_EM_RESTART': '1', 16:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:30 INFO - 'PWD': '/builds/slave/test', 16:33:30 INFO - 'SHELL': '/bin/bash', 16:33:30 INFO - 'SHLVL': '1', 16:33:30 INFO - 'TERM': 'linux', 16:33:30 INFO - 'TMOUT': '86400', 16:33:30 INFO - 'USER': 'cltbld', 16:33:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:30 INFO - '_': '/tools/buildbot/bin/python'} 16:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:33:30 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 16:33:30 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 16:33:30 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 16:33:30 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 16:33:30 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 16:33:30 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 16:33:32 INFO - Downloading blobuploader-1.2.4.tar.gz 16:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:33:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:33:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:33:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:33:33 INFO - Downloading docopt-0.6.1.tar.gz 16:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:33:33 INFO - Installing collected packages: blobuploader, requests, docopt 16:33:33 INFO - Running setup.py install for blobuploader 16:33:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:33:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:33:33 INFO - Running setup.py install for requests 16:33:33 INFO - Running setup.py install for docopt 16:33:33 INFO - Successfully installed blobuploader requests docopt 16:33:33 INFO - Cleaning up... 16:33:33 INFO - Return code: 0 16:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:33 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')]} 16:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:33 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')]} 16:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:33 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:33 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 16:33:33 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 16:33:33 INFO - Using env: {'DISPLAY': ':0', 16:33:33 INFO - 'HOME': '/home/cltbld', 16:33:33 INFO - 'LANG': 'en_US.UTF-8', 16:33:33 INFO - 'LANGUAGE': 'en_US:en', 16:33:33 INFO - 'LOGNAME': 'cltbld', 16:33:33 INFO - 'MAIL': '/var/mail/cltbld', 16:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:33 INFO - 'MOZ_NO_REMOTE': '1', 16:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:33 INFO - 'NO_EM_RESTART': '1', 16:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:33 INFO - 'PWD': '/builds/slave/test', 16:33:33 INFO - 'SHELL': '/bin/bash', 16:33:33 INFO - 'SHLVL': '1', 16:33:33 INFO - 'TERM': 'linux', 16:33:33 INFO - 'TMOUT': '86400', 16:33:33 INFO - 'USER': 'cltbld', 16:33:33 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:33 INFO - '_': '/tools/buildbot/bin/python'} 16:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:33 INFO - Running setup.py (path:/tmp/pip-naeL2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:33 INFO - Running setup.py (path:/tmp/pip-xRINrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:34 INFO - Running setup.py (path:/tmp/pip-gsQ71s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:34 INFO - Running setup.py (path:/tmp/pip-5c5_sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:34 INFO - Running setup.py (path:/tmp/pip-GvaNOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:34 INFO - Running setup.py (path:/tmp/pip-Fluilv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:34 INFO - Running setup.py (path:/tmp/pip-vstmbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:34 INFO - Running setup.py (path:/tmp/pip-PyXZhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:34 INFO - Running setup.py (path:/tmp/pip-LUCpp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:34 INFO - Running setup.py (path:/tmp/pip-ujyWsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:34 INFO - Running setup.py (path:/tmp/pip-kKt1Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:34 INFO - Running setup.py (path:/tmp/pip-Yxyrfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:34 INFO - Running setup.py (path:/tmp/pip-qmEcOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:34 INFO - Running setup.py (path:/tmp/pip-up5MAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:34 INFO - Running setup.py (path:/tmp/pip-BwuLsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:34 INFO - Running setup.py (path:/tmp/pip-CxqCEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:35 INFO - Running setup.py (path:/tmp/pip-5xCOMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:33:35 INFO - Running setup.py install for manifestparser 16:33:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Running setup.py install for mozcrash 16:33:35 INFO - Running setup.py install for mozdebug 16:33:35 INFO - Running setup.py install for mozdevice 16:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Running setup.py install for mozfile 16:33:35 INFO - Running setup.py install for mozhttpd 16:33:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Running setup.py install for mozinfo 16:33:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Running setup.py install for mozInstall 16:33:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:33:35 INFO - Running setup.py install for mozleak 16:33:36 INFO - Running setup.py install for mozlog 16:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Running setup.py install for moznetwork 16:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Running setup.py install for mozprocess 16:33:36 INFO - Running setup.py install for mozprofile 16:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Running setup.py install for mozrunner 16:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Running setup.py install for mozscreenshot 16:33:36 INFO - Running setup.py install for moztest 16:33:36 INFO - Running setup.py install for mozversion 16:33:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:33:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:33:36 INFO - Cleaning up... 16:33:36 INFO - Return code: 0 16:33:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:36 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:36 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 16:33:36 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 16:33:36 INFO - Using env: {'DISPLAY': ':0', 16:33:36 INFO - 'HOME': '/home/cltbld', 16:33:36 INFO - 'LANG': 'en_US.UTF-8', 16:33:36 INFO - 'LANGUAGE': 'en_US:en', 16:33:36 INFO - 'LOGNAME': 'cltbld', 16:33:36 INFO - 'MAIL': '/var/mail/cltbld', 16:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:36 INFO - 'MOZ_NO_REMOTE': '1', 16:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:36 INFO - 'NO_EM_RESTART': '1', 16:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:36 INFO - 'PWD': '/builds/slave/test', 16:33:36 INFO - 'SHELL': '/bin/bash', 16:33:36 INFO - 'SHLVL': '1', 16:33:36 INFO - 'TERM': 'linux', 16:33:36 INFO - 'TMOUT': '86400', 16:33:36 INFO - 'USER': 'cltbld', 16:33:36 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:36 INFO - '_': '/tools/buildbot/bin/python'} 16:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:33:37 INFO - Running setup.py (path:/tmp/pip-ZjzCpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:33:37 INFO - Running setup.py (path:/tmp/pip-DExpW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:33:37 INFO - Running setup.py (path:/tmp/pip-BXq4zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:33:37 INFO - Running setup.py (path:/tmp/pip-Yvqhf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:33:37 INFO - Running setup.py (path:/tmp/pip-bNgpNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:33:37 INFO - Running setup.py (path:/tmp/pip-DxN7f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:33:37 INFO - Running setup.py (path:/tmp/pip-CWA2mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:33:37 INFO - Running setup.py (path:/tmp/pip-qn6AY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:33:37 INFO - Running setup.py (path:/tmp/pip-xJDzr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:33:37 INFO - Running setup.py (path:/tmp/pip-5toqqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:33:37 INFO - Running setup.py (path:/tmp/pip-EaCr2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:33:37 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)) 16:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:33:37 INFO - Running setup.py (path:/tmp/pip-FHC7ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:33:38 INFO - Running setup.py (path:/tmp/pip-MD46Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:33:38 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)) 16:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:33:38 INFO - Running setup.py (path:/tmp/pip-gUkf1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:38 INFO - Running setup.py (path:/tmp/pip-smB2eO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:33:38 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)) 16:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:33:38 INFO - Running setup.py (path:/tmp/pip-53CYXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:33:38 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)) 16:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:33:38 INFO - Running setup.py (path:/tmp/pip-dIxBe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:33:38 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)) 16:33:38 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)) 16:33:38 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)) 16:33:38 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)) 16:33:38 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)) 16:33:38 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)) 16:33:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:33:38 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 16:33:38 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 16:33:38 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 16:33:38 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 16:33:38 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 16:33:38 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 16:33:40 INFO - Downloading blessings-1.6.tar.gz 16:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:33:40 INFO - Installing collected packages: blessings 16:33:40 INFO - Running setup.py install for blessings 16:33:40 INFO - Successfully installed blessings 16:33:40 INFO - Cleaning up... 16:33:40 INFO - Return code: 0 16:33:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:33:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:40 INFO - Reading from file tmpfile_stdout 16:33:40 INFO - Current package versions: 16:33:40 INFO - argparse == 1.2.1 16:33:40 INFO - blessings == 1.6 16:33:40 INFO - blobuploader == 1.2.4 16:33:40 INFO - docopt == 0.6.1 16:33:40 INFO - functools32 == 3.2.3-2 16:33:40 INFO - jsonschema == 2.5.1 16:33:40 INFO - manifestparser == 1.1 16:33:40 INFO - mozInstall == 1.12 16:33:40 INFO - mozcrash == 0.17 16:33:40 INFO - mozdebug == 0.1 16:33:40 INFO - mozdevice == 0.48 16:33:40 INFO - mozfile == 1.2 16:33:40 INFO - mozhttpd == 0.7 16:33:40 INFO - mozinfo == 0.9 16:33:40 INFO - mozleak == 0.1 16:33:40 INFO - mozlog == 3.2 16:33:40 INFO - moznetwork == 0.27 16:33:40 INFO - mozprocess == 0.23 16:33:40 INFO - mozprofile == 0.28 16:33:40 INFO - mozrunner == 6.12 16:33:40 INFO - mozscreenshot == 0.1 16:33:40 INFO - mozsystemmonitor == 0.3 16:33:40 INFO - moztest == 0.7 16:33:40 INFO - mozversion == 1.4 16:33:40 INFO - psutil == 3.1.1 16:33:40 INFO - requests == 1.2.3 16:33:40 INFO - wsgiref == 0.1.2 16:33:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:40 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:40 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 16:33:40 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 16:33:40 INFO - Using env: {'DISPLAY': ':0', 16:33:40 INFO - 'HOME': '/home/cltbld', 16:33:40 INFO - 'LANG': 'en_US.UTF-8', 16:33:40 INFO - 'LANGUAGE': 'en_US:en', 16:33:40 INFO - 'LOGNAME': 'cltbld', 16:33:40 INFO - 'MAIL': '/var/mail/cltbld', 16:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:40 INFO - 'MOZ_NO_REMOTE': '1', 16:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:40 INFO - 'NO_EM_RESTART': '1', 16:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:40 INFO - 'PWD': '/builds/slave/test', 16:33:40 INFO - 'SHELL': '/bin/bash', 16:33:40 INFO - 'SHLVL': '1', 16:33:40 INFO - 'TERM': 'linux', 16:33:40 INFO - 'TMOUT': '86400', 16:33:40 INFO - 'USER': 'cltbld', 16:33:40 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:40 INFO - '_': '/tools/buildbot/bin/python'} 16:33:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 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)) 16:33:40 INFO - Cleaning up... 16:33:40 INFO - Return code: 0 16:33:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:40 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:40 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 16:33:40 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 16:33:40 INFO - Using env: {'DISPLAY': ':0', 16:33:40 INFO - 'HOME': '/home/cltbld', 16:33:40 INFO - 'LANG': 'en_US.UTF-8', 16:33:40 INFO - 'LANGUAGE': 'en_US:en', 16:33:40 INFO - 'LOGNAME': 'cltbld', 16:33:40 INFO - 'MAIL': '/var/mail/cltbld', 16:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:40 INFO - 'MOZ_NO_REMOTE': '1', 16:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:41 INFO - 'NO_EM_RESTART': '1', 16:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:41 INFO - 'PWD': '/builds/slave/test', 16:33:41 INFO - 'SHELL': '/bin/bash', 16:33:41 INFO - 'SHLVL': '1', 16:33:41 INFO - 'TERM': 'linux', 16:33:41 INFO - 'TMOUT': '86400', 16:33:41 INFO - 'USER': 'cltbld', 16:33:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:41 INFO - '_': '/tools/buildbot/bin/python'} 16:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:33:41 INFO - Cleaning up... 16:33:41 INFO - Return code: 0 16:33:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:33:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:33:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:33:41 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 0x7ffe298b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x288e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, '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': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', '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 16:33:41 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 16:33:41 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 16:33:41 INFO - Using env: {'DISPLAY': ':0', 16:33:41 INFO - 'HOME': '/home/cltbld', 16:33:41 INFO - 'LANG': 'en_US.UTF-8', 16:33:41 INFO - 'LANGUAGE': 'en_US:en', 16:33:41 INFO - 'LOGNAME': 'cltbld', 16:33:41 INFO - 'MAIL': '/var/mail/cltbld', 16:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:33:41 INFO - 'MOZ_NO_REMOTE': '1', 16:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:33:41 INFO - 'NO_EM_RESTART': '1', 16:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:33:41 INFO - 'PWD': '/builds/slave/test', 16:33:41 INFO - 'SHELL': '/bin/bash', 16:33:41 INFO - 'SHLVL': '1', 16:33:41 INFO - 'TERM': 'linux', 16:33:41 INFO - 'TMOUT': '86400', 16:33:41 INFO - 'USER': 'cltbld', 16:33:41 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:33:41 INFO - '_': '/tools/buildbot/bin/python'} 16:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:33:41 INFO - Downloading/unpacking flake8 16:33:41 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 16:33:41 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 16:33:41 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 16:33:41 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 16:33:41 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 16:33:41 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 16:33:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:33:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:33:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 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 16:33:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:33:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:33:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:33:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:33:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:33:44 INFO - no previously-included directories found matching 'docs/_build' 16:33:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:33:44 INFO - Running setup.py install for pep8 16:33:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:33:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:33:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:33:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:33:44 INFO - no previously-included directories found matching 'docs/_build' 16:33:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:33:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:33:44 INFO - Cleaning up... 16:33:44 INFO - Return code: 0 16:33:44 INFO - Running post-action listener: _resource_record_post_action 16:33:44 INFO - Running post-action listener: _start_resource_monitoring 16:33:44 INFO - Starting resource monitoring. 16:33:44 INFO - ##### 16:33:44 INFO - ##### Finished create-virtualenv step (success) 16:33:44 INFO - ##### 16:33:44 INFO - ##### 16:33:44 INFO - ##### Running install step. 16:33:44 INFO - ##### 16:33:44 INFO - Running pre-action listener: _resource_record_pre_action 16:33:44 INFO - Running main action method: install 16:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:33:44 INFO - Reading from file tmpfile_stdout 16:33:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:33:44 INFO - Reading from file tmpfile_stdout 16:33:44 INFO - Output received: 16:33:44 INFO - Usage: mozinstall [options] installer 16:33:44 INFO - Options: 16:33:44 INFO - -h, --help show this help message and exit 16:33:44 INFO - -d DEST, --destination=DEST 16:33:44 INFO - Directory to install application into. [default: 16:33:44 INFO - "/builds/slave/test"] 16:33:44 INFO - --app=APP Application being installed. [default: firefox] 16:33:44 INFO - mkdir: /builds/slave/test/build/application 16:33:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:33:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:34:00 INFO - Reading from file tmpfile_stdout 16:34:00 INFO - Output received: 16:34:00 INFO - /builds/slave/test/build/application/firefox/firefox 16:34:00 INFO - Running post-action listener: _resource_record_post_action 16:34:00 INFO - ##### 16:34:00 INFO - ##### Finished install step (success) 16:34:00 INFO - ##### 16:34:00 INFO - ##### 16:34:00 INFO - ##### Running run-tests step. 16:34:00 INFO - ##### 16:34:00 INFO - Running pre-action listener: _resource_record_pre_action 16:34:00 INFO - Running main action method: run_tests 16:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:34:00 INFO - Python 2.7.3 16:34:00 INFO - Return code: 0 16:34:00 INFO - grabbing minidump binary from tooltool 16:34:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:34:00 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29202e0>, '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 0x288c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x288c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:34:00 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 16:34:00 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 16:34:00 INFO - Calling ['/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'] with output_timeout 600 16:34:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:34:00 INFO - Return code: 0 16:34:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:34:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:34:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:34:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:34:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:34:01 INFO - Return code: 0 16:34:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:34:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 16:34:01 INFO - Using env: {'DISPLAY': ':0', 16:34:01 INFO - 'HOME': '/home/cltbld', 16:34:01 INFO - 'LANG': 'en_US.UTF-8', 16:34:01 INFO - 'LANGUAGE': 'en_US:en', 16:34:01 INFO - 'LOGNAME': 'cltbld', 16:34:01 INFO - 'MAIL': '/var/mail/cltbld', 16:34:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:34:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:34:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:34:01 INFO - 'MOZ_NO_REMOTE': '1', 16:34:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:34:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:34:01 INFO - 'NO_EM_RESTART': '1', 16:34:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:34:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:34:01 INFO - 'PWD': '/builds/slave/test', 16:34:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:34:01 INFO - 'SHELL': '/bin/bash', 16:34:01 INFO - 'SHLVL': '1', 16:34:01 INFO - 'TERM': 'linux', 16:34:01 INFO - 'TMOUT': '86400', 16:34:01 INFO - 'USER': 'cltbld', 16:34:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968', 16:34:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:34:01 INFO - '_': '/tools/buildbot/bin/python'} 16:34:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 16:34:01 INFO - mozversion application_buildid: 20160729135425 16:34:01 INFO - mozversion application_changeset: 42c3abe40b3bbea3611cde618c150dbff8c68542 16:34:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:34:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:34:01 INFO - mozversion application_name: Firefox 16:34:01 INFO - mozversion application_remotingname: firefox-dev 16:34:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:34:01 INFO - mozversion application_vendor: Mozilla 16:34:01 INFO - mozversion application_version: 49.0a2 16:34:01 INFO - mozversion platform_buildid: 20160729135425 16:34:01 INFO - mozversion platform_changeset: 42c3abe40b3bbea3611cde618c150dbff8c68542 16:34:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:34:01 INFO - mozversion platform_version: 49.0a2 16:34:01 INFO - using testdate: 1469835241 16:34:01 INFO - actual date: 1469835241 16:34:01 INFO - starting webserver on 'localhost:57939' 16:34:01 INFO - SUITE-START | Running 2 tests 16:34:01 INFO - TEST-START | dromaeo_css 16:34:01 INFO - operating with platform_type : linux_ 16:34:01 INFO - Initialising browser for dromaeo_css test... 16:34:01 INFO - TEST-INFO | started process 1385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVj7o4/profile http://localhost:57939/getInfo.html) 16:34:05 INFO - PROCESS | 1385 | __metrics Screen width/height:1600/1200 16:34:05 INFO - PROCESS | 1385 | colorDepth:24 16:34:05 INFO - PROCESS | 1385 | Browser inner width/height: 1024/697 16:34:05 INFO - PROCESS | 1385 | __metrics 16:34:06 ERROR - PROCESS | 1385 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:34:07 INFO - TEST-INFO | 1385: exit 0 16:34:07 INFO - Browser initialized. 16:34:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:34:07 INFO - TEST-INFO | started process 1515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVj7o4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:34:19 INFO - PROCESS | 1515 | RSS: Main: 156061696 16:34:19 INFO - PROCESS | 1515 | 16:35:08 INFO - PROCESS | 1515 | 1469835308830 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] 16:37:16 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57939/tests/dromaeo/cssquery-ext.html) 16:37:17 INFO - PROCESS | 1515 | RSS: Main: 159944704 16:37:17 INFO - PROCESS | 1515 | 16:40:19 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-ext.html (next: http://localhost:57939/tests/dromaeo/cssquery-jquery.html) 16:40:20 INFO - PROCESS | 1515 | RSS: Main: 158019584 16:40:20 INFO - PROCESS | 1515 | 16:43:21 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57939/tests/dromaeo/cssquery-mootools.html) 16:43:22 INFO - PROCESS | 1515 | RSS: Main: 157818880 16:43:22 INFO - PROCESS | 1515 | 16:46:24 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57939/tests/dromaeo/cssquery-prototype.html) 16:46:24 INFO - PROCESS | 1515 | RSS: Main: 157024256 16:46:24 INFO - PROCESS | 1515 | 16:49:27 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57939/tests/dromaeo/cssquery-yui.html) 16:49:27 INFO - PROCESS | 1515 | RSS: Main: 158953472 16:49:27 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | Cycle 1(1): loaded http://localhost:57939/tests/dromaeo/cssquery-yui.html (next: http://localhost:57939/tests/dromaeo/cssquery-dojo.html) 16:52:30 INFO - PROCESS | 1515 | RSS: Main: 159141888 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | __start_tp_report 16:52:30 INFO - PROCESS | 1515 | _x_x_mozilla_page_load 16:52:30 INFO - PROCESS | 1515 | _x_x_mozilla_page_load_details 16:52:30 INFO - PROCESS | 1515 | |i|pagename|runs| 16:52:30 INFO - PROCESS | 1515 | |0;dojo.html;3302.2074702071504;3309.189248634085;3317.1541256979467;3333.1833700743323;3334.9661604902467;5444.646098003627;5450.836474905749;5456.208849716793;5488.149336852789;5499.202615620733;5512.834614961547;5515.896820635869;5528.226048353234;5572.192032155345;5583.776648934037;5009.248612708096;5075.720835354054;5135.614828887829;5153.020926024044;5176.171812509999;5012.9749351253195;5029.220470827027;5076.822311219108;5113.309703190078;5156.690598564098;5019.924701129486;5050.570701490359;5077.847664570068;5134.794608215667;5151.845444636667;5128.71792051437;5204.479552044803;5209.7134657593815;5213.139831927746;5262.631615786897;4916.115099282128;5115.079285728568;5123.89836185222;5171;5189.040027594907;5301.628885977983;5366.409694933554;5395.136778115522;5396.946030539683;5444.265024221759;5870.3249126350165;5903;5909.586328956974;5915.704214789286;5916.526677865761;5857.70711464425;5962.373950735154;5967.104934259895;5967.49276311514;5976.671283079429;5606.971965140148;5653.802116925888;5658.971705141448;5666.858328541819;5678.148277758328;6144.692765361714;6194;6194.5973511721595;6204.255489341308;6204.689765511796;5638.041532939328;5800.0429929062075;5811.912821307684;5902.822915312548;5933.288005439289;5974.701264936736;5982.910256346158;5984.431479009487;5994.9700251499335;6017.428344307284;5897.115432685132;5924.4667979882015;5952.7321270542925;5958.791442299499;5983.581149319593;5764.827055188351;5870.26621672291;5873.706314684248;5906.822795316148;5986.311574168939;4560.908781824345;4573.977130114395;4578.40480737502;4600.516945720651;4607.331936869202;4091.672666186698;4099.631033207026;4120.237756015147;4125.587441255911;4140.60664236897;5613.186088017214;5654.151877218368;5659.264295641623;5720.056190728566;5768.682722450221;5882.823515294548;5917.260342457193;5930.733117009745;5943.55423343251;5944.078667806497;5657.971710141505;5710.5717071219;5723.313202415654;5750.827475175752;5761.107028410603;5079.492050794965;5102.413222479462;5160.509751573594;5160.767765450489;5164.070467315919;6186.81439556814;6312.8421789454715;6341.8097457076365;6345.524085693592;6360.109584658151;6063.999999999912;6084.847878802888;6091.238595175603;6112.969435152796;6114.908276375947;6081.27024757032;6123.892747182756;6134.130457564626;6263.718132684131;6300.558960872695;5891.587588868738;5911.881762364815;5912.260967379078;5958.463738263577;5970.791022314198;5986.461218490357;6032.065029920369;6042.0332746760305;6045.697715114139;6048.243969503812;5668.744906479301;5677.886442271214;5680.545556355564;5700.201971723879;5837.620554663933;5720.056190728649;5726.312842458931;5729.2551968245525;5736.913946290892;5744.3681195067675;5572.3034620672415;5652.830415087554;5658.603897727285;5663.1788390682295;5672.2342483765815;5779.162021506942;5792.884142317214;5796.59423840344;5889.499392551681;5931.051031834886;5793.623414478046;5807.593468457168;5827.76688932438;5832.300123984979;5832.3292821326095 16:52:30 INFO - PROCESS | 1515 | |1;ext.html;600.6966481926629;629.5089829932652;651.9804405867823;660.8645227728315;673.7473447457204;40775.38836917445;45998;46154;46260.07479850405;46403.30395044073;45863.77068114655;46087.539124608746;46240.3063954041;46287.84280392984;46363.768181159045;8836.116388361177;8940.150685684883;9001.77495562613;9014.053524379944;9016.459012459241;8841.425307355;8913.153250441197;8944.8658270126;8948;8975.730728078168;8912;8917.95541022294;8968.730938071836;8971.596278167499;8980.416272942239;8862.556872156367;8870.112988701143;8907.465552066897;8909.910900891005;8965.64137434505;8863.2466240369;8922;8937.240334571568;8941.955290223572;8947.552622368856;42981.14037719259;43309;43526;43539.346909796375;43540.3468947966;3827.4067519534515;3916.706247031484;3939.5863434339267;4384.298512238027;4692;33984.49023264653;34312;34511;34551.82724086389;34811;4729.858104256878;4730;4792.664513484057;4845.297431872394;4931.65478416511;343432;348099.2595037034;351902;353822;355772;62929.37070629235;62957;62997.68501157465;63470.36529634737;63515;38849.80575097106;40024.59975400267;40124.79937600352;42440.57559424428;42454.363184552254;17832.3758668446;18109;18119.36582219616;18127.63744725098;18161.45515634533;13400.798988015187;13557.932210338886;13563.186208827501;13564.864351356557;13611.52359667407;21189.15243390278;21235.362939111852;21247;21329.466763331042;21374.358769236947;7121.359077683033;7140;7406.629668516553;7426.5915374654915;7465.738699145504;951.4766878216954;1052.5631862777016;1160.988390116105;1162.2213117211488;1240.2388608176411;34181;35319.11702207466;36933;37223.62776372256;37932.43101353482;1113.560143743233;1149.9942500287445;1169.1231576317762;1213.8239955206445;1234.5248126523986;17255.137243137793;17376.478705638852;17555.648887022187;17604.207810648553;17813.46559603214;293500;626729;958265;978280;978964;60021;60667.39332606706;60729;60772;60832.695836521416;1467.985320146785;1474.6681996550906;1506.623344163959;1509.4641402302245;1518.681076973848;32057.839710801298;32509;32669.346613068083;33080.33839323152;33825.830870845486;51871.481285186666;52167.73916130395;52755.736221320185;52871.735641321546;52924.47075529196;430061;431053;431070;433652;434443;30070;30132.849335754057;30134.246643834078;30305.84847075839;30641.387172256877;48652.75673621609;48719.5128048715;49095.754521227165;49291;49555.25667114924;42020.78989605032;42392.576074240096;42492.362614561425;42591.14817703567;43636.34545481884;40130.39804402995;41273.587264126974;41479;41667;41760.37359439672;40395.1920961585;41123.1775364497;41390.37914431346;41572.79213603913;42124.368134478624;36488.45267321046;36528.45207321839;36599.08502287464;37106.25787484289;37325.253494929406;27823.721762782112;28691.426171476036;29033.7096629031;29054.418911622073;30721 16:52:30 INFO - PROCESS | 1515 | |2;jquery.html;415.5864914410162;415.99376009359844;420.23517198698363;424.7897290841033;431.9265724826779;19390.612187756255;19485.123169457354;20147.798522014775;20536;20680.069396877137;18419.90790046048;18920.432387028377;18959.62080758384;19061.04694765263;19569.315073972415;5050.242463630448;5367.221752845835;5373.328333958255;5396.811111611094;5439.48324909133;5179.223116532513;5335.1197052486295;5417.864553386157;5423.349198096214;5427.864303392407;5437.564994800407;5437.755301011464;5445.237666726642;5448.237246785453;5466.262054622614;5297.788088476456;5412.4858138476975;5511.696856672881;5529.281193444866;5538.363088244822;5275.076861549213;5326.92009619856;5374.4625537445945;5377.247185394048;5387.326584176978;15159.62100947474;18319.90080595155;19338.613227735506;23868;23980;2380.6071998120287;2402.4594466244953;2426.733059363469;2434.050720219116;2478.0954951442595;10496.895031049668;10507.737306567396;10553.155747540179;11031.172662050298;11535.884641153565;2050.8872012039333;2072.171131547378;2076.3148161106797;2116.9364919052455;2147.9463013424634;72222.27777722209;84808;86226.56886715526;88842;90112;11071.225014249087;11713.355765432983;11844.763104737856;11861.051115910706;11886.702832429259;16615.916920415322;16758.58103547421;16769.580760481087;16799.748003779954;16872.072036038135;6944.201416837129;7333.266673332624;7342.412606991428;7371.569229540248;7406.07424071991;6590.80227593173;6609.20689517261;6676.098726671934;6737.663116844138;6744.055832183498;5030.974845125751;5056;5083.491650834887;5169.25045868347;5202.895942081137;2069.0999415254414;2076.3148161106797;2082.437741809703;2109.5991761565256;2149.290734057757;973.4062222044547;1096.6874440784338;1099.9285046471953;1122.9775404491863;1191.2018947305326;18475.538111547317;19555.902220488806;19654;19693.40919772409;19932;1032.1330082730542;1061.3048453263125;1080.475969154959;1091.3942761767296;1094.2996482251365;10863.782724345469;11157.776844463227;11191.104711623051;11267.718307042225;11271.041961433206;517587;523834;532610;534852;537121;59194.704026479594;79619.60190199011;96568.51715741376;98035;98129;1012.3622118065572;1051.8061999630474;1051.8264486359665;1051.8737751469873;1069.04320633033;18152.81847181564;18240.36158734491;18411.079446027914;18437.81562184361;18477.260909563465;39894;40198;42796.57203428051;42868;43686.344704828814;59639.701801490715;60510.09234861569;61128.38871611227;61441.18205720291;61583;8417.410781245255;8790.648374064966;8972.147645973622;9046.864297035418;9148.130927561871;10133.341332813343;13523.256220907551;13558.93220533891;13755.449782008607;13794.241316727675;6058.697065146813;8563.015253245707;11939.164258501822;12085.939570302093;12414.937925310676;11865.110116741107;11927.642170734893;11996.880031199926;12013.939930300292;12022.879771202175;12365.319907405179;12373;12440.81338779901;12489.93755031219;12499.687507812378;8975.147361000694;9114.088591141099;9148.085191480799;9155;9250.259979201513;9125.726228213165;11080.778384432428;11442.427878606202;11633.418329083343;12271.815922760987 16:52:30 INFO - PROCESS | 1515 | |3;mootools.html;1521.1709618258049;1563.5153102538213;1713.9314427422903;1839.576897313617;1842.972355414669;7959.522428654285;8657.826843463143;8788.34087443442;9147.588358523866;9176.954115229431;8628.870566941501;8894.777630559223;8977;8986.37095403322;8997.145271199242;2374.0978428197304;2409.3976505873534;2415.685960825099;2420.322309753263;2422.9757702423017;2397.1969390254285;2412.8552286862755;2450.742672019439;2452.0927256914965;2464.8890799914047;2426.915057972971;2431.914882979096;2470.3206618179966;2473;2482.2801387597574;2413.3725231439776;2417.335232810991;2426.623873299641;2432.914847980312;2438.2928950604305;2303.9884800576056;2326.7207935047904;2332.953340933189;2344.5193735284224;2357.752435994213;8868.955655221747;8929.151730585583;8967.10328967098;8980.506072166028;9001.594928228245;5265.605079619044;5327.653702509325;5332.146856502941;5342.171963345688;5347.893042139174;3389.440742277521;3476.28736109097;3536.345776031417;3578.982105089458;3580.23025049613;1164.126904821384;1203.3983008495752;1256.6104507602672;1260.3635164241998;1284.267967258663;11927.701807454796;11959.94020029903;11962.40187990597;11994.640160795103;12025.879741202563;4376.256036473807;4497.482789479186;4561.156186105581;4642.489326174118;4702.764861756898;10209.081182693444;10252.282340236261;10263.7434064149;10284.691459256233;10325.896741032644;5205.6616319939085;5250.527452529291;5284.550813180923;5313.282706834605;5326.707031113326;4404.66964977628;4832.226843704991;4863.270509423614;4881.414230292387;4964.429090654621;4077.7553346799286;4128.674882984475;4171.6036976487185;4176.853810116631;4223.936640950388;1295.2099219476113;1308.6597484653869;1314.789633658629;1320.201278226659;1325.8939284857188;932.6735642525061;1022.6522982186092;1025.9230557708202;1047.2355180717966;1076.2412499188054;6113.585133872096;6211.3478084800445;6233.252009758858;6342.809715708536;6350.237971443456;489.3516091179131;496.5506216873735;500.412015881338;505.5273319446329;506.7896822818489;4305.806238719265;4405.9559404405545;4413.911721765547;4432.578905004019;4437.29003359461;10509.84235236472;10791.83812242817;10823.67528974132;10831.783364332827;10857.891421085687;10663.306885052447;10708.303960242714;10716;10757.78484430307;10813.891861081445;8030.237127472998;8110.716124935717;8171.223733745284;8275.213854683796;8376.49741015541;6319.210098737658;6378.138951241523;6465.321141280097;6543.1821022372205;6548.8035358939305;10452.529636166239;10501.054905058581;10578.89421105779;10638.73403164927;10899.509522071685;10918.781624367628;11010.614628487965;11024.614138505114;11049;11105.38920359388;7086.362227399559;7582.355499782359;7788.104367997753;7811.4922530035365;7894.644740986554;8892.288616910502;8905.955470222607;8987.056359082464;9006;9072.727818165466;7810.687572497037;7813.374930005472;7956.283934445928;8090.555019473985;8114.148014458397;7878;7907.48601340911;7949.642266097924;7980.281774640311;8002.119766825528;6607.900881486878;7074.469414794014;7114.181869084914;7137.32195441453;7145.964270178616;5148;5162.535371816554;5196.68819870809;5220.1647736362;5296.920546191887;5166.612504062286;5170.97414512925;5277.84166474991;5299;5384.9730751346 16:52:30 INFO - PROCESS | 1515 | |4;prototype.html;348.52252414192554;348.66702299304166;354.68787467029046;355.1759916992577;357.29434367124946;5733.1973523706665;5777.711114444277;5791.594588378815;5801.564882633798;5821.708914554266;5689.288838895138;5699.629524080932;5701.429857014296;5702.059160238566;5728.770849166029;4102.815373308194;4422.491413487442;4427.9557204427865;4428.114377124572;4436.64506839452;4417.359482874981;4442.955570444286;4443.311286750542;4454.3318502224765;4485.573870482299;4422.646188304944;4452.577005184518;4461.442319710036;4470.217711900421;4486.842960496383;4278.807453664577;4373.666031860282;4406.889827754299;4412.889677758049;4418.182636212311;3890.221955608861;3905.37513997759;3907.4138879168067;3912.4913761211146;3937.5274967003857;5467.097928841737;5497.340319161686;5542.944570554283;5576.219329293902;5601.915971260434;5010.574101201402;5094.235864620299;5099.59203263738;5105.489451054902;5107.948920510785;5869.911951320733;5893.469587737081;5960.880782384372;5977.342492325841;5995.160677505153;4324.707196871457;4371.825126994916;4375.7593332366705;4396.384506169139;4400.843586642554;6060.33336333003;6123.050927106306;6149.938500614981;6164.291106522763;6199.039148931968;4459.219636563654;4469.2849144137435;4474.814174243828;4485.282354823278;4513.345564893072;4378.978105109454;4541.250693635513;4561.749103799257;4575.3823233863;4588.862334129982;5038.79844806211;5078.568321692697;5091.261767043832;5097.8725531862;5100.617453690914;5945.791897283574;5949.672767997802;5987.670678112746;6012.158297838306;6016.608920420159;1478.8317229388663;1509.8943073984935;1517.347540557571;1541.1138595307743;1544.3282172255106;968.1867231525553;1015.9288849780445;1054.1040115901421;1087.8640169978753;1099.395332567101;5799;5830.183774271605;5838.9124163137585;5883.941160588425;5889.764409423575;6095.7866474674065;6163.660998645118;6173.506119510518;6191.442770150618;6203.410675985774;5606.719664016783;5945.821625351246;5951.375105613848;5964.1650168976375;5977.970110149421;3303.900882973515;3339.4489909164718;3345.464725643934;3345.565076540034;3348.8827891024184;6228.688565571703;6529.836754081091;6549.148610680676;6553.639549824806;6563.770268040691;6296.464800492009;6323.177986861679;6345.714442850082;6346.333634968354;6379.425851673372;6214.576315237061;6486.545941784124;6489.415952564292;6536.470306034783;6574.671266436659;6300.7794727186165;6316.021016742412;6373.5857169283845;6377.139086223486;6379.840503987438;6006.309274433496;6208.658523781055;6231.844203894939;6243.157173781663;6268.216472940882;6528.062371932554;6546.345365463416;6559.704813283509;6559.934400655932;6579.539432239697;4387.100644367833;4428.981334293195;4444.1111777643955;4455.62127219177;4460.907077765968;5929.940700592939;6222;6237.844053898689;6295.3704629538515;6350.174477317919;6027.487663548647;6042.3655516170165;6046.486048685735;6057.000594901968;6108.053251745987;5791;6074.757009719562;6106;6119.837230926109;6128.754849805958;5869.295684517714;6035.6076855004285;6036.215292012011;6038.154658347747;6042.456178943916;6121.663308518075;6127.111568822406;6147.907781383194;6172.6913654318005;6198.81403557894;5845.736941837713;5907.793227237026;5978.461938425563;6044;6048 16:52:30 INFO - PROCESS | 1515 | |5;yui.html;819.3813670678637;825.4840724547158;853.7268074216249;887.5606574745502;890.8441022821007;15823.129727864964;17423.39018134364;17673.64652706945;17686.115694215303;17688.1155942203;16114.7582786258;16131.032138071723;16147.111908845038;16230.513084607452;16384.262708178132;851.586980314547;872.7512658892217;875.0986483921571;878.1789027259501;880.7886107334226;869.3566760597145;877.4954401219293;881.8500854854658;883.7437143228456;884.0982198157907;912.9543522823866;914.1863741270275;915.844306467902;918.3709159225918;919.296737995434;908.3686837647838;910.8633704944245;912.7535565397305;912.8448163812135;913.1325241021024;672.8217022489044;673.7473447457204;674.6828990374516;674.9392554670103;675.4022689919408;16666.33334666624;16671.916640416843;16727.83272167275;16790.66418671632;16801.07594082325;15380.942195870579;15785.447509337233;15905.125218112998;15956.122413267265;16080;13235;13237.536686216032;13269.336533173398;13367.532136375181;13672.52146174879;4038.1519880825063;4113.835446582133;4132.876013719593;4166.979165104185;4168.062186008155;80499;80779.5961020197;82255.58872205601;83189;84472;12430.751384972249;12466.439010244561;12894.742105157844;12910.741785164431;13232.54442011378;22772;23127.7687223129;23180.420489487897;23250.41873953131;23332.53334933292;9370.67202647904;9584.424934503952;9597.919603847948;9612.375195612263;10031.247656425652;4976.104301225741;5055;5064.290999260106;5073.34046573943;5124.359455068116;3727.5340582427198;3867.3812190049457;3869.28418242626;3869.613038696164;3892.8832135035996;654.3914159831307;657.2966925389883;660.3693472733528;673.9224989126216;683.8871586188224;675.7297081167474;803.1286054630791;824.1922915542801;835.9456635318807;838.2204549768652;9847.55685994132;10073.395596264247;10106.494675266355;10128.696139115838;10258.692239232834;771.2865599320606;779.8050487378156;795.7016118955391;803.4375936844233;827.1810907201947;4986.4514903360605;5059.595232381401;5080.7205603692155;5098.821541246113;5120.411152717411;72692.63653681698;82085.17914820775;94721.5263923676;120326;124044;66749;85381.57309213415;101070;102659.4867025675;104549;88284;90978.54510727536;91650;92106.53946730358;92566.99999999865;9810.705678829647;10134.898651013396;10416.11463025621;10431.843522347323;10490.895091048991;54873.176902347295;55301.44698552963;55799.72100139473;55983.72008139933;57853.710731447754;48899;52075.47924520706;53268.46731532635;76688.2331176681;78331;12826.707665275597;12877.162984405984;13018.544350947672;13274.867251327363;13319;14092.718145636825;14209.928950355596;14562.199079050753;14576.416943322149;15747.055176689435;12693.492260309853;12769.170003949714;13363.997700172331;13721.45114195421;14043.929780351033;13706.314684265946;13726.176429414267;13762.587122386345;14070.507532236323;14654;12642.683932901751;12939;13257.088111134413;13356.732865342445;13484.393202306115;11232;11338.829917551408;11454.66340635747;11598.768024639628;11935.94032029869;11484;11557.711057223636;11802.350870702194;11850;12221.877781222074 16:52:30 INFO - PROCESS | 1515 | __end_tp_report 16:52:30 INFO - PROCESS | 1515 | __start_cc_report 16:52:30 INFO - PROCESS | 1515 | _x_x_mozilla_cycle_collect,337 16:52:30 INFO - PROCESS | 1515 | __end_cc_report 16:52:30 INFO - PROCESS | 1515 | __startTimestamp1469836350368__endTimestamp 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | ------- Summary: start ------- 16:52:30 INFO - PROCESS | 1515 | Number of tests: 6 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#0] dojo.html Cycles:165 Average:5547.39 Median:5723.31 stddev:616.92 (10.8%) stddev-sans-first:593.13 16:52:30 INFO - PROCESS | 1515 | Values: 3302.2 3309.2 3317.2 3333.2 3335.0 5444.6 5450.8 5456.2 5488.1 5499.2 5512.8 5515.9 5528.2 5572.2 5583.8 5009.2 5075.7 5135.6 5153.0 5176.2 5013.0 5029.2 5076.8 5113.3 5156.7 5019.9 5050.6 5077.8 5134.8 5151.8 5128.7 5204.5 5209.7 5213.1 5262.6 4916.1 5115.1 5123.9 5171.0 5189.0 5301.6 5366.4 5395.1 5396.9 5444.3 5870.3 5903.0 5909.6 5915.7 5916.5 5857.7 5962.4 5967.1 5967.5 5976.7 5607.0 5653.8 5659.0 5666.9 5678.1 6144.7 6194.0 6194.6 6204.3 6204.7 5638.0 5800.0 5811.9 5902.8 5933.3 5974.7 5982.9 5984.4 5995.0 6017.4 5897.1 5924.5 5952.7 5958.8 5983.6 5764.8 5870.3 5873.7 5906.8 5986.3 4560.9 4574.0 4578.4 4600.5 4607.3 4091.7 4099.6 4120.2 4125.6 4140.6 5613.2 5654.2 5659.3 5720.1 5768.7 5882.8 5917.3 5930.7 5943.6 5944.1 5658.0 5710.6 5723.3 5750.8 5761.1 5079.5 5102.4 5160.5 5160.8 5164.1 6186.8 6312.8 6341.8 6345.5 6360.1 6064.0 6084.8 6091.2 6113.0 6114.9 6081.3 6123.9 6134.1 6263.7 6300.6 5891.6 5911.9 5912.3 5958.5 5970.8 5986.5 6032.1 6042.0 6045.7 6048.2 5668.7 5677.9 5680.5 5700.2 5837.6 5720.1 5726.3 5729.3 5736.9 5744.4 5572.3 5652.8 5658.6 5663.2 5672.2 5779.2 5792.9 5796.6 5889.5 5931.1 5793.6 5807.6 5827.8 5832.3 5832.3 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#1] ext.html Cycles:180 Average:66980.58 Median:42473.36 stddev:153622.40 (361.7%) stddev-sans-first:153972.50 16:52:30 INFO - PROCESS | 1515 | Values: 600.7 629.5 652.0 660.9 673.7 40775.4 45998.0 46154.0 46260.1 46403.3 45863.8 46087.5 46240.3 46287.8 46363.8 8836.1 8940.2 9001.8 9014.1 9016.5 8841.4 8913.2 8944.9 8948.0 8975.7 8912.0 8918.0 8968.7 8971.6 8980.4 8862.6 8870.1 8907.5 8909.9 8965.6 8863.2 8922.0 8937.2 8942.0 8947.6 42981.1 43309.0 43526.0 43539.3 43540.3 3827.4 3916.7 3939.6 4384.3 4692.0 33984.5 34312.0 34511.0 34551.8 34811.0 4729.9 4730.0 4792.7 4845.3 4931.7 343432.0 348099.3 351902.0 353822.0 355772.0 62929.4 62957.0 62997.7 63470.4 63515.0 38849.8 40024.6 40124.8 42440.6 42454.4 17832.4 18109.0 18119.4 18127.6 18161.5 13400.8 13557.9 13563.2 13564.9 13611.5 21189.2 21235.4 21247.0 21329.5 21374.4 7121.4 7140.0 7406.6 7426.6 7465.7 951.5 1052.6 1161.0 1162.2 1240.2 34181.0 35319.1 36933.0 37223.6 37932.4 1113.6 1150.0 1169.1 1213.8 1234.5 17255.1 17376.5 17555.6 17604.2 17813.5 293500.0 626729.0 958265.0 978280.0 978964.0 60021.0 60667.4 60729.0 60772.0 60832.7 1468.0 1474.7 1506.6 1509.5 1518.7 32057.8 32509.0 32669.3 33080.3 33825.8 51871.5 52167.7 52755.7 52871.7 52924.5 430061.0 431053.0 431070.0 433652.0 434443.0 30070.0 30132.8 30134.2 30305.8 30641.4 48652.8 48719.5 49095.8 49291.0 49555.3 42020.8 42392.6 42492.4 42591.1 43636.3 40130.4 41273.6 41479.0 41667.0 41760.4 40395.2 41123.2 41390.4 41572.8 42124.4 36488.5 36528.5 36599.1 37106.3 37325.3 27823.7 28691.4 29033.7 29054.4 30721.0 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#2] jquery.html Cycles:180 Average:30083.74 Median:23924.00 stddev:87092.58 (364.0%) stddev-sans-first:87308.41 16:52:30 INFO - PROCESS | 1515 | Values: 415.6 416.0 420.2 424.8 431.9 19390.6 19485.1 20147.8 20536.0 20680.1 18419.9 18920.4 18959.6 19061.0 19569.3 5050.2 5367.2 5373.3 5396.8 5439.5 5179.2 5335.1 5417.9 5423.3 5427.9 5437.6 5437.8 5445.2 5448.2 5466.3 5297.8 5412.5 5511.7 5529.3 5538.4 5275.1 5326.9 5374.5 5377.2 5387.3 15159.6 18319.9 19338.6 23868.0 23980.0 2380.6 2402.5 2426.7 2434.1 2478.1 10496.9 10507.7 10553.2 11031.2 11535.9 2050.9 2072.2 2076.3 2116.9 2147.9 72222.3 84808.0 86226.6 88842.0 90112.0 11071.2 11713.4 11844.8 11861.1 11886.7 16615.9 16758.6 16769.6 16799.7 16872.1 6944.2 7333.3 7342.4 7371.6 7406.1 6590.8 6609.2 6676.1 6737.7 6744.1 5031.0 5056.0 5083.5 5169.3 5202.9 2069.1 2076.3 2082.4 2109.6 2149.3 973.4 1096.7 1099.9 1123.0 1191.2 18475.5 19555.9 19654.0 19693.4 19932.0 1032.1 1061.3 1080.5 1091.4 1094.3 10863.8 11157.8 11191.1 11267.7 11271.0 517587.0 523834.0 532610.0 534852.0 537121.0 59194.7 79619.6 96568.5 98035.0 98129.0 1012.4 1051.8 1051.8 1051.9 1069.0 18152.8 18240.4 18411.1 18437.8 18477.3 39894.0 40198.0 42796.6 42868.0 43686.3 59639.7 60510.1 61128.4 61441.2 61583.0 8417.4 8790.6 8972.1 9046.9 9148.1 10133.3 13523.3 13558.9 13755.4 13794.2 6058.7 8563.0 11939.2 12085.9 12414.9 11865.1 11927.6 11996.9 12013.9 12022.9 12365.3 12373.0 12440.8 12489.9 12499.7 8975.1 9114.1 9148.1 9155.0 9250.3 9125.7 11080.8 11442.4 11633.4 12271.8 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#3] mootools.html Cycles:180 Average:5907.78 Median:4467.39 stddev:3326.16 (74.5%) stddev-sans-first:3319.16 16:52:30 INFO - PROCESS | 1515 | Values: 1521.2 1563.5 1713.9 1839.6 1843.0 7959.5 8657.8 8788.3 9147.6 9177.0 8628.9 8894.8 8977.0 8986.4 8997.1 2374.1 2409.4 2415.7 2420.3 2423.0 2397.2 2412.9 2450.7 2452.1 2464.9 2426.9 2431.9 2470.3 2473.0 2482.3 2413.4 2417.3 2426.6 2432.9 2438.3 2304.0 2326.7 2333.0 2344.5 2357.8 8869.0 8929.2 8967.1 8980.5 9001.6 5265.6 5327.7 5332.1 5342.2 5347.9 3389.4 3476.3 3536.3 3579.0 3580.2 1164.1 1203.4 1256.6 1260.4 1284.3 11927.7 11959.9 11962.4 11994.6 12025.9 4376.3 4497.5 4561.2 4642.5 4702.8 10209.1 10252.3 10263.7 10284.7 10325.9 5205.7 5250.5 5284.6 5313.3 5326.7 4404.7 4832.2 4863.3 4881.4 4964.4 4077.8 4128.7 4171.6 4176.9 4223.9 1295.2 1308.7 1314.8 1320.2 1325.9 932.7 1022.7 1025.9 1047.2 1076.2 6113.6 6211.3 6233.3 6342.8 6350.2 489.4 496.6 500.4 505.5 506.8 4305.8 4406.0 4413.9 4432.6 4437.3 10509.8 10791.8 10823.7 10831.8 10857.9 10663.3 10708.3 10716.0 10757.8 10813.9 8030.2 8110.7 8171.2 8275.2 8376.5 6319.2 6378.1 6465.3 6543.2 6548.8 10452.5 10501.1 10578.9 10638.7 10899.5 10918.8 11010.6 11024.6 11049.0 11105.4 7086.4 7582.4 7788.1 7811.5 7894.6 8892.3 8906.0 8987.1 9006.0 9072.7 7810.7 7813.4 7956.3 8090.6 8114.1 7878.0 7907.5 7949.6 7980.3 8002.1 6607.9 7074.5 7114.2 7137.3 7146.0 5148.0 5162.5 5196.7 5220.2 5296.9 5166.6 5171.0 5277.8 5299.0 5385.0 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#4] prototype.html Cycles:180 Average:5099.91 Median:5811.64 stddev:1512.08 (26.0%) stddev-sans-first:1473.67 16:52:30 INFO - PROCESS | 1515 | Values: 348.5 348.7 354.7 355.2 357.3 5733.2 5777.7 5791.6 5801.6 5821.7 5689.3 5699.6 5701.4 5702.1 5728.8 4102.8 4422.5 4428.0 4428.1 4436.6 4417.4 4443.0 4443.3 4454.3 4485.6 4422.6 4452.6 4461.4 4470.2 4486.8 4278.8 4373.7 4406.9 4412.9 4418.2 3890.2 3905.4 3907.4 3912.5 3937.5 5467.1 5497.3 5542.9 5576.2 5601.9 5010.6 5094.2 5099.6 5105.5 5107.9 5869.9 5893.5 5960.9 5977.3 5995.2 4324.7 4371.8 4375.8 4396.4 4400.8 6060.3 6123.1 6149.9 6164.3 6199.0 4459.2 4469.3 4474.8 4485.3 4513.3 4379.0 4541.3 4561.7 4575.4 4588.9 5038.8 5078.6 5091.3 5097.9 5100.6 5945.8 5949.7 5987.7 6012.2 6016.6 1478.8 1509.9 1517.3 1541.1 1544.3 968.2 1015.9 1054.1 1087.9 1099.4 5799.0 5830.2 5838.9 5883.9 5889.8 6095.8 6163.7 6173.5 6191.4 6203.4 5606.7 5945.8 5951.4 5964.2 5978.0 3303.9 3339.4 3345.5 3345.6 3348.9 6228.7 6529.8 6549.1 6553.6 6563.8 6296.5 6323.2 6345.7 6346.3 6379.4 6214.6 6486.5 6489.4 6536.5 6574.7 6300.8 6316.0 6373.6 6377.1 6379.8 6006.3 6208.7 6231.8 6243.2 6268.2 6528.1 6546.3 6559.7 6559.9 6579.5 4387.1 4429.0 4444.1 4455.6 4460.9 5929.9 6222.0 6237.8 6295.4 6350.2 6027.5 6042.4 6046.5 6057.0 6108.1 5791.0 6074.8 6106.0 6119.8 6128.8 5869.3 6035.6 6036.2 6038.2 6042.5 6121.7 6127.1 6147.9 6172.7 6198.8 5845.7 5907.8 5978.5 6044.0 6048.0 16:52:30 INFO - PROCESS | 1515 | 16:52:30 INFO - PROCESS | 1515 | [#5] yui.html Cycles:180 Average:20672.01 Median:4123.36 stddev:28573.47 (693.0%) stddev-sans-first:28614.74 16:52:30 INFO - PROCESS | 1515 | Values: 819.4 825.5 853.7 887.6 890.8 15823.1 17423.4 17673.6 17686.1 17688.1 16114.8 16131.0 16147.1 16230.5 16384.3 851.6 872.8 875.1 878.2 880.8 869.4 877.5 881.9 883.7 884.1 913.0 914.2 915.8 918.4 919.3 908.4 910.9 912.8 912.8 913.1 672.8 673.7 674.7 674.9 675.4 16666.3 16671.9 16727.8 16790.7 16801.1 15380.9 15785.4 15905.1 15956.1 16080.0 13235.0 13237.5 13269.3 13367.5 13672.5 4038.2 4113.8 4132.9 4167.0 4168.1 80499.0 80779.6 82255.6 83189.0 84472.0 12430.8 12466.4 12894.7 12910.7 13232.5 22772.0 23127.8 23180.4 23250.4 23332.5 9370.7 9584.4 9597.9 9612.4 10031.2 4976.1 5055.0 5064.3 5073.3 5124.4 3727.5 3867.4 3869.3 3869.6 3892.9 654.4 657.3 660.4 673.9 683.9 675.7 803.1 824.2 835.9 838.2 9847.6 10073.4 10106.5 10128.7 10258.7 771.3 779.8 795.7 803.4 827.2 4986.5 5059.6 5080.7 5098.8 5120.4 72692.6 82085.2 94721.5 120326.0 124044.0 66749.0 85381.6 101070.0 102659.5 104549.0 88284.0 90978.5 91650.0 92106.5 92567.0 9810.7 10134.9 10416.1 10431.8 10490.9 54873.2 55301.4 55799.7 55983.7 57853.7 48899.0 52075.5 53268.5 76688.2 78331.0 12826.7 12877.2 13018.5 13274.9 13319.0 14092.7 14209.9 14562.2 14576.4 15747.1 12693.5 12769.2 13364.0 13721.5 14043.9 13706.3 13726.2 13762.6 14070.5 14654.0 12642.7 12939.0 13257.1 13356.7 13484.4 11232.0 11338.8 11454.7 11598.8 11935.9 11484.0 11557.7 11802.4 11850.0 12221.9 16:52:30 INFO - PROCESS | 1515 | -------- Summary: end -------- 16:52:30 INFO - PROCESS | 1515 | 16:52:31 INFO - TEST-INFO | 1515: exit 0 16:52:31 INFO - TEST-OK | dromaeo_css | took 1109408ms 16:52:31 INFO - TEST-START | kraken 16:52:31 INFO - operating with platform_type : linux_ 16:52:31 INFO - Initialising browser for kraken test... 16:52:31 INFO - TEST-INFO | started process 1764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasAXXu/profile http://localhost:57939/getInfo.html) 16:52:35 INFO - PROCESS | 1764 | __metrics Screen width/height:1600/1200 16:52:35 INFO - PROCESS | 1764 | colorDepth:24 16:52:35 INFO - PROCESS | 1764 | Browser inner width/height: 1024/697 16:52:35 INFO - PROCESS | 1764 | __metrics 16:52:36 ERROR - PROCESS | 1764 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 16:52:36 INFO - TEST-INFO | 1764: exit 0 16:52:36 INFO - Browser initialized. 16:52:36 INFO - Running cycle 1/1 for kraken test... 16:52:36 INFO - TEST-INFO | started process 1891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpasAXXu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:48 INFO - PROCESS | 1891 | RSS: Main: 155967488 16:52:48 INFO - PROCESS | 1891 | 16:52:51 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection) 16:52:52 INFO - PROCESS | 1891 | RSS: Main: 161120256 16:52:52 INFO - PROCESS | 1891 | 16:52:54 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-dft) 16:52:55 INFO - PROCESS | 1891 | RSS: Main: 160354304 16:52:55 INFO - PROCESS | 1891 | 16:52:58 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-fft) 16:52:58 INFO - PROCESS | 1891 | RSS: Main: 161107968 16:52:58 INFO - PROCESS | 1891 | 16:53:00 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator) 16:53:01 INFO - PROCESS | 1891 | RSS: Main: 160661504 16:53:01 INFO - PROCESS | 1891 | 16:53:03 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:53:04 INFO - PROCESS | 1891 | RSS: Main: 160645120 16:53:04 INFO - PROCESS | 1891 | 16:53:07 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom) 16:53:08 INFO - PROCESS | 1891 | RSS: Main: 160481280 16:53:08 INFO - PROCESS | 1891 | 16:53:11 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate) 16:53:12 INFO - PROCESS | 1891 | RSS: Main: 157163520 16:53:12 INFO - PROCESS | 1891 | 16:53:14 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial) 16:53:15 INFO - PROCESS | 1891 | RSS: Main: 159162368 16:53:15 INFO - PROCESS | 1891 | 16:53:17 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:53:17 INFO - PROCESS | 1891 | RSS: Main: 159285248 16:53:17 INFO - PROCESS | 1891 | 16:53:19 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:53:20 INFO - PROCESS | 1891 | RSS: Main: 159739904 16:53:20 INFO - PROCESS | 1891 | 16:53:22 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:53:22 INFO - PROCESS | 1891 | RSS: Main: 160358400 16:53:22 INFO - PROCESS | 1891 | 16:53:25 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:53:26 INFO - PROCESS | 1891 | RSS: Main: 160636928 16:53:26 INFO - PROCESS | 1891 | 16:53:28 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:53:29 INFO - PROCESS | 1891 | RSS: Main: 160292864 16:53:29 INFO - PROCESS | 1891 | 16:53:30 INFO - PROCESS | 1891 | Cycle 1(1): loaded http://localhost:57939/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57939/tests/kraken/driver.html?testName=ai-astar) 16:53:31 INFO - PROCESS | 1891 | RSS: Main: 160923648 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | __start_tp_report 16:53:31 INFO - PROCESS | 1891 | _x_x_mozilla_page_load 16:53:31 INFO - PROCESS | 1891 | _x_x_mozilla_page_load_details 16:53:31 INFO - PROCESS | 1891 | |i|pagename|runs| 16:53:31 INFO - PROCESS | 1891 | |0;ai-astar;113;104;111;109;111;114;110;110;111;111 16:53:31 INFO - PROCESS | 1891 | |1;audio-beat-detection;148;124;159;179;126;153;152;134;180;132 16:53:31 INFO - PROCESS | 1891 | |2;audio-dft;163;163;162;165;163;161;162;163;161;161 16:53:31 INFO - PROCESS | 1891 | |3;audio-fft;76;75;76;183;76;75;74;78;176;76 16:53:31 INFO - PROCESS | 1891 | |4;audio-oscillator;85;85;158;84;85;85;138;85;85;137 16:53:31 INFO - PROCESS | 1891 | |5;imaging-gaussian-blur;118;117;118;118;118;118;117;118;118;118 16:53:31 INFO - PROCESS | 1891 | |6;imaging-darkroom;146;149;146;146;147;147;147;148;147;148 16:53:31 INFO - PROCESS | 1891 | |7;imaging-desaturate;95;95;96;96;96;94;95;97;96;95 16:53:31 INFO - PROCESS | 1891 | |8;json-parse-financial;52;57;53;54;53;62;52;53;52;53 16:53:31 INFO - PROCESS | 1891 | |9;json-stringify-tinderbox;61;60;62;61;61;62;61;61;62;62 16:53:31 INFO - PROCESS | 1891 | |10;stanford-crypto-aes;81;75;77;77;77;82;78;82;105;77 16:53:31 INFO - PROCESS | 1891 | |11;stanford-crypto-ccm;120;119;129;131;137;125;130;126;124;136 16:53:31 INFO - PROCESS | 1891 | |12;stanford-crypto-pbkdf2;163;156;158;161;153;157;157;154;155;153 16:53:31 INFO - PROCESS | 1891 | |13;stanford-crypto-sha256-iterative;67;66;62;61;61;66;60;62;62;60 16:53:31 INFO - PROCESS | 1891 | __end_tp_report 16:53:31 INFO - PROCESS | 1891 | __start_cc_report 16:53:31 INFO - PROCESS | 1891 | _x_x_mozilla_cycle_collect,888 16:53:31 INFO - PROCESS | 1891 | __end_cc_report 16:53:31 INFO - PROCESS | 1891 | __startTimestamp1469836411225__endTimestamp 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | ------- Summary: start ------- 16:53:31 INFO - PROCESS | 1891 | Number of tests: 14 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.67 (2.4%) stddev-sans-first:2.67 16:53:31 INFO - PROCESS | 1891 | Values: 113.0 104.0 111.0 109.0 111.0 114.0 110.0 110.0 111.0 111.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:152.50 stddev:20.15 (13.2%) stddev-sans-first:21.37 16:53:31 INFO - PROCESS | 1891 | Values: 148.0 124.0 159.0 179.0 126.0 153.0 152.0 134.0 180.0 132.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 16:53:31 INFO - PROCESS | 1891 | Values: 163.0 163.0 162.0 165.0 163.0 161.0 162.0 163.0 161.0 161.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#3] audio-fft Cycles:10 Average:96.50 Median:76.00 stddev:43.79 (57.6%) stddev-sans-first:45.81 16:53:31 INFO - PROCESS | 1891 | Values: 76.0 75.0 76.0 183.0 76.0 75.0 74.0 78.0 176.0 76.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:29.27 (34.4%) stddev-sans-first:30.34 16:53:31 INFO - PROCESS | 1891 | Values: 85.0 85.0 158.0 84.0 85.0 85.0 138.0 85.0 85.0 137.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:53:31 INFO - PROCESS | 1891 | Values: 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 118.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 16:53:31 INFO - PROCESS | 1891 | Values: 146.0 149.0 146.0 146.0 147.0 147.0 147.0 148.0 147.0 148.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 16:53:31 INFO - PROCESS | 1891 | Values: 95.0 95.0 96.0 96.0 96.0 94.0 95.0 97.0 96.0 95.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.00 stddev:3.14 (5.9%) stddev-sans-first:3.24 16:53:31 INFO - PROCESS | 1891 | Values: 52.0 57.0 53.0 54.0 53.0 62.0 52.0 53.0 52.0 53.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 16:53:31 INFO - PROCESS | 1891 | Values: 61.0 60.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 62.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:77.50 stddev:8.74 (11.3%) stddev-sans-first:9.27 16:53:31 INFO - PROCESS | 1891 | Values: 81.0 75.0 77.0 77.0 77.0 82.0 78.0 82.0 105.0 77.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.50 stddev:6.07 (4.7%) stddev-sans-first:5.77 16:53:31 INFO - PROCESS | 1891 | Values: 120.0 119.0 129.0 131.0 137.0 125.0 130.0 126.0 124.0 136.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.70 Median:157.00 stddev:3.30 (2.1%) stddev-sans-first:2.60 16:53:31 INFO - PROCESS | 1891 | Values: 163.0 156.0 158.0 161.0 153.0 157.0 157.0 154.0 155.0 153.0 16:53:31 INFO - PROCESS | 1891 | 16:53:31 INFO - PROCESS | 1891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:2.63 (4.2%) stddev-sans-first:2.28 16:53:31 INFO - PROCESS | 1891 | Values: 67.0 66.0 62.0 61.0 61.0 66.0 60.0 62.0 62.0 60.0 16:53:31 INFO - PROCESS | 1891 | -------- Summary: end -------- 16:53:31 INFO - PROCESS | 1891 | 16:53:32 INFO - TEST-INFO | 1891: exit 0 16:53:32 INFO - TEST-OK | kraken | took 61063ms 16:53:32 INFO - SUITE-END | took 1170s 16:53:32 INFO - Completed test suite (00:19:30) 16:53:32 INFO - javascript benchmark 16:53:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7549.409938116126, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.2074702071504, 3309.189248634085, 3317.1541256979467, 3333.1833700743323, 3334.9661604902467, 5444.646098003627, 5450.836474905749, 5456.208849716793, 5488.149336852789, 5499.202615620733, 5512.834614961547, 5515.896820635869, 5528.226048353234, 5572.192032155345, 5583.776648934037, 5009.248612708096, 5075.720835354054, 5135.614828887829, 5153.020926024044, 5176.171812509999, 5012.9749351253195, 5029.220470827027, 5076.822311219108, 5113.309703190078, 5156.690598564098, 5019.924701129486, 5050.570701490359, 5077.847664570068, 5134.794608215667, 5151.845444636667, 5128.71792051437, 5204.479552044803, 5209.7134657593815, 5213.139831927746, 5262.631615786897, 4916.115099282128, 5115.079285728568, 5123.89836185222, 5171.0, 5189.040027594907, 5301.628885977983, 5366.409694933554, 5395.136778115522, 5396.946030539683, 5444.265024221759, 5870.3249126350165, 5903.0, 5909.586328956974, 5915.704214789286, 5916.526677865761, 5857.70711464425, 5962.373950735154, 5967.104934259895, 5967.49276311514, 5976.671283079429, 5606.971965140148, 5653.802116925888, 5658.971705141448, 5666.858328541819, 5678.148277758328, 6144.692765361714, 6194.0, 6194.5973511721595, 6204.255489341308, 6204.689765511796, 5638.041532939328, 5800.0429929062075, 5811.912821307684, 5902.822915312548, 5933.288005439289, 5974.701264936736, 5982.910256346158, 5984.431479009487, 5994.9700251499335, 6017.428344307284, 5897.115432685132, 5924.4667979882015, 5952.7321270542925, 5958.791442299499, 5983.581149319593, 5764.827055188351, 5870.26621672291, 5873.706314684248, 5906.822795316148, 5986.311574168939, 4560.908781824345, 4573.977130114395, 4578.40480737502, 4600.516945720651, 4607.331936869202, 4091.672666186698, 4099.631033207026, 4120.237756015147, 4125.587441255911, 4140.60664236897, 5613.186088017214, 5654.151877218368, 5659.264295641623, 5720.056190728566, 5768.682722450221, 5882.823515294548, 5917.260342457193, 5930.733117009745, 5943.55423343251, 5944.078667806497, 5657.971710141505, 5710.5717071219, 5723.313202415654, 5750.827475175752, 5761.107028410603, 5079.492050794965, 5102.413222479462, 5160.509751573594, 5160.767765450489, 5164.070467315919, 6186.81439556814, 6312.8421789454715, 6341.8097457076365, 6345.524085693592, 6360.109584658151, 6063.999999999912, 6084.847878802888, 6091.238595175603, 6112.969435152796, 6114.908276375947, 6081.27024757032, 6123.892747182756, 6134.130457564626, 6263.718132684131, 6300.558960872695, 5891.587588868738, 5911.881762364815, 5912.260967379078, 5958.463738263577, 5970.791022314198, 5986.461218490357, 6032.065029920369, 6042.0332746760305, 6045.697715114139, 6048.243969503812, 5668.744906479301, 5677.886442271214, 5680.545556355564, 5700.201971723879, 5837.620554663933, 5720.056190728649, 5726.312842458931, 5729.2551968245525, 5736.913946290892, 5744.3681195067675, 5572.3034620672415, 5652.830415087554, 5658.603897727285, 5663.1788390682295, 5672.2342483765815, 5779.162021506942, 5792.884142317214, 5796.59423840344, 5889.499392551681, 5931.051031834886, 5793.623414478046, 5807.593468457168, 5827.76688932438, 5832.300123984979, 5832.3292821326095], "value": 5507.210229715602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.6966481926629, 629.5089829932652, 651.9804405867823, 660.8645227728315, 673.7473447457204, 40775.38836917445, 45998.0, 46154.0, 46260.07479850405, 46403.30395044073, 45863.77068114655, 46087.539124608746, 46240.3063954041, 46287.84280392984, 46363.768181159045, 8836.116388361177, 8940.150685684883, 9001.77495562613, 9014.053524379944, 9016.459012459241, 8841.425307355, 8913.153250441197, 8944.8658270126, 8948.0, 8975.730728078168, 8912.0, 8917.95541022294, 8968.730938071836, 8971.596278167499, 8980.416272942239, 8862.556872156367, 8870.112988701143, 8907.465552066897, 8909.910900891005, 8965.64137434505, 8863.2466240369, 8922.0, 8937.240334571568, 8941.955290223572, 8947.552622368856, 42981.14037719259, 43309.0, 43526.0, 43539.346909796375, 43540.3468947966, 3827.4067519534515, 3916.706247031484, 3939.5863434339267, 4384.298512238027, 4692.0, 33984.49023264653, 34312.0, 34511.0, 34551.82724086389, 34811.0, 4729.858104256878, 4730.0, 4792.664513484057, 4845.297431872394, 4931.65478416511, 343432.0, 348099.2595037034, 351902.0, 353822.0, 355772.0, 62929.37070629235, 62957.0, 62997.68501157465, 63470.36529634737, 63515.0, 38849.80575097106, 40024.59975400267, 40124.79937600352, 42440.57559424428, 42454.363184552254, 17832.3758668446, 18109.0, 18119.36582219616, 18127.63744725098, 18161.45515634533, 13400.798988015187, 13557.932210338886, 13563.186208827501, 13564.864351356557, 13611.52359667407, 21189.15243390278, 21235.362939111852, 21247.0, 21329.466763331042, 21374.358769236947, 7121.359077683033, 7140.0, 7406.629668516553, 7426.5915374654915, 7465.738699145504, 951.4766878216954, 1052.5631862777016, 1160.988390116105, 1162.2213117211488, 1240.2388608176411, 34181.0, 35319.11702207466, 36933.0, 37223.62776372256, 37932.43101353482, 1113.560143743233, 1149.9942500287445, 1169.1231576317762, 1213.8239955206445, 1234.5248126523986, 17255.137243137793, 17376.478705638852, 17555.648887022187, 17604.207810648553, 17813.46559603214, 293500.0, 626729.0, 958265.0, 978280.0, 978964.0, 60021.0, 60667.39332606706, 60729.0, 60772.0, 60832.695836521416, 1467.985320146785, 1474.6681996550906, 1506.623344163959, 1509.4641402302245, 1518.681076973848, 32057.839710801298, 32509.0, 32669.346613068083, 33080.33839323152, 33825.830870845486, 51871.481285186666, 52167.73916130395, 52755.736221320185, 52871.735641321546, 52924.47075529196, 430061.0, 431053.0, 431070.0, 433652.0, 434443.0, 30070.0, 30132.849335754057, 30134.246643834078, 30305.84847075839, 30641.387172256877, 48652.75673621609, 48719.5128048715, 49095.754521227165, 49291.0, 49555.25667114924, 42020.78989605032, 42392.576074240096, 42492.362614561425, 42591.14817703567, 43636.34545481884, 40130.39804402995, 41273.587264126974, 41479.0, 41667.0, 41760.37359439672, 40395.1920961585, 41123.1775364497, 41390.37914431346, 41572.79213603913, 42124.368134478624, 36488.45267321046, 36528.45207321839, 36599.08502287464, 37106.25787484289, 37325.253494929406, 27823.721762782112, 28691.426171476036, 29033.7096629031, 29054.418911622073, 30721.0], "value": 20989.055341718085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.5864914410162, 415.99376009359844, 420.23517198698363, 424.7897290841033, 431.9265724826779, 19390.612187756255, 19485.123169457354, 20147.798522014775, 20536.0, 20680.069396877137, 18419.90790046048, 18920.432387028377, 18959.62080758384, 19061.04694765263, 19569.315073972415, 5050.242463630448, 5367.221752845835, 5373.328333958255, 5396.811111611094, 5439.48324909133, 5179.223116532513, 5335.1197052486295, 5417.864553386157, 5423.349198096214, 5427.864303392407, 5437.564994800407, 5437.755301011464, 5445.237666726642, 5448.237246785453, 5466.262054622614, 5297.788088476456, 5412.4858138476975, 5511.696856672881, 5529.281193444866, 5538.363088244822, 5275.076861549213, 5326.92009619856, 5374.4625537445945, 5377.247185394048, 5387.326584176978, 15159.62100947474, 18319.90080595155, 19338.613227735506, 23868.0, 23980.0, 2380.6071998120287, 2402.4594466244953, 2426.733059363469, 2434.050720219116, 2478.0954951442595, 10496.895031049668, 10507.737306567396, 10553.155747540179, 11031.172662050298, 11535.884641153565, 2050.8872012039333, 2072.171131547378, 2076.3148161106797, 2116.9364919052455, 2147.9463013424634, 72222.27777722209, 84808.0, 86226.56886715526, 88842.0, 90112.0, 11071.225014249087, 11713.355765432983, 11844.763104737856, 11861.051115910706, 11886.702832429259, 16615.916920415322, 16758.58103547421, 16769.580760481087, 16799.748003779954, 16872.072036038135, 6944.201416837129, 7333.266673332624, 7342.412606991428, 7371.569229540248, 7406.07424071991, 6590.80227593173, 6609.20689517261, 6676.098726671934, 6737.663116844138, 6744.055832183498, 5030.974845125751, 5056.0, 5083.491650834887, 5169.25045868347, 5202.895942081137, 2069.0999415254414, 2076.3148161106797, 2082.437741809703, 2109.5991761565256, 2149.290734057757, 973.4062222044547, 1096.6874440784338, 1099.9285046471953, 1122.9775404491863, 1191.2018947305326, 18475.538111547317, 19555.902220488806, 19654.0, 19693.40919772409, 19932.0, 1032.1330082730542, 1061.3048453263125, 1080.475969154959, 1091.3942761767296, 1094.2996482251365, 10863.782724345469, 11157.776844463227, 11191.104711623051, 11267.718307042225, 11271.041961433206, 517587.0, 523834.0, 532610.0, 534852.0, 537121.0, 59194.704026479594, 79619.60190199011, 96568.51715741376, 98035.0, 98129.0, 1012.3622118065572, 1051.8061999630474, 1051.8264486359665, 1051.8737751469873, 1069.04320633033, 18152.81847181564, 18240.36158734491, 18411.079446027914, 18437.81562184361, 18477.260909563465, 39894.0, 40198.0, 42796.57203428051, 42868.0, 43686.344704828814, 59639.701801490715, 60510.09234861569, 61128.38871611227, 61441.18205720291, 61583.0, 8417.410781245255, 8790.648374064966, 8972.147645973622, 9046.864297035418, 9148.130927561871, 10133.341332813343, 13523.256220907551, 13558.93220533891, 13755.449782008607, 13794.241316727675, 6058.697065146813, 8563.015253245707, 11939.164258501822, 12085.939570302093, 12414.937925310676, 11865.110116741107, 11927.642170734893, 11996.880031199926, 12013.939930300292, 12022.879771202175, 12365.319907405179, 12373.0, 12440.81338779901, 12489.93755031219, 12499.687507812378, 8975.147361000694, 9114.088591141099, 9148.085191480799, 9155.0, 9250.259979201513, 9125.726228213165, 11080.778384432428, 11442.427878606202, 11633.418329083343, 12271.815922760987], "value": 9289.357739953773, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1521.1709618258049, 1563.5153102538213, 1713.9314427422903, 1839.576897313617, 1842.972355414669, 7959.522428654285, 8657.826843463143, 8788.34087443442, 9147.588358523866, 9176.954115229431, 8628.870566941501, 8894.777630559223, 8977.0, 8986.37095403322, 8997.145271199242, 2374.0978428197304, 2409.3976505873534, 2415.685960825099, 2420.322309753263, 2422.9757702423017, 2397.1969390254285, 2412.8552286862755, 2450.742672019439, 2452.0927256914965, 2464.8890799914047, 2426.915057972971, 2431.914882979096, 2470.3206618179966, 2473.0, 2482.2801387597574, 2413.3725231439776, 2417.335232810991, 2426.623873299641, 2432.914847980312, 2438.2928950604305, 2303.9884800576056, 2326.7207935047904, 2332.953340933189, 2344.5193735284224, 2357.752435994213, 8868.955655221747, 8929.151730585583, 8967.10328967098, 8980.506072166028, 9001.594928228245, 5265.605079619044, 5327.653702509325, 5332.146856502941, 5342.171963345688, 5347.893042139174, 3389.440742277521, 3476.28736109097, 3536.345776031417, 3578.982105089458, 3580.23025049613, 1164.126904821384, 1203.3983008495752, 1256.6104507602672, 1260.3635164241998, 1284.267967258663, 11927.701807454796, 11959.94020029903, 11962.40187990597, 11994.640160795103, 12025.879741202563, 4376.256036473807, 4497.482789479186, 4561.156186105581, 4642.489326174118, 4702.764861756898, 10209.081182693444, 10252.282340236261, 10263.7434064149, 10284.691459256233, 10325.896741032644, 5205.6616319939085, 5250.527452529291, 5284.550813180923, 5313.282706834605, 5326.707031113326, 4404.66964977628, 4832.226843704991, 4863.270509423614, 4881.414230292387, 4964.429090654621, 4077.7553346799286, 4128.674882984475, 4171.6036976487185, 4176.853810116631, 4223.936640950388, 1295.2099219476113, 1308.6597484653869, 1314.789633658629, 1320.201278226659, 1325.8939284857188, 932.6735642525061, 1022.6522982186092, 1025.9230557708202, 1047.2355180717966, 1076.2412499188054, 6113.585133872096, 6211.3478084800445, 6233.252009758858, 6342.809715708536, 6350.237971443456, 489.3516091179131, 496.5506216873735, 500.412015881338, 505.5273319446329, 506.7896822818489, 4305.806238719265, 4405.9559404405545, 4413.911721765547, 4432.578905004019, 4437.29003359461, 10509.84235236472, 10791.83812242817, 10823.67528974132, 10831.783364332827, 10857.891421085687, 10663.306885052447, 10708.303960242714, 10716.0, 10757.78484430307, 10813.891861081445, 8030.237127472998, 8110.716124935717, 8171.223733745284, 8275.213854683796, 8376.49741015541, 6319.210098737658, 6378.138951241523, 6465.321141280097, 6543.1821022372205, 6548.8035358939305, 10452.529636166239, 10501.054905058581, 10578.89421105779, 10638.73403164927, 10899.509522071685, 10918.781624367628, 11010.614628487965, 11024.614138505114, 11049.0, 11105.38920359388, 7086.362227399559, 7582.355499782359, 7788.104367997753, 7811.4922530035365, 7894.644740986554, 8892.288616910502, 8905.955470222607, 8987.056359082464, 9006.0, 9072.727818165466, 7810.687572497037, 7813.374930005472, 7956.283934445928, 8090.555019473985, 8114.148014458397, 7878.0, 7907.48601340911, 7949.642266097924, 7980.281774640311, 8002.119766825528, 6607.900881486878, 7074.469414794014, 7114.181869084914, 7137.32195441453, 7145.964270178616, 5148.0, 5162.535371816554, 5196.68819870809, 5220.1647736362, 5296.920546191887, 5166.612504062286, 5170.97414512925, 5277.84166474991, 5299.0, 5384.9730751346], "value": 4688.344949653711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.52252414192554, 348.66702299304166, 354.68787467029046, 355.1759916992577, 357.29434367124946, 5733.1973523706665, 5777.711114444277, 5791.594588378815, 5801.564882633798, 5821.708914554266, 5689.288838895138, 5699.629524080932, 5701.429857014296, 5702.059160238566, 5728.770849166029, 4102.815373308194, 4422.491413487442, 4427.9557204427865, 4428.114377124572, 4436.64506839452, 4417.359482874981, 4442.955570444286, 4443.311286750542, 4454.3318502224765, 4485.573870482299, 4422.646188304944, 4452.577005184518, 4461.442319710036, 4470.217711900421, 4486.842960496383, 4278.807453664577, 4373.666031860282, 4406.889827754299, 4412.889677758049, 4418.182636212311, 3890.221955608861, 3905.37513997759, 3907.4138879168067, 3912.4913761211146, 3937.5274967003857, 5467.097928841737, 5497.340319161686, 5542.944570554283, 5576.219329293902, 5601.915971260434, 5010.574101201402, 5094.235864620299, 5099.59203263738, 5105.489451054902, 5107.948920510785, 5869.911951320733, 5893.469587737081, 5960.880782384372, 5977.342492325841, 5995.160677505153, 4324.707196871457, 4371.825126994916, 4375.7593332366705, 4396.384506169139, 4400.843586642554, 6060.33336333003, 6123.050927106306, 6149.938500614981, 6164.291106522763, 6199.039148931968, 4459.219636563654, 4469.2849144137435, 4474.814174243828, 4485.282354823278, 4513.345564893072, 4378.978105109454, 4541.250693635513, 4561.749103799257, 4575.3823233863, 4588.862334129982, 5038.79844806211, 5078.568321692697, 5091.261767043832, 5097.8725531862, 5100.617453690914, 5945.791897283574, 5949.672767997802, 5987.670678112746, 6012.158297838306, 6016.608920420159, 1478.8317229388663, 1509.8943073984935, 1517.347540557571, 1541.1138595307743, 1544.3282172255106, 968.1867231525553, 1015.9288849780445, 1054.1040115901421, 1087.8640169978753, 1099.395332567101, 5799.0, 5830.183774271605, 5838.9124163137585, 5883.941160588425, 5889.764409423575, 6095.7866474674065, 6163.660998645118, 6173.506119510518, 6191.442770150618, 6203.410675985774, 5606.719664016783, 5945.821625351246, 5951.375105613848, 5964.1650168976375, 5977.970110149421, 3303.900882973515, 3339.4489909164718, 3345.464725643934, 3345.565076540034, 3348.8827891024184, 6228.688565571703, 6529.836754081091, 6549.148610680676, 6553.639549824806, 6563.770268040691, 6296.464800492009, 6323.177986861679, 6345.714442850082, 6346.333634968354, 6379.425851673372, 6214.576315237061, 6486.545941784124, 6489.415952564292, 6536.470306034783, 6574.671266436659, 6300.7794727186165, 6316.021016742412, 6373.5857169283845, 6377.139086223486, 6379.840503987438, 6006.309274433496, 6208.658523781055, 6231.844203894939, 6243.157173781663, 6268.216472940882, 6528.062371932554, 6546.345365463416, 6559.704813283509, 6559.934400655932, 6579.539432239697, 4387.100644367833, 4428.981334293195, 4444.1111777643955, 4455.62127219177, 4460.907077765968, 5929.940700592939, 6222.0, 6237.844053898689, 6295.3704629538515, 6350.174477317919, 6027.487663548647, 6042.3655516170165, 6046.486048685735, 6057.000594901968, 6108.053251745987, 5791.0, 6074.757009719562, 6106.0, 6119.837230926109, 6128.754849805958, 5869.295684517714, 6035.6076855004285, 6036.215292012011, 6038.154658347747, 6042.456178943916, 6121.663308518075, 6127.111568822406, 6147.907781383194, 6172.6913654318005, 6198.81403557894, 5845.736941837713, 5907.793227237026, 5978.461938425563, 6044.0, 6048.0], "value": 4615.900485164486, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.3813670678637, 825.4840724547158, 853.7268074216249, 887.5606574745502, 890.8441022821007, 15823.129727864964, 17423.39018134364, 17673.64652706945, 17686.115694215303, 17688.1155942203, 16114.7582786258, 16131.032138071723, 16147.111908845038, 16230.513084607452, 16384.262708178132, 851.586980314547, 872.7512658892217, 875.0986483921571, 878.1789027259501, 880.7886107334226, 869.3566760597145, 877.4954401219293, 881.8500854854658, 883.7437143228456, 884.0982198157907, 912.9543522823866, 914.1863741270275, 915.844306467902, 918.3709159225918, 919.296737995434, 908.3686837647838, 910.8633704944245, 912.7535565397305, 912.8448163812135, 913.1325241021024, 672.8217022489044, 673.7473447457204, 674.6828990374516, 674.9392554670103, 675.4022689919408, 16666.33334666624, 16671.916640416843, 16727.83272167275, 16790.66418671632, 16801.07594082325, 15380.942195870579, 15785.447509337233, 15905.125218112998, 15956.122413267265, 16080.0, 13235.0, 13237.536686216032, 13269.336533173398, 13367.532136375181, 13672.52146174879, 4038.1519880825063, 4113.835446582133, 4132.876013719593, 4166.979165104185, 4168.062186008155, 80499.0, 80779.5961020197, 82255.58872205601, 83189.0, 84472.0, 12430.751384972249, 12466.439010244561, 12894.742105157844, 12910.741785164431, 13232.54442011378, 22772.0, 23127.7687223129, 23180.420489487897, 23250.41873953131, 23332.53334933292, 9370.67202647904, 9584.424934503952, 9597.919603847948, 9612.375195612263, 10031.247656425652, 4976.104301225741, 5055.0, 5064.290999260106, 5073.34046573943, 5124.359455068116, 3727.5340582427198, 3867.3812190049457, 3869.28418242626, 3869.613038696164, 3892.8832135035996, 654.3914159831307, 657.2966925389883, 660.3693472733528, 673.9224989126216, 683.8871586188224, 675.7297081167474, 803.1286054630791, 824.1922915542801, 835.9456635318807, 838.2204549768652, 9847.55685994132, 10073.395596264247, 10106.494675266355, 10128.696139115838, 10258.692239232834, 771.2865599320606, 779.8050487378156, 795.7016118955391, 803.4375936844233, 827.1810907201947, 4986.4514903360605, 5059.595232381401, 5080.7205603692155, 5098.821541246113, 5120.411152717411, 72692.63653681698, 82085.17914820775, 94721.5263923676, 120326.0, 124044.0, 66749.0, 85381.57309213415, 101070.0, 102659.4867025675, 104549.0, 88284.0, 90978.54510727536, 91650.0, 92106.53946730358, 92566.99999999865, 9810.705678829647, 10134.898651013396, 10416.11463025621, 10431.843522347323, 10490.895091048991, 54873.176902347295, 55301.44698552963, 55799.72100139473, 55983.72008139933, 57853.710731447754, 48899.0, 52075.47924520706, 53268.46731532635, 76688.2331176681, 78331.0, 12826.707665275597, 12877.162984405984, 13018.544350947672, 13274.867251327363, 13319.0, 14092.718145636825, 14209.928950355596, 14562.199079050753, 14576.416943322149, 15747.055176689435, 12693.492260309853, 12769.170003949714, 13363.997700172331, 13721.45114195421, 14043.929780351033, 13706.314684265946, 13726.176429414267, 13762.587122386345, 14070.507532236323, 14654.0, 12642.683932901751, 12939.0, 13257.088111134413, 13356.732865342445, 13484.393202306115, 11232.0, 11338.829917551408, 11454.66340635747, 11598.768024639628, 11935.94032029869, 11484.0, 11557.711057223636, 11802.350870702194, 11850.0, 12221.877781222074], "value": 7966.167848830038, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 104.0, 111.0, 109.0, 111.0, 114.0, 110.0, 110.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 159.0, 179.0, 126.0, 153.0, 152.0, 134.0, 180.0, 132.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 165.0, 163.0, 161.0, 162.0, 163.0, 161.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 183.0, 76.0, 75.0, 74.0, 78.0, 176.0, 76.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 158.0, 84.0, 85.0, 85.0, 138.0, 85.0, 85.0, 137.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 146.0, 146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 97.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 57.0, 53.0, 54.0, 53.0, 62.0, 52.0, 53.0, 52.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 77.0, 77.0, 77.0, 82.0, 78.0, 82.0, 105.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 129.0, 131.0, 137.0, 125.0, 130.0, 126.0, 124.0, 136.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 156.0, 158.0, 161.0, 153.0, 157.0, 157.0, 154.0, 155.0, 153.0], "value": 156.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 62.0, 61.0, 61.0, 66.0, 60.0, 62.0, 62.0, 60.0], "value": 62.7, "unit": "score"}]}]} 16:53:32 INFO - Return code: 0 16:53:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:53:32 ERROR - # TBPL SUCCESS # 16:53:32 INFO - Running post-action listener: _resource_record_post_action 16:53:32 INFO - ##### 16:53:32 INFO - ##### Finished run-tests step (success) 16:53:32 INFO - ##### 16:53:32 INFO - Running post-run listener: _resource_record_post_run 16:53:32 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 290816; Write bytes: 505262080; Read time: 40; Write time: 361976 16:53:32 INFO - TinderboxPrint: CPU usage
13.3% 16:53:32 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 40 16:53:32 INFO - TinderboxPrint: I/O write bytes / time
505,262,080 / 361,976 16:53:32 INFO - TinderboxPrint: CPU idle
8,215.1 (86.7%) 16:53:32 INFO - TinderboxPrint: CPU user
1,208.9 (12.8%) 16:53:32 INFO - TinderboxPrint: Swap in / out
0 / 0 16:53:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252641280; Read time: 0; Write time: 202996 16:53:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252620800; Read time: 28; Write time: 158980 16:53:33 INFO - Running post-run listener: _upload_blobber_files 16:53:33 INFO - Blob upload gear active. 16:53:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:53:33 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 16:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:53:33 INFO - (blobuploader) - INFO - Open directory for files ... 16:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:53:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:36 INFO - (blobuploader) - INFO - Done attempting. 16:53:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:53:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:53:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:37 INFO - (blobuploader) - INFO - Done attempting. 16:53:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:53:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:53:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:53:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:53:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:53:38 INFO - (blobuploader) - INFO - Done attempting. 16:53:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:53:38 INFO - Return code: 0 16:53:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:53:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:53:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4fea16dbe6c430694ba257844c733f47cf0f582dddc14441d629a69de952615f66e3c1a3e7b435d4afe2b219399a7da170e0ad1574d8b57e50144b6b879ec49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b313e8ea21610d30fab6dbd3d9482199e650f653dbf883882d48f9023b216b8f7c38bf1c388eed3a1ead1dbb962a9bf754b5a5ccf5b9c2dd946d62442112769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50a841271ac4460cdc793d558104c945204e1f00ef4b2e41ab0291dd434fc439f17e85b344dab708a0dde95a3bbe9d47ff32e23cd0344dff419d33981176c797"} 16:53:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:53:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:53:38 INFO - Contents: 16:53:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4fea16dbe6c430694ba257844c733f47cf0f582dddc14441d629a69de952615f66e3c1a3e7b435d4afe2b219399a7da170e0ad1574d8b57e50144b6b879ec49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b313e8ea21610d30fab6dbd3d9482199e650f653dbf883882d48f9023b216b8f7c38bf1c388eed3a1ead1dbb962a9bf754b5a5ccf5b9c2dd946d62442112769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50a841271ac4460cdc793d558104c945204e1f00ef4b2e41ab0291dd434fc439f17e85b344dab708a0dde95a3bbe9d47ff32e23cd0344dff419d33981176c797"} 16:53:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:53:38 INFO - Copying logs to upload dir... 16:53:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:53:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.280612 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-29 16:53:38.140136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 16:53:38.143874) ========= 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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4fea16dbe6c430694ba257844c733f47cf0f582dddc14441d629a69de952615f66e3c1a3e7b435d4afe2b219399a7da170e0ad1574d8b57e50144b6b879ec49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b313e8ea21610d30fab6dbd3d9482199e650f653dbf883882d48f9023b216b8f7c38bf1c388eed3a1ead1dbb962a9bf754b5a5ccf5b9c2dd946d62442112769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50a841271ac4460cdc793d558104c945204e1f00ef4b2e41ab0291dd434fc439f17e85b344dab708a0dde95a3bbe9d47ff32e23cd0344dff419d33981176c797"} build_url:https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/Il0-u5bTSQW6Pyi7QPBQAg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4fea16dbe6c430694ba257844c733f47cf0f582dddc14441d629a69de952615f66e3c1a3e7b435d4afe2b219399a7da170e0ad1574d8b57e50144b6b879ec49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b313e8ea21610d30fab6dbd3d9482199e650f653dbf883882d48f9023b216b8f7c38bf1c388eed3a1ead1dbb962a9bf754b5a5ccf5b9c2dd946d62442112769", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/50a841271ac4460cdc793d558104c945204e1f00ef4b2e41ab0291dd434fc439f17e85b344dab708a0dde95a3bbe9d47ff32e23cd0344dff419d33981176c797"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-29 16:53:38.169484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:53:38.169827) ========= 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=1f5564757af27664ca02d71f000001b0-1469834949.864671-1711573968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-29 16:53:38.255487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 16:53:38.255832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-29 16:53:38.256231) ========= ========= Total master_lag: 0.18 =========