builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1469873398.13 results: success (0) buildid: 20160729170826 builduid: 5bb96b5f7e074e778445d151ad800bd4 revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.127836) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.128784) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.129454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.145254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.145548) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:09:58-- 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% 89.0M=0s 2016-07-30 03:09:58 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.293653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.294430) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016185 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.348663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:58.349528) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589e1f984537e280ff84591e94afdc3c5bfe2710 --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 589e1f984537e280ff84591e94afdc3c5bfe2710 --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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:09:58,608 truncating revision to first 12 chars 2016-07-30 03:09:58,608 Setting DEBUG logging. 2016-07-30 03:09:58,608 attempt 1/10 2016-07-30 03:09:58,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589e1f984537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:09:58,909 unpacking tar archive at: mozilla-aurora-589e1f984537/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:59.007389) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:59.007750) ========= script_repo_revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:59.008204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:59.008507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:09:59.017545) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-30 03:09:59.017849) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:09:59 INFO - MultiFileLogger online at 20160730 03:09:59 in /builds/slave/test 03:09:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:09:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:09:59 INFO - {'append_to_log': False, 03:09:59 INFO - 'base_work_dir': '/builds/slave/test', 03:09:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:09:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:09:59 INFO - 'branch': 'Mozilla-Aurora', 03:09:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:09:59 INFO - 'config_files': ('talos/linux_config.py',), 03:09:59 INFO - 'default_actions': ('clobber', 03:09:59 INFO - 'read-buildbot-config', 03:09:59 INFO - 'download-and-extract', 03:09:59 INFO - 'populate-webroot', 03:09:59 INFO - 'create-virtualenv', 03:09:59 INFO - 'install', 03:09:59 INFO - 'run-tests'), 03:09:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:09:59 INFO - 'download_minidump_stackwalk': True, 03:09:59 INFO - 'download_symbols': 'ondemand', 03:09:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:09:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:09:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:09:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:09:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:09:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:09:59 INFO - 'installer_path': 'installer.exe', 03:09:59 INFO - 'log_level': 'info', 03:09:59 INFO - 'log_name': 'talos', 03:09:59 INFO - 'log_to_console': True, 03:09:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:09:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:09:59 INFO - 'opt_config_files': (), 03:09:59 INFO - 'pip_index': False, 03:09:59 INFO - 'sps_profile': False, 03:09:59 INFO - 'sps_profile_interval': 0, 03:09:59 INFO - 'suite': 'dromaeojs', 03:09:59 INFO - 'system_bits': '32', 03:09:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:09:59 INFO - 'title': 'talos-linux64-ix-033', 03:09:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:09:59 INFO - 'use_talos_json': True, 03:09:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:09:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:09:59 INFO - 'work_dir': 'build'} 03:09:59 INFO - ##### 03:09:59 INFO - ##### Running clobber step. 03:09:59 INFO - ##### 03:09:59 INFO - Running pre-action listener: _resource_record_pre_action 03:09:59 INFO - Running main action method: clobber 03:09:59 INFO - rmtree: /builds/slave/test/build 03:09:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:09:59 INFO - Running post-action listener: _resource_record_post_action 03:09:59 INFO - ##### 03:09:59 INFO - ##### Finished clobber step (success) 03:09:59 INFO - ##### 03:09:59 INFO - ##### 03:09:59 INFO - ##### Running read-buildbot-config step. 03:09:59 INFO - ##### 03:09:59 INFO - Running pre-action listener: _resource_record_pre_action 03:09:59 INFO - Running main action method: read_buildbot_config 03:09:59 INFO - Using buildbot properties: 03:09:59 INFO - { 03:09:59 INFO - "project": "", 03:09:59 INFO - "product": "firefox", 03:09:59 INFO - "script_repo_revision": "production", 03:09:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:09:59 INFO - "repository": "", 03:09:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:09:59 INFO - "buildid": "20160729170826", 03:09:59 INFO - "pgo_build": "True", 03:09:59 INFO - "basedir": "/builds/slave/test", 03:09:59 INFO - "buildnumber": 434, 03:09:59 INFO - "slavename": "talos-linux64-ix-033", 03:09:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:09:59 INFO - "platform": "ubuntu64_hw", 03:09:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:09:59 INFO - "branch": "mozilla-aurora", 03:09:59 INFO - "repo_path": "releases/mozilla-aurora", 03:09:59 INFO - "revision": "589e1f984537e280ff84591e94afdc3c5bfe2710", 03:09:59 INFO - "stage_platform": "linux64-pgo", 03:09:59 INFO - "builduid": "5bb96b5f7e074e778445d151ad800bd4", 03:09:59 INFO - "slavebuilddir": "test" 03:09:59 INFO - } 03:09:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:09:59 INFO - Running post-action listener: _resource_record_post_action 03:09:59 INFO - ##### 03:09:59 INFO - ##### Finished read-buildbot-config step (success) 03:09:59 INFO - ##### 03:09:59 INFO - ##### 03:09:59 INFO - ##### Running download-and-extract step. 03:09:59 INFO - ##### 03:09:59 INFO - Running pre-action listener: _resource_record_pre_action 03:09:59 INFO - Running main action method: download_and_extract 03:09:59 INFO - mkdir: /builds/slave/test/build/tests 03:09: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')]} 03:09:59 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:09:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:09:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:09:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:00 INFO - Downloaded 1361 bytes. 03:10:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:10:00 INFO - Using the following test package requirements: 03:10:00 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:10:00 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:10:00 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:10:00 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'jsshell-linux-x86_64.zip'], 03:10:00 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:10:00 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:10:00 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:10:00 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:10:00 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:10:00 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:10:00 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:10:00 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:10: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')]} 03:10:00 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:10:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:10:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:01 INFO - Downloaded 24496939 bytes. 03:10:01 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'] 03:10:01 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 03:10:02 INFO - Return code: 0 03:10:02 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 03:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:02 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:03 INFO - Downloaded 24496939 bytes. 03:10:03 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'] 03:10:03 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 03:10:05 INFO - Return code: 0 03:10: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')]} 03:10:05 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:06 INFO - Downloaded 10833369 bytes. 03:10:06 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'] 03:10:06 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 03:10:06 INFO - Return code: 0 03:10:06 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')]} 03:10:06 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:10:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:10:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:10:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:10:07 INFO - Downloaded 63648271 bytes. 03:10:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:10:07 INFO - mkdir: /builds/slave/test/properties 03:10:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:10:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:10:07 INFO - Contents: 03:10:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:10:08 INFO - Running post-action listener: _resource_record_post_action 03:10:08 INFO - Running post-action listener: set_extra_try_arguments 03:10:08 INFO - ##### 03:10:08 INFO - ##### Finished download-and-extract step (success) 03:10:08 INFO - ##### 03:10:08 INFO - ##### 03:10:08 INFO - ##### Running populate-webroot step. 03:10:08 INFO - ##### 03:10:08 INFO - Running pre-action listener: _resource_record_pre_action 03:10:08 INFO - Running main action method: populate_webroot 03:10:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:10:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:10:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:10:08 INFO - '--tppagecycles', 03:10:08 INFO - '7'], 03:10:08 INFO - 'tests': ['tsvgm']}}, 03:10:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:10:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:10:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:10:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:10:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:10:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['damp', 'tps']}, 03:10:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'tests': ['damp', 'tps']}, 03:10:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['dromaeo_dom']}, 03:10:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:10:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['a11yr', 03:10:08 INFO - 'ts_paint', 03:10:08 INFO - 'tpaint', 03:10:08 INFO - 'sessionrestore', 03:10:08 INFO - 'sessionrestore_no_auto_restore', 03:10:08 INFO - 'tabpaint']}, 03:10:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['tsvgx', 03:10:08 INFO - 'tsvgr_opacity', 03:10:08 INFO - 'tart', 03:10:08 INFO - 'tscrollx', 03:10:08 INFO - 'cart']}, 03:10:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:10:08 INFO - 'tsvgr_opacity', 03:10:08 INFO - 'tart', 03:10:08 INFO - 'tscrollx', 03:10:08 INFO - 'cart']}, 03:10:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'talos_options': ['--disable-e10s'], 03:10:08 INFO - 'tests': ['tp5o']}, 03:10:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'tests': ['tp5o']}, 03:10:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'talos_options': ['--disable-e10s', 03:10:08 INFO - '--xperf_path', 03:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:08 INFO - 'tests': ['tp5n']}, 03:10:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:10:08 INFO - 'talos_options': ['--xperf_path', 03:10:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:10:08 INFO - 'tests': ['tp5n']}}, 03:10:08 INFO - 'talos.zip': {'path': '', 03:10:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:10:08 INFO - Running post-action listener: _resource_record_post_action 03:10:08 INFO - ##### 03:10:08 INFO - ##### Finished populate-webroot step (success) 03:10:08 INFO - ##### 03:10:08 INFO - ##### 03:10:08 INFO - ##### Running create-virtualenv step. 03:10:08 INFO - ##### 03:10:08 INFO - Running pre-action listener: _resource_record_pre_action 03:10:08 INFO - Running main action method: create_virtualenv 03:10:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:10:08 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 03:10:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:10:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:10:08 INFO - Using real prefix '/usr' 03:10:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:10:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:10:11 INFO - Installing pip.................done. 03:10:11 INFO - Return code: 0 03:10:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:10:11 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')]} 03:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:11 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')]} 03:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:11 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:11 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 03:10:11 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 03:10:11 INFO - Using env: {'DISPLAY': ':0', 03:10:11 INFO - 'HOME': '/home/cltbld', 03:10:11 INFO - 'LANG': 'en_US.UTF-8', 03:10:11 INFO - 'LANGUAGE': 'en_US:en', 03:10:11 INFO - 'LOGNAME': 'cltbld', 03:10:11 INFO - 'MAIL': '/var/mail/cltbld', 03:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:11 INFO - 'MOZ_NO_REMOTE': '1', 03:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:11 INFO - 'NO_EM_RESTART': '1', 03:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:11 INFO - 'PWD': '/builds/slave/test', 03:10:11 INFO - 'SHELL': '/bin/bash', 03:10:11 INFO - 'SHLVL': '1', 03:10:11 INFO - 'TERM': 'linux', 03:10:11 INFO - 'TMOUT': '86400', 03:10:11 INFO - 'USER': 'cltbld', 03:10:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:11 INFO - '_': '/tools/buildbot/bin/python'} 03:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:11 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 03:10:11 INFO - Cleaning up... 03:10:11 INFO - Return code: 0 03:10:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:10:11 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')]} 03:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:11 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')]} 03:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:11 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:11 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 03:10:11 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 03:10:11 INFO - Using env: {'DISPLAY': ':0', 03:10:11 INFO - 'HOME': '/home/cltbld', 03:10:11 INFO - 'LANG': 'en_US.UTF-8', 03:10:11 INFO - 'LANGUAGE': 'en_US:en', 03:10:11 INFO - 'LOGNAME': 'cltbld', 03:10:11 INFO - 'MAIL': '/var/mail/cltbld', 03:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:11 INFO - 'MOZ_NO_REMOTE': '1', 03:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:11 INFO - 'NO_EM_RESTART': '1', 03:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:11 INFO - 'PWD': '/builds/slave/test', 03:10:11 INFO - 'SHELL': '/bin/bash', 03:10:11 INFO - 'SHLVL': '1', 03:10:11 INFO - 'TERM': 'linux', 03:10:11 INFO - 'TMOUT': '86400', 03:10:11 INFO - 'USER': 'cltbld', 03:10:11 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:11 INFO - '_': '/tools/buildbot/bin/python'} 03:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:11 INFO - Downloading/unpacking psutil>=3.1.1 03:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:10:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:13 INFO - Installing collected packages: psutil 03:10:13 INFO - Running setup.py install for psutil 03:10:13 INFO - building 'psutil._psutil_linux' extension 03:10:13 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 03:10:13 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 03:10:13 INFO - building 'psutil._psutil_posix' extension 03:10:13 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 03:10:13 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 03:10:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:10:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:10:14 INFO - Successfully installed psutil 03:10:14 INFO - Cleaning up... 03:10:14 INFO - Return code: 0 03:10:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:10:14 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')]} 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:14 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')]} 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:14 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:14 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 03:10:14 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 03:10:14 INFO - Using env: {'DISPLAY': ':0', 03:10:14 INFO - 'HOME': '/home/cltbld', 03:10:14 INFO - 'LANG': 'en_US.UTF-8', 03:10:14 INFO - 'LANGUAGE': 'en_US:en', 03:10:14 INFO - 'LOGNAME': 'cltbld', 03:10:14 INFO - 'MAIL': '/var/mail/cltbld', 03:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:14 INFO - 'MOZ_NO_REMOTE': '1', 03:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:14 INFO - 'NO_EM_RESTART': '1', 03:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:14 INFO - 'PWD': '/builds/slave/test', 03:10:14 INFO - 'SHELL': '/bin/bash', 03:10:14 INFO - 'SHLVL': '1', 03:10:14 INFO - 'TERM': 'linux', 03:10:14 INFO - 'TMOUT': '86400', 03:10:14 INFO - 'USER': 'cltbld', 03:10:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:14 INFO - '_': '/tools/buildbot/bin/python'} 03:10:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:10:16 INFO - Installing collected packages: mozsystemmonitor 03:10:16 INFO - Running setup.py install for mozsystemmonitor 03:10:16 INFO - Successfully installed mozsystemmonitor 03:10:16 INFO - Cleaning up... 03:10:16 INFO - Return code: 0 03:10:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:10:16 INFO - Using env: {'DISPLAY': ':0', 03:10:16 INFO - 'HOME': '/home/cltbld', 03:10:16 INFO - 'LANG': 'en_US.UTF-8', 03:10:16 INFO - 'LANGUAGE': 'en_US:en', 03:10:16 INFO - 'LOGNAME': 'cltbld', 03:10:16 INFO - 'MAIL': '/var/mail/cltbld', 03:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:16 INFO - 'MOZ_NO_REMOTE': '1', 03:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:16 INFO - 'NO_EM_RESTART': '1', 03:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:16 INFO - 'PWD': '/builds/slave/test', 03:10:16 INFO - 'SHELL': '/bin/bash', 03:10:16 INFO - 'SHLVL': '1', 03:10:16 INFO - 'TERM': 'linux', 03:10:16 INFO - 'TMOUT': '86400', 03:10:16 INFO - 'USER': 'cltbld', 03:10:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:16 INFO - '_': '/tools/buildbot/bin/python'} 03:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:16 INFO - Downloading/unpacking jsonschema==2.5.1 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:10:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:18 INFO - Downloading functools32-3.2.3-2.tar.gz 03:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:10:18 INFO - warning: no files found matching '*.txt' 03:10:18 INFO - no previously-included directories found matching 'build' 03:10:18 INFO - no previously-included directories found matching 'dist' 03:10:18 INFO - no previously-included directories found matching '.git*' 03:10:18 INFO - Installing collected packages: jsonschema, functools32 03:10:18 INFO - Running setup.py install for functools32 03:10:18 INFO - warning: no files found matching '*.txt' 03:10:18 INFO - no previously-included directories found matching 'build' 03:10:18 INFO - no previously-included directories found matching 'dist' 03:10:18 INFO - no previously-included directories found matching '.git*' 03:10:18 INFO - Successfully installed jsonschema functools32 03:10:18 INFO - Cleaning up... 03:10:18 INFO - Return code: 0 03:10:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:10:18 INFO - Using env: {'DISPLAY': ':0', 03:10:18 INFO - 'HOME': '/home/cltbld', 03:10:18 INFO - 'LANG': 'en_US.UTF-8', 03:10:18 INFO - 'LANGUAGE': 'en_US:en', 03:10:18 INFO - 'LOGNAME': 'cltbld', 03:10:18 INFO - 'MAIL': '/var/mail/cltbld', 03:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:18 INFO - 'MOZ_NO_REMOTE': '1', 03:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:18 INFO - 'NO_EM_RESTART': '1', 03:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:18 INFO - 'PWD': '/builds/slave/test', 03:10:18 INFO - 'SHELL': '/bin/bash', 03:10:18 INFO - 'SHLVL': '1', 03:10:18 INFO - 'TERM': 'linux', 03:10:18 INFO - 'TMOUT': '86400', 03:10:18 INFO - 'USER': 'cltbld', 03:10:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:18 INFO - '_': '/tools/buildbot/bin/python'} 03:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:19 INFO - Downloading/unpacking blobuploader==1.2.4 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:21 INFO - Downloading blobuploader-1.2.4.tar.gz 03:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:10:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:10:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:10:21 INFO - Downloading docopt-0.6.1.tar.gz 03:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:10:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:10:21 INFO - Running setup.py install for blobuploader 03:10:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:10:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:10:22 INFO - Running setup.py install for requests 03:10:22 INFO - Running setup.py install for docopt 03:10:22 INFO - Successfully installed blobuploader requests docopt 03:10:22 INFO - Cleaning up... 03:10:22 INFO - Return code: 0 03:10:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:22 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:22 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 03:10:22 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 03:10:22 INFO - Using env: {'DISPLAY': ':0', 03:10:22 INFO - 'HOME': '/home/cltbld', 03:10:22 INFO - 'LANG': 'en_US.UTF-8', 03:10:22 INFO - 'LANGUAGE': 'en_US:en', 03:10:22 INFO - 'LOGNAME': 'cltbld', 03:10:22 INFO - 'MAIL': '/var/mail/cltbld', 03:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:22 INFO - 'MOZ_NO_REMOTE': '1', 03:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:22 INFO - 'NO_EM_RESTART': '1', 03:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:22 INFO - 'PWD': '/builds/slave/test', 03:10:22 INFO - 'SHELL': '/bin/bash', 03:10:22 INFO - 'SHLVL': '1', 03:10:22 INFO - 'TERM': 'linux', 03:10:22 INFO - 'TMOUT': '86400', 03:10:22 INFO - 'USER': 'cltbld', 03:10:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:22 INFO - '_': '/tools/buildbot/bin/python'} 03:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:22 INFO - Running setup.py (path:/tmp/pip-0wmrGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:22 INFO - Running setup.py (path:/tmp/pip-n2gSAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:22 INFO - Running setup.py (path:/tmp/pip-_H0WkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:22 INFO - Running setup.py (path:/tmp/pip-IE5mgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:23 INFO - Running setup.py (path:/tmp/pip-nfvIxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:23 INFO - Running setup.py (path:/tmp/pip-twBNud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:23 INFO - Running setup.py (path:/tmp/pip-ebPIk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:23 INFO - Running setup.py (path:/tmp/pip-UTcTyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:23 INFO - Running setup.py (path:/tmp/pip-zHwKtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:23 INFO - Running setup.py (path:/tmp/pip-isW4Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:23 INFO - Running setup.py (path:/tmp/pip-5nm5cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:23 INFO - Running setup.py (path:/tmp/pip-7h1Inq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:23 INFO - Running setup.py (path:/tmp/pip-IamUKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:23 INFO - Running setup.py (path:/tmp/pip-vY3pEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:23 INFO - Running setup.py (path:/tmp/pip-2MvpzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:23 INFO - Running setup.py (path:/tmp/pip-8amdtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:23 INFO - Running setup.py (path:/tmp/pip-w2JzAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:10:24 INFO - Running setup.py install for manifestparser 03:10:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Running setup.py install for mozcrash 03:10:24 INFO - Running setup.py install for mozdebug 03:10:24 INFO - Running setup.py install for mozdevice 03:10:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Running setup.py install for mozfile 03:10:24 INFO - Running setup.py install for mozhttpd 03:10:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Running setup.py install for mozinfo 03:10:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Running setup.py install for mozInstall 03:10:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:10:24 INFO - Running setup.py install for mozleak 03:10:24 INFO - Running setup.py install for mozlog 03:10:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Running setup.py install for moznetwork 03:10:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Running setup.py install for mozprocess 03:10:25 INFO - Running setup.py install for mozprofile 03:10:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Running setup.py install for mozrunner 03:10:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Running setup.py install for mozscreenshot 03:10:25 INFO - Running setup.py install for moztest 03:10:25 INFO - Running setup.py install for mozversion 03:10:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:10:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:10:25 INFO - Cleaning up... 03:10:25 INFO - Return code: 0 03:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:25 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:25 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 03:10:25 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 03:10:25 INFO - Using env: {'DISPLAY': ':0', 03:10:25 INFO - 'HOME': '/home/cltbld', 03:10:25 INFO - 'LANG': 'en_US.UTF-8', 03:10:25 INFO - 'LANGUAGE': 'en_US:en', 03:10:25 INFO - 'LOGNAME': 'cltbld', 03:10:25 INFO - 'MAIL': '/var/mail/cltbld', 03:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:25 INFO - 'MOZ_NO_REMOTE': '1', 03:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:25 INFO - 'NO_EM_RESTART': '1', 03:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:25 INFO - 'PWD': '/builds/slave/test', 03:10:25 INFO - 'SHELL': '/bin/bash', 03:10:25 INFO - 'SHLVL': '1', 03:10:25 INFO - 'TERM': 'linux', 03:10:25 INFO - 'TMOUT': '86400', 03:10:25 INFO - 'USER': 'cltbld', 03:10:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:25 INFO - '_': '/tools/buildbot/bin/python'} 03:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:10:26 INFO - Running setup.py (path:/tmp/pip-4dyCV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:10:26 INFO - Running setup.py (path:/tmp/pip-NLnwPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:10:26 INFO - Running setup.py (path:/tmp/pip-dAhVcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:10:26 INFO - Running setup.py (path:/tmp/pip-zEVGox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:10:26 INFO - Running setup.py (path:/tmp/pip-SQViNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:10:26 INFO - Running setup.py (path:/tmp/pip-g9NVEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:10:26 INFO - Running setup.py (path:/tmp/pip-BXyo1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:10:26 INFO - Running setup.py (path:/tmp/pip-wT_9rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:10:26 INFO - Running setup.py (path:/tmp/pip-QGLVYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:10:26 INFO - Running setup.py (path:/tmp/pip-hEIxcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:10:26 INFO - Running setup.py (path:/tmp/pip-b1xyo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:10:26 INFO - Running setup.py (path:/tmp/pip-w6Ifu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:10:26 INFO - Running setup.py (path:/tmp/pip-96BqLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:10:26 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)) 03:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:10:26 INFO - Running setup.py (path:/tmp/pip-6bRult-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:10:27 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)) 03:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:27 INFO - Running setup.py (path:/tmp/pip-XY_nYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:10:27 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)) 03:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:10:27 INFO - Running setup.py (path:/tmp/pip-4rXAf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:10:27 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)) 03:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:10:27 INFO - Running setup.py (path:/tmp/pip-1Lo1zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 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)) 03:10:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:29 INFO - Downloading blessings-1.6.tar.gz 03:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:10:29 INFO - Installing collected packages: blessings 03:10:29 INFO - Running setup.py install for blessings 03:10:29 INFO - Successfully installed blessings 03:10:29 INFO - Cleaning up... 03:10:29 INFO - Return code: 0 03:10:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:10:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:29 INFO - Reading from file tmpfile_stdout 03:10:29 INFO - Current package versions: 03:10:29 INFO - argparse == 1.2.1 03:10:29 INFO - blessings == 1.6 03:10:29 INFO - blobuploader == 1.2.4 03:10:29 INFO - docopt == 0.6.1 03:10:29 INFO - functools32 == 3.2.3-2 03:10:29 INFO - jsonschema == 2.5.1 03:10:29 INFO - manifestparser == 1.1 03:10:29 INFO - mozInstall == 1.12 03:10:29 INFO - mozcrash == 0.17 03:10:29 INFO - mozdebug == 0.1 03:10:29 INFO - mozdevice == 0.48 03:10:29 INFO - mozfile == 1.2 03:10:29 INFO - mozhttpd == 0.7 03:10:29 INFO - mozinfo == 0.9 03:10:29 INFO - mozleak == 0.1 03:10:29 INFO - mozlog == 3.2 03:10:29 INFO - moznetwork == 0.27 03:10:29 INFO - mozprocess == 0.23 03:10:29 INFO - mozprofile == 0.28 03:10:29 INFO - mozrunner == 6.12 03:10:29 INFO - mozscreenshot == 0.1 03:10:29 INFO - mozsystemmonitor == 0.3 03:10:29 INFO - moztest == 0.7 03:10:29 INFO - mozversion == 1.4 03:10:29 INFO - psutil == 3.1.1 03:10:29 INFO - requests == 1.2.3 03:10:29 INFO - wsgiref == 0.1.2 03:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:29 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:29 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 03:10:29 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 03:10:29 INFO - Using env: {'DISPLAY': ':0', 03:10:29 INFO - 'HOME': '/home/cltbld', 03:10:29 INFO - 'LANG': 'en_US.UTF-8', 03:10:29 INFO - 'LANGUAGE': 'en_US:en', 03:10:29 INFO - 'LOGNAME': 'cltbld', 03:10:29 INFO - 'MAIL': '/var/mail/cltbld', 03:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:29 INFO - 'MOZ_NO_REMOTE': '1', 03:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:29 INFO - 'NO_EM_RESTART': '1', 03:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:29 INFO - 'PWD': '/builds/slave/test', 03:10:29 INFO - 'SHELL': '/bin/bash', 03:10:29 INFO - 'SHLVL': '1', 03:10:29 INFO - 'TERM': 'linux', 03:10:29 INFO - 'TMOUT': '86400', 03:10:29 INFO - 'USER': 'cltbld', 03:10:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:29 INFO - '_': '/tools/buildbot/bin/python'} 03:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 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)) 03:10:29 INFO - Cleaning up... 03:10:29 INFO - Return code: 0 03:10:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10:29 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 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10:29 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 03:10:29 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 03:10:29 INFO - Using env: {'DISPLAY': ':0', 03:10:29 INFO - 'HOME': '/home/cltbld', 03:10:29 INFO - 'LANG': 'en_US.UTF-8', 03:10:29 INFO - 'LANGUAGE': 'en_US:en', 03:10:29 INFO - 'LOGNAME': 'cltbld', 03:10:29 INFO - 'MAIL': '/var/mail/cltbld', 03:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:29 INFO - 'MOZ_NO_REMOTE': '1', 03:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:29 INFO - 'NO_EM_RESTART': '1', 03:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:29 INFO - 'PWD': '/builds/slave/test', 03:10:29 INFO - 'SHELL': '/bin/bash', 03:10:29 INFO - 'SHLVL': '1', 03:10:29 INFO - 'TERM': 'linux', 03:10:29 INFO - 'TMOUT': '86400', 03:10:29 INFO - 'USER': 'cltbld', 03:10:29 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:29 INFO - '_': '/tools/buildbot/bin/python'} 03:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:10:30 INFO - Cleaning up... 03:10:30 INFO - Return code: 0 03:10:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:10: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')]} 03:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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')]} 03:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:10: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f362029ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23cc350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', '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 03:10: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', 'flake8'] in /builds/slave/test/build 03:10: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 flake8 03:10:30 INFO - Using env: {'DISPLAY': ':0', 03:10:30 INFO - 'HOME': '/home/cltbld', 03:10:30 INFO - 'LANG': 'en_US.UTF-8', 03:10:30 INFO - 'LANGUAGE': 'en_US:en', 03:10:30 INFO - 'LOGNAME': 'cltbld', 03:10:30 INFO - 'MAIL': '/var/mail/cltbld', 03:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:30 INFO - 'MOZ_NO_REMOTE': '1', 03:10:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:30 INFO - 'NO_EM_RESTART': '1', 03:10:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:30 INFO - 'PWD': '/builds/slave/test', 03:10:30 INFO - 'SHELL': '/bin/bash', 03:10:30 INFO - 'SHLVL': '1', 03:10:30 INFO - 'TERM': 'linux', 03:10:30 INFO - 'TMOUT': '86400', 03:10:30 INFO - 'USER': 'cltbld', 03:10:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:30 INFO - '_': '/tools/buildbot/bin/python'} 03:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:10:30 INFO - Downloading/unpacking flake8 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:10:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:10:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10: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 03:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:32 INFO - no previously-included directories found matching 'docs/_build' 03:10:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:10:32 INFO - Running setup.py install for pep8 03:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:10:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:10:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:10:33 INFO - no previously-included directories found matching 'docs/_build' 03:10:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:10:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:10:33 INFO - Cleaning up... 03:10:33 INFO - Return code: 0 03:10:33 INFO - Running post-action listener: _resource_record_post_action 03:10:33 INFO - Running post-action listener: _start_resource_monitoring 03:10:33 INFO - Starting resource monitoring. 03:10:33 INFO - ##### 03:10:33 INFO - ##### Finished create-virtualenv step (success) 03:10:33 INFO - ##### 03:10:33 INFO - ##### 03:10:33 INFO - ##### Running install step. 03:10:33 INFO - ##### 03:10:33 INFO - Running pre-action listener: _resource_record_pre_action 03:10:33 INFO - Running main action method: install 03:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:10:33 INFO - Reading from file tmpfile_stdout 03:10:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:10:33 INFO - Reading from file tmpfile_stdout 03:10:33 INFO - Output received: 03:10:33 INFO - Usage: mozinstall [options] installer 03:10:33 INFO - Options: 03:10:33 INFO - -h, --help show this help message and exit 03:10:33 INFO - -d DEST, --destination=DEST 03:10:33 INFO - Directory to install application into. [default: 03:10:33 INFO - "/builds/slave/test"] 03:10:33 INFO - --app=APP Application being installed. [default: firefox] 03:10:33 INFO - mkdir: /builds/slave/test/build/application 03:10:33 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'] 03:10:33 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 03:10:49 INFO - Reading from file tmpfile_stdout 03:10:49 INFO - Output received: 03:10:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:10:49 INFO - Running post-action listener: _resource_record_post_action 03:10:49 INFO - ##### 03:10:49 INFO - ##### Finished install step (success) 03:10:49 INFO - ##### 03:10:49 INFO - ##### 03:10:49 INFO - ##### Running run-tests step. 03:10:49 INFO - ##### 03:10:49 INFO - Running pre-action listener: _resource_record_pre_action 03:10:49 INFO - Running main action method: run_tests 03:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:10:49 INFO - Python 2.7.3 03:10:49 INFO - Return code: 0 03:10:49 INFO - grabbing minidump binary from tooltool 03:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:49 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 0x245b1c0>, '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 0x245c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x245c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:10:49 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 03:10:49 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 03:10:49 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 03:10:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:10:49 INFO - Return code: 0 03:10:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:10:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:10:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:10:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:10:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:10:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:10:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:10:50 INFO - Return code: 0 03:10:50 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:10:50 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:10:50 INFO - Using env: {'DISPLAY': ':0', 03:10:50 INFO - 'HOME': '/home/cltbld', 03:10:50 INFO - 'LANG': 'en_US.UTF-8', 03:10:50 INFO - 'LANGUAGE': 'en_US:en', 03:10:50 INFO - 'LOGNAME': 'cltbld', 03:10:50 INFO - 'MAIL': '/var/mail/cltbld', 03:10:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:10:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:10:50 INFO - 'MOZ_NO_REMOTE': '1', 03:10:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:10:50 INFO - 'NO_EM_RESTART': '1', 03:10:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:10:50 INFO - 'PWD': '/builds/slave/test', 03:10:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:10:50 INFO - 'SHELL': '/bin/bash', 03:10:50 INFO - 'SHLVL': '1', 03:10:50 INFO - 'TERM': 'linux', 03:10:50 INFO - 'TMOUT': '86400', 03:10:50 INFO - 'USER': 'cltbld', 03:10:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303', 03:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:10:50 INFO - '_': '/tools/buildbot/bin/python'} 03:10:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:10:50 INFO - mozversion application_buildid: 20160729170826 03:10:50 INFO - mozversion application_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:10:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:10:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:10:50 INFO - mozversion application_name: Firefox 03:10:50 INFO - mozversion application_remotingname: firefox-dev 03:10:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:50 INFO - mozversion application_vendor: Mozilla 03:10:50 INFO - mozversion application_version: 49.0a2 03:10:50 INFO - mozversion platform_buildid: 20160729170826 03:10:50 INFO - mozversion platform_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:10:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:10:50 INFO - mozversion platform_version: 49.0a2 03:10:50 INFO - using testdate: 1469873450 03:10:50 INFO - actual date: 1469873450 03:10:50 INFO - starting webserver on 'localhost:53722' 03:10:50 INFO - SUITE-START | Running 2 tests 03:10:50 INFO - TEST-START | dromaeo_css 03:10:50 INFO - operating with platform_type : linux_ 03:10:50 INFO - Initialising browser for dromaeo_css test... 03:10:50 INFO - TEST-INFO | started process 27580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9y7jx/profile http://localhost:53722/getInfo.html) 03:10:55 INFO - PROCESS | 27580 | __metrics Screen width/height:1600/1200 03:10:55 INFO - PROCESS | 27580 | colorDepth:24 03:10:55 INFO - PROCESS | 27580 | Browser inner width/height: 1024/697 03:10:55 INFO - PROCESS | 27580 | __metrics 03:10:56 INFO - PROCESS | 27580 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:10:56 ERROR - PROCESS | 27580 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:10:57 INFO - TEST-INFO | 27580: exit 0 03:10:57 INFO - Browser initialized. 03:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:10:57 INFO - TEST-INFO | started process 27673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph9y7jx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:09 INFO - PROCESS | 27673 | RSS: Main: 148377600 03:11:09 INFO - PROCESS | 27673 | 03:12:00 INFO - PROCESS | 27673 | 1469873520213 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] 03:14:08 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53722/tests/dromaeo/cssquery-ext.html) 03:14:09 INFO - PROCESS | 27673 | RSS: Main: 252608512 03:14:09 INFO - PROCESS | 27673 | 03:17:11 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-ext.html (next: http://localhost:53722/tests/dromaeo/cssquery-jquery.html) 03:17:12 INFO - PROCESS | 27673 | RSS: Main: 235630592 03:17:12 INFO - PROCESS | 27673 | 03:20:14 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53722/tests/dromaeo/cssquery-mootools.html) 03:20:14 INFO - PROCESS | 27673 | RSS: Main: 237273088 03:20:14 INFO - PROCESS | 27673 | 03:23:16 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53722/tests/dromaeo/cssquery-prototype.html) 03:23:17 INFO - PROCESS | 27673 | RSS: Main: 227987456 03:23:17 INFO - PROCESS | 27673 | 03:26:20 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53722/tests/dromaeo/cssquery-yui.html) 03:26:20 INFO - PROCESS | 27673 | RSS: Main: 195907584 03:26:20 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | Cycle 1(1): loaded http://localhost:53722/tests/dromaeo/cssquery-yui.html (next: http://localhost:53722/tests/dromaeo/cssquery-dojo.html) 03:29:23 INFO - PROCESS | 27673 | RSS: Main: 260644864 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | __start_tp_report 03:29:23 INFO - PROCESS | 27673 | _x_x_mozilla_page_load 03:29:23 INFO - PROCESS | 27673 | _x_x_mozilla_page_load_details 03:29:23 INFO - PROCESS | 27673 | |i|pagename|runs| 03:29:23 INFO - PROCESS | 27673 | |0;dojo.html;3302.7027567518926;3330.7168890644293;3332.1336452522337;3340.36533058719;3382.4926261060837;5404.621676482643;5470.726463676815;5482.150266708666;5508.338999320087;5517.062099443095;5442.374126975399;5492.011437941169;5497.862553436156;5505.724713764316;5531.197976293445;4849.24836650318;4934.629902757299;4951.331570238026;4988.65079444439;5014.774335154909;4835.564799168074;4969.329140566014;4991.40103187618;5001.299818025479;5003.12445322069;4928.236123400879;4932.210846264598;4938.38270216223;4954.504549545035;4977.47736487669;5043.646944713872;5045.041442125985;5057.898842023139;5072.188449848043;5081.136206844845;4848.757562121879;4868.805247790084;4928.334674818925;4966.379202599675;4979.8008079676765;5334.093204155303;5349.411564727877;5371.221172929942;5377;5405.972970135124;5858.238429004245;5868.941310586925;5889.941100589025;5908.261467316585;5919.940800591982;5785.47930686236;5836.737346819404;5859.736311865933;5916.083007133901;5946.524278057745;5483.643563168382;5518.448155184449;5533.861653458695;5536.2249285099315;5536.612437129403;5723;6009.098635204667;6022.789202377896;6023.367546407564;6024.3072046714315;5678.659280443104;5706.857328566819;5737.569682273846;5784.71076446176;5811.564132690065;5836.620619659709;5838.32859221195;5838.416158384212;5875.059990401515;5885.470307672244;5571.526420254243;5682.431756824284;5830.067189249699;5841.4450627190345;5851.297844258716;5701.686407247641;5769.913451298234;5771.394003629643;5788;5813.447722466359;4456.242438785414;4464.6428285737065;4465.910681786346;4475.686701930834;4489.775511224426;3968.960310396859;3984.960150398459;4002.779847108437;4024.054347228399;4040.717149799486;5561.527270181999;5569.777208911598;5578.525825304813;5590.413006634326;5618.325800903917;5860.238169037998;5864.618799778086;5876.706164691748;5886.852828679232;5915.615484993462;5428.67427954324;5444.8366549003595;5485.835424937259;5527.972360138174;5579.525740312038;4976.850694479099;4982.701037937735;4983.975080124576;4985.451600323961;4998.450170481244;5967.224260846062;5987.850303742354;6010.639361638316;6025.758969641253;6049.939500604937;5726.856828579319;5736.110902810071;5815.127730840408;5828.417158284137;5842.5325973921135;6128.233970753656;6134.6625935573975;6140.17107690456;6140.416660417253;6142.078688196806;5780.190773291826;5796.594238403271;5804.1293805929445;5806.912896306643;5808.796692115756;5691.089425691869;5693.259876216065;5749.367569567428;5755.280589926259;5830.7959221427045;5671.347795003628;5684.147377893349;5684.261046064151;5686.744096515584;5689.914651280317;5465.9726701366235;5658.066419040812;5679.630823996427;5685.744141513559;5685.857853553694;5579.6652200868075;5580.21876937221;5586.636868603528;5627.0434026214825;5677.687727175045;5735.9139612905;5778.682172480554;5793.391693872083;5816.302043754607;5820.185174075717;5536.584756143386;5579.609427340048;5660.066089095253;5660.094384898396;5691.032524470767 03:29:23 INFO - PROCESS | 27673 | |1;ext.html;562.8339639806256;647.1942431672568;651.9641419721913;652.8335274505002;663.8041777675585;32835.34329313415;45776.54223457768;46499.07001859961;46512.3023154653;46554;48426.515734842644;48911.26633100506;48940.2658960115;48949.755251223694;48982.26526602104;8336.791580210513;9066.410683305598;9214.539273036355;9221.907780922173;10734.838977415346;10541.947290263577;10912.290701104403;10921.781564368748;10923.890761092407;10969.122470202405;10929.890701092967;10986.890131098666;11012.17408694347;11025.83461248082;11030.28303160296;8405.285550728166;10688.893111068868;10909.18181136414;11018.338899665965;11038.889611103867;10460.581576736922;10988.120950323955;11001.889981100247;11003.944980275048;11019.83470247947;45696;46149.077018459444;46230.30654540184;46251.76874115642;46320.305195422094;3753.3056384568667;3875.9224815503812;3944.842206311744;4045.5145382553987;4498.910021799578;35150.296994060234;35322.823385883166;35397.292054158774;35410.64589354099;35564.288714225826;4579.5878370946775;4641.396618439615;4656.278276867091;4672.415948006499;4680.859574212779;390035;391900.04049979855;393611;393861;394628;39138;70412;70749.2925070753;71371.2862871375;71399;41398;41679.374809377885;41773.79113104415;41798.58201418008;41801.79099104546;16159;16721.749173762404;16793.496195114167;16801.15994200285;16806.663866722596;11563;13609.863901360859;13859.307034648227;13890.236037018061;14280.42878284857;9327.580258888367;9334.066593340747;9370.34407591462;9393.671221507351;9432.858507122399;3551.2364841558674;3564.108972756811;3575.570931488186;3616.3309787689363;3623.873164439232;1069;1074.3661239868359;1131.3833960491552;1156.7166044319197;1223.4311045363947;34022.14944626404;34043.48934765981;34143.31713365719;34229.82885085609;34327.313453730785;1151.6582484035307;1162.6918866500384;1177.3171560494893;1178.6935396796723;1233.6360773571819;18105.185266663033;18115.54711132206;18216.726749098772;18243.45269641913;18285.451436456926;605108;605250;608616;608625;610685;64931.350686493475;65264;65530.34469655243;65599;65626;1330.2484096485455;1446.4286606790258;1450.0864455393246;1474.46182143519;1494.8729358004691;33182;33832.1541961453;34333.656663433045;34395.312093757486;34551.30897382089;53928.46071539234;54415.18377224424;54481.18278225909;54550.45449545613;54586.45413545814;414978;424083;425874;426360;427336;27867.303317417227;28370.85814570914;29909.850450747606;30979.845100775252;31284.06147815569;47970.28044579264;48839.75580122077;49744.50255497399;51325.74337128291;53595.46404535905;44106.338404924594;45280.54719452763;45417;46350.30474542817;47051.05897882092;44954;45405.31892021689;45649.54350456453;45744.77127614341;46960.7651961738;44378.77810610926;44966.1006779856;45330.77334613306;45702.77148614236;45766.313505298116;38626;39376.97494463957;39609.405858912716;39974;40174;30117.849410752806;30239.697603023687;30268.54597181;30757;30798.69201308048 03:29:23 INFO - PROCESS | 27673 | |2;jquery.html;411.66038018634634;412.18798966036917;414.9087200815823;423.3480440122211;431.0731926358329;18070.5482362941;19029.2388304468;19460.41618751438;19477;19985.800141998574;11898.64304070877;11927.761444771098;12018.218815776969;12609.4325755341;12908.741825163492;5234.528892399693;5307.548858347045;5405.648632838853;5414.377346605132;5468.234447177379;5870.090136028923;5879.794207202727;5900.114982752579;5939.227900372945;5940.2871655401195;5881.206037184989;5883.8234852954265;5889.734961926723;5895.997680394344;6217.59585626935;6453.225612926455;6560.671966401661;6589.242237142742;6601.3728695773825;6608.7686930957425;5613.298337707786;5728.083506638918;5728.455796699307;5736.139579063132;5901.822945311647;13288.069835111546;13297.933510332483;13358.933205333911;13387.531436399679;13597.52408665692;2418.8790560471907;2504.461540768725;2514.6353778701987;2833.121732263005;3065.080475857234;9793.461359625218;9951.601935922554;10065.446400447972;10385.42880141592;10576.629817956335;1968.0946764488353;1973.2994786850604;1979.0500559731408;1992.561636439981;2092.215419217793;79368;80962;81816;82427;83499.16500835035;11305.71735706614;11422.31466112036;11577.76844463106;11597.18819682614;11639.709007274885;16284.918575407048;16333.26500307489;16411;16437.506874793777;16452.506424807274;8195.7951051223;8347.54088525137;8352.958235208907;8407.8318433631;8676.392652514263;7900.525968441912;8005.399595030396;8027.7993050173045;8112.75661730149;8216.712415065444;4347.500037495665;4478.731276123443;4782.971661092882;4806.2310030394965;5003.574696150868;2000.1099510717881;2030.878147311166;2099.601075795594;2107.589020141058;2108.50450144216;912.6942474271061;1013.9543720532594;1022.5807418958192;1098.9120870330355;1113.5323164270865;18681.43955681332;18870.90564547196;19435.611287774165;19795.10922008513;19797.208111675372;982.3467394182932;982.5283863745442;1003.5433877585681;1019.4240254256322;1047.9790404191874;10170.796584068277;10850.0777433919;10960;10976.286541374786;11031.448427578589;494153;497562;509099;511025;513081;89315;89789.55105224432;90551;91121.54439227762;91625;1059.5338051257422;1072.9731756706144;1121.8429419881222;1154.1286328821686;1156.0578128824982;17119.464086341646;17135.914320428317;17507.38724144649;17524.91237543804;17668.911655442156;34799.65200347964;38842;38866.61133388743;39885.999999998836;41615.58384416117;56101.438985609624;57336;58261.417385825596;58618;58670.41329586649;8363.707270245755;8577.399582029198;8775.42959707617;8869.64521419136;9001.234895033995;12101.576444824388;12990.155639883378;13032.54386096482;13146.408411621309;13324.067315287837;11191.216614836883;11388.715282118013;11425.485853136463;11913;11961.102917281412;11377.374244416636;11471.885281147082;11698.06415486742;11757.647270581554;12061;11648.359340236368;11700.47347869365;11712.88287117118;11813.940930295294;12218.75562488763;8225.095239523527;8397.664093436195;8635.956820215859;8691.652333906573;9176.353700943864;9823.705288841345;11372.943135284271;11388.202825802446;11670.124740644655;11748.412579371168 03:29:23 INFO - PROCESS | 27673 | |3;mootools.html;1443.343278808142;1455.294182321573;1543.5909483986745;1704.8977061376318;1911.5507855653918;8884.378093533454;9269.397489163208;9308.90691093089;9385.577649005794;9389.953050234739;9215.769605759842;9357.391769534976;9396;9418.905810941906;9421.340506164572;2118.5868755592664;2335.1943579465055;2379.8572085674873;2419.177479656916;2420.1529464687396;2427.5387676341525;2434.720007199177;2436.8659723715186;2438.9024439022505;2439.7926176275037;2313.2828823064906;2359.95280094398;2362.5511152880986;2362.7164740231196;2364.160722943356;2029.3607513633233;2322.837401381904;2398.3524448399007;2404.5912194926905;2404.97595024051;2329.79031887131;2338.275134708246;2345.601247787863;2346.894389752448;2363.881805909715;9324.953375233148;9343.71968840929;9373.671921482784;9387.295952803499;9390.765230869214;5178.0679477694;5267.973660131714;5277.445868183862;5302.125149350352;5307.761150748225;3194.8242846643425;3314.1548905029063;3359.5968483782103;3476.930461390758;3485.89542313731;1033.41095575522;1038.0709265207672;1056.1972900595526;1115.676453828397;1117.1398023521924;12563.246205227715;12608.180468269533;12609;12618.242905425612;12618.68453288666;4433.334999749999;4572.9314060289125;4579.290210017452;4653.883652908637;4654.371659825948;10446.68659940203;10449;10450.16398688103;10465.68602941913;10472.633457828939;4849.684770489906;5178.275041494194;5275.709835958983;5279.340082489689;5281.996420680135;4679.578837904605;4820.325154478376;4835.975820120947;4855.878603034882;4916.680415772963;4135.17296540687;4138.52406973196;4259.8083086261195;4288.142371525707;4322.481302243751;1300.7008388070797;1345.656857501331;1346.4614154338342;1357.7080927600614;1365.283226306197;1024.7386916336436;1089.4443833644739;1091.8307662312354;1093.6227001684406;1101.3446999035561;6189.412005859526;6382.20222472191;6391.2330520337855;6460.289368169498;6648.66756662165;394.89732669506134;396.15025769724355;397.45747055269925;408.8671181865906;409.89957460422386;4466.508684044752;4494.325851122358;4495.25828238337;4509.909801803946;4514.300283456004;11334.149938754626;11611.419429028514;11615.6515304541;11620;11634.6509604712;10941.343519388862;11350.14873884462;11350.3757293348;11454.541818327174;11479.13906457019;8476.872846907301;8597.613107410307;8612.311015118776;8630.5253211074;8679.088695686989;6334.33489483616;6455.67721613908;6488.059231411325;6490.902636460362;6573.8027859162385;10321.277510574188;10584.259101862795;10691.999999999689;10715.410652414192;10828.729281768019;10790.838137428102;10941.45292735344;10973.286736362112;11022.779544409228;11098.389588572383;7881.527108373516;8140.430169888288;8221;8225.465344752572;8320.417570769989;9029.729108126767;9033.006369299503;9056.683016094668;9064.909350906406;9138.634454622006;7972.521648701097;8140.959295203723;8166.510009399455;8212.671493140446;8277.54473503939;7717.807054823675;7883.054033515786;7995.12053674107;8039.839203215786;8054;7344.118705755343;7368.962127147792;7436.814079647836;7539.208383119693;7553.169151393452;5639.407862174577;5688.63023903445;5714.314282285986;5743.62666426681;5840.036393994943;5409.918851217313;5619.943800561942;5664.546836253007;5696.544276457957;5731.3408957968695 03:29:23 INFO - PROCESS | 27673 | |4;prototype.html;333.64966784875884;335.1804837173111;339.2485644297881;342.3563700243542;343.6340297583075;5339.332583427072;5367.516923476886;5392.622516423852;5417.4289456057795;5449.182622606611;5319.723266416061;5342.610921160507;5352.973235133829;5362.65142765721;5365.195220716894;3961.7821019843896;4026.335654616985;4027.496562929634;4145.917081658365;4146.1914926589325;4131.277026520362;4203.957960420387;4207.747535147885;4217.1987322408795;4219.346001369792;4153.667706583481;4168.353905144692;4176.7469759072155;4179.665626749868;4186.476690413699;3933.878844529324;4056.9594304056877;4134.338505839081;4177.310743727281;4188.1204946961025;3691.7046636269033;3694.9445758313377;3708.61059588742;3715.888523344304;3716.628337166289;5070.8225212117395;5071.467495912912;5101.087092340373;5101.897962040738;5117;4710.528947105262;4715.245560710304;4748.264019077049;4805.111054454902;4823.686460380064;5562.332520097614;5565.9443405565835;5599.916001259943;5602.1596760485845;5609.382967873531;3894.162755007687;3993.5407428145845;4000.19996000801;4010.498687664042;4042.191561687645;5573.637713548606;5654.943450565442;5784.913226301609;5791.594588378773;5822.417758224144;4129.1625226774395;4145.854895078718;4146.232946904832;4151.626353628128;4153.605407486284;4094.341791574417;4112.773797441109;4156.168766246763;4193.559676234013;4202.201581699467;4679.321498382716;4695.131400690883;4702.388689470347;4705.035467729107;4706.576408123286;5507.7246137692955;5519.2824932758485;5542.362628297717;5551.806361632269;5554.277943867352;1362.2507620808515;1418.4255376572505;1431.9689823327187;1433.8207724034496;1435.7702767557141;892.8169725206317;897.1701176411923;907.6550910653909;908.52756566585;925.2089463508738;4831.613470922318;4840.419149702058;4852.563269305709;4894.926576101361;4898;5031.974840125849;5054.69671819692;5070.239464080418;5070.518300761421;5080.695158290514;4866.48901865299;4867.683600565952;4945.505449455098;4950.2079667253065;5090.9236361454605;3032.757379409642;3058.877644894224;3068.8671373395723;3069.4935335669365;3087.521434177706;6041.275046994301;6048.153258543807;6050.45545900871;6054.182685337511;6074.51403887688;5556.805511807067;5894.705264736746;5903.911441328383;5910.911336329958;5916.970415147896;5916.526677865761;5978.013627751372;5984.670843103584;5994.7602095916545;6011.188489553854;5394.056040192872;5555.944440555542;5760;5761.8559536011935;5839.89042082003;5656.88686226265;5670.234518340137;5683.23276357703;5684.602077854511;5687.7724891005555;5957.106434034929;5977.521798256216;5993.910091348546;5997.490213331916;5997.490213331916;3966.524017117849;4016.7991600420446;4019.397090436341;4026.979865100656;4032.6975476838766;5746.913796292975;5749.396313387201;5753.165790960371;5778.682172480554;5790.189373487631;5577.693226872399;5655.660660360391;5659.179418984142;5661.490465858093;5668.26312579362;5378.919316210182;5566.192902029102;5579.163125531203;5581.9162712560155;5620.875824835131;5438.510534051954;5494.725263736877;5506.724663766876;5511.22842802016;5529.142982837667;5384.461553844584;5567.777288908398;5596.1605759136455;5607.887842243051;5630;5475.370332411823;5508.807191748269;5514.420985796433;5518.2826232589505;5526.613137080366 03:29:23 INFO - PROCESS | 27673 | |5;yui.html;787.6927998080749;795.6737737527615;804.9678012879485;871.65569600008;904.9140331668493;17200.225989830455;17583.120843957815;17586;17630.64738705225;17634.118294085292;16908.746368804477;17019.48941531753;17043.403480878173;17060;17064.573385665364;728.0644371982004;852.0031563071191;878.5519385113606;882.4176043811086;883.3463237204454;838.7483754873514;844.7381311793364;845.5434065604566;845.8984921809391;845.9196376344238;886.1581497577295;892.5180402582598;893.1158153428124;893.5487578772743;894.021046953588;762.672051018062;896.26058501736;898.3980732908934;928.8467402878517;930.3998920696113;648.9123968264271;670.8993650952348;672.6367761408833;673.1182151381705;673.1282988529865;15909.602259943478;15996.52010439677;16008.199590020453;16027.439039633557;16028.679426411523;16104.83895161045;16472.25874835623;16576.66846663072;16691.49925502237;16705.164741762987;12749.681257968625;12835.679108022374;12978.545750898767;13066;13070.738585228242;4153.460050193486;4163.83344666213;4167.395727619509;4173.686973477002;4205.432266644025;77850.61074694646;79164.60417697932;79256;81221.78167327555;81525;12385.256884586774;12677.619671409873;12760.936195318964;12816.679583010313;12922.353882306035;22877.19929802449;23047.423814404774;23051.423714406938;24746.25761227166;24831.87584062068;9854.655087071918;9951.850722239173;9955.203583713286;10007.249456290807;10072.848907266396;5185.922211166836;5224.529792318634;5259.894802103937;5357.303550538405;5365.865853353619;3883.7475564088245;3996.3805610130476;4000.119973605802;4004.8598299059977;4007.779572123503;692.6640579319027;694.8679750847323;702.8488874891923;706.6890568149997;715.488425775573;676.5027704637088;748.6855520681327;823.9794005149919;837.380338549469;839;11097.667069987914;11184.496697648625;11315.717107072389;11434.970852623304;11518.827217591743;654.6759354119741;766.7201471462876;792.7463211772177;824.6000689665508;856.1224744636797;4990.72551009698;5114.5652619527755;5138.30632864566;5183.170692689152;5233.110371236899;71202.28797711956;71436.64281678558;71587.64206178936;87375.56312218525;125086;60599.69700151559;62347.376526235064;64011.35988640054;91963;94977.525112374;78964.21035789684;80278.19721802825;87890.56054719686;91270.54364728267;93009.53495232615;10492.527836247235;10907.127429805756;11291.943540282246;11336.149788765711;11604.419779011185;48531;51188;51663.74168129286;51914;54576.18135727888;69515;70051.64974175097;74862;75069.6246518764;78695;13786.724265514835;13862.376193071537;14035.559138340372;14235.786463202852;14680;14915.850841491447;15255.847441525886;16165.272562734941;16269.349226030827;16448.917755411625;14959.963349534093;15188.392464301745;15235.3905843765;15662.9216853915;15869.20653967274;14979.101253924799;15138.697226055638;15148.16685082287;15208.923955380153;15211.923940380228;14127.788083178555;14303.64240893986;15222.086674799548;15362.30869610848;16159.67680646404;11854.798607657882;12276.81584776247;12440.875591243972;12445.564405246136;12465.404296836212;12075.879241207827;12489.750204996031;12517.93741031289;12656.810147847606;12858 03:29:23 INFO - PROCESS | 27673 | __end_tp_report 03:29:23 INFO - PROCESS | 27673 | __start_cc_report 03:29:23 INFO - PROCESS | 27673 | _x_x_mozilla_cycle_collect,894 03:29:23 INFO - PROCESS | 27673 | __end_cc_report 03:29:23 INFO - PROCESS | 27673 | __startTimestamp1469874563290__endTimestamp 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | ------- Summary: start ------- 03:29:23 INFO - PROCESS | 27673 | Number of tests: 6 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#0] dojo.html Cycles:165 Average:5427.60 Median:5627.04 stddev:595.35 (10.6%) stddev-sans-first:573.36 03:29:23 INFO - PROCESS | 27673 | Values: 3302.7 3330.7 3332.1 3340.4 3382.5 5404.6 5470.7 5482.2 5508.3 5517.1 5442.4 5492.0 5497.9 5505.7 5531.2 4849.2 4934.6 4951.3 4988.7 5014.8 4835.6 4969.3 4991.4 5001.3 5003.1 4928.2 4932.2 4938.4 4954.5 4977.5 5043.6 5045.0 5057.9 5072.2 5081.1 4848.8 4868.8 4928.3 4966.4 4979.8 5334.1 5349.4 5371.2 5377.0 5406.0 5858.2 5868.9 5889.9 5908.3 5919.9 5785.5 5836.7 5859.7 5916.1 5946.5 5483.6 5518.4 5533.9 5536.2 5536.6 5723.0 6009.1 6022.8 6023.4 6024.3 5678.7 5706.9 5737.6 5784.7 5811.6 5836.6 5838.3 5838.4 5875.1 5885.5 5571.5 5682.4 5830.1 5841.4 5851.3 5701.7 5769.9 5771.4 5788.0 5813.4 4456.2 4464.6 4465.9 4475.7 4489.8 3969.0 3985.0 4002.8 4024.1 4040.7 5561.5 5569.8 5578.5 5590.4 5618.3 5860.2 5864.6 5876.7 5886.9 5915.6 5428.7 5444.8 5485.8 5528.0 5579.5 4976.9 4982.7 4984.0 4985.5 4998.5 5967.2 5987.9 6010.6 6025.8 6049.9 5726.9 5736.1 5815.1 5828.4 5842.5 6128.2 6134.7 6140.2 6140.4 6142.1 5780.2 5796.6 5804.1 5806.9 5808.8 5691.1 5693.3 5749.4 5755.3 5830.8 5671.3 5684.1 5684.3 5686.7 5689.9 5466.0 5658.1 5679.6 5685.7 5685.9 5579.7 5580.2 5586.6 5627.0 5677.7 5735.9 5778.7 5793.4 5816.3 5820.2 5536.6 5579.6 5660.1 5660.1 5691.0 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#1] ext.html Cycles:180 Average:64050.59 Median:199286.42 stddev:128634.81 (64.5%) stddev-sans-first:128907.35 03:29:23 INFO - PROCESS | 27673 | Values: 562.8 647.2 652.0 652.8 663.8 32835.3 45776.5 46499.1 46512.3 46554.0 48426.5 48911.3 48940.3 48949.8 48982.3 8336.8 9066.4 9214.5 9221.9 10734.8 10541.9 10912.3 10921.8 10923.9 10969.1 10929.9 10986.9 11012.2 11025.8 11030.3 8405.3 10688.9 10909.2 11018.3 11038.9 10460.6 10988.1 11001.9 11003.9 11019.8 45696.0 46149.1 46230.3 46251.8 46320.3 3753.3 3875.9 3944.8 4045.5 4498.9 35150.3 35322.8 35397.3 35410.6 35564.3 4579.6 4641.4 4656.3 4672.4 4680.9 390035.0 391900.0 393611.0 393861.0 394628.0 39138.0 70412.0 70749.3 71371.3 71399.0 41398.0 41679.4 41773.8 41798.6 41801.8 16159.0 16721.7 16793.5 16801.2 16806.7 11563.0 13609.9 13859.3 13890.2 14280.4 9327.6 9334.1 9370.3 9393.7 9432.9 3551.2 3564.1 3575.6 3616.3 3623.9 1069.0 1074.4 1131.4 1156.7 1223.4 34022.1 34043.5 34143.3 34229.8 34327.3 1151.7 1162.7 1177.3 1178.7 1233.6 18105.2 18115.5 18216.7 18243.5 18285.5 605108.0 605250.0 608616.0 608625.0 610685.0 64931.4 65264.0 65530.3 65599.0 65626.0 1330.2 1446.4 1450.1 1474.5 1494.9 33182.0 33832.2 34333.7 34395.3 34551.3 53928.5 54415.2 54481.2 54550.5 54586.5 414978.0 424083.0 425874.0 426360.0 427336.0 27867.3 28370.9 29909.9 30979.8 31284.1 47970.3 48839.8 49744.5 51325.7 53595.5 44106.3 45280.5 45417.0 46350.3 47051.1 44954.0 45405.3 45649.5 45744.8 46960.8 44378.8 44966.1 45330.8 45702.8 45766.3 38626.0 39377.0 39609.4 39974.0 40174.0 30117.8 30239.7 30268.5 30757.0 30798.7 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#2] jquery.html Cycles:180 Average:28933.19 Median:2509.55 stddev:83202.98 (3315.5%) stddev-sans-first:83408.82 03:29:23 INFO - PROCESS | 27673 | Values: 411.7 412.2 414.9 423.3 431.1 18070.5 19029.2 19460.4 19477.0 19985.8 11898.6 11927.8 12018.2 12609.4 12908.7 5234.5 5307.5 5405.6 5414.4 5468.2 5870.1 5879.8 5900.1 5939.2 5940.3 5881.2 5883.8 5889.7 5896.0 6217.6 6453.2 6560.7 6589.2 6601.4 6608.8 5613.3 5728.1 5728.5 5736.1 5901.8 13288.1 13297.9 13358.9 13387.5 13597.5 2418.9 2504.5 2514.6 2833.1 3065.1 9793.5 9951.6 10065.4 10385.4 10576.6 1968.1 1973.3 1979.1 1992.6 2092.2 79368.0 80962.0 81816.0 82427.0 83499.2 11305.7 11422.3 11577.8 11597.2 11639.7 16284.9 16333.3 16411.0 16437.5 16452.5 8195.8 8347.5 8353.0 8407.8 8676.4 7900.5 8005.4 8027.8 8112.8 8216.7 4347.5 4478.7 4783.0 4806.2 5003.6 2000.1 2030.9 2099.6 2107.6 2108.5 912.7 1014.0 1022.6 1098.9 1113.5 18681.4 18870.9 19435.6 19795.1 19797.2 982.3 982.5 1003.5 1019.4 1048.0 10170.8 10850.1 10960.0 10976.3 11031.4 494153.0 497562.0 509099.0 511025.0 513081.0 89315.0 89789.6 90551.0 91121.5 91625.0 1059.5 1073.0 1121.8 1154.1 1156.1 17119.5 17135.9 17507.4 17524.9 17668.9 34799.7 38842.0 38866.6 39886.0 41615.6 56101.4 57336.0 58261.4 58618.0 58670.4 8363.7 8577.4 8775.4 8869.6 9001.2 12101.6 12990.2 13032.5 13146.4 13324.1 11191.2 11388.7 11425.5 11913.0 11961.1 11377.4 11471.9 11698.1 11757.6 12061.0 11648.4 11700.5 11712.9 11813.9 12218.8 8225.1 8397.7 8636.0 8691.7 9176.4 9823.7 11372.9 11388.2 11670.1 11748.4 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#3] mootools.html Cycles:180 Average:6064.45 Median:4449.92 stddev:3498.53 (78.6%) stddev-sans-first:3491.11 03:29:23 INFO - PROCESS | 27673 | Values: 1443.3 1455.3 1543.6 1704.9 1911.6 8884.4 9269.4 9308.9 9385.6 9390.0 9215.8 9357.4 9396.0 9418.9 9421.3 2118.6 2335.2 2379.9 2419.2 2420.2 2427.5 2434.7 2436.9 2438.9 2439.8 2313.3 2360.0 2362.6 2362.7 2364.2 2029.4 2322.8 2398.4 2404.6 2405.0 2329.8 2338.3 2345.6 2346.9 2363.9 9325.0 9343.7 9373.7 9387.3 9390.8 5178.1 5268.0 5277.4 5302.1 5307.8 3194.8 3314.2 3359.6 3476.9 3485.9 1033.4 1038.1 1056.2 1115.7 1117.1 12563.2 12608.2 12609.0 12618.2 12618.7 4433.3 4572.9 4579.3 4653.9 4654.4 10446.7 10449.0 10450.2 10465.7 10472.6 4849.7 5178.3 5275.7 5279.3 5282.0 4679.6 4820.3 4836.0 4855.9 4916.7 4135.2 4138.5 4259.8 4288.1 4322.5 1300.7 1345.7 1346.5 1357.7 1365.3 1024.7 1089.4 1091.8 1093.6 1101.3 6189.4 6382.2 6391.2 6460.3 6648.7 394.9 396.2 397.5 408.9 409.9 4466.5 4494.3 4495.3 4509.9 4514.3 11334.1 11611.4 11615.7 11620.0 11634.7 10941.3 11350.1 11350.4 11454.5 11479.1 8476.9 8597.6 8612.3 8630.5 8679.1 6334.3 6455.7 6488.1 6490.9 6573.8 10321.3 10584.3 10692.0 10715.4 10828.7 10790.8 10941.5 10973.3 11022.8 11098.4 7881.5 8140.4 8221.0 8225.5 8320.4 9029.7 9033.0 9056.7 9064.9 9138.6 7972.5 8141.0 8166.5 8212.7 8277.5 7717.8 7883.1 7995.1 8039.8 8054.0 7344.1 7369.0 7436.8 7539.2 7553.2 5639.4 5688.6 5714.3 5743.6 5840.0 5409.9 5619.9 5664.5 5696.5 5731.3 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#4] prototype.html Cycles:180 Average:4665.94 Median:5329.53 stddev:1374.93 (25.8%) stddev-sans-first:1339.79 03:29:23 INFO - PROCESS | 27673 | Values: 333.6 335.2 339.2 342.4 343.6 5339.3 5367.5 5392.6 5417.4 5449.2 5319.7 5342.6 5353.0 5362.7 5365.2 3961.8 4026.3 4027.5 4145.9 4146.2 4131.3 4204.0 4207.7 4217.2 4219.3 4153.7 4168.4 4176.7 4179.7 4186.5 3933.9 4057.0 4134.3 4177.3 4188.1 3691.7 3694.9 3708.6 3715.9 3716.6 5070.8 5071.5 5101.1 5101.9 5117.0 4710.5 4715.2 4748.3 4805.1 4823.7 5562.3 5565.9 5599.9 5602.2 5609.4 3894.2 3993.5 4000.2 4010.5 4042.2 5573.6 5654.9 5784.9 5791.6 5822.4 4129.2 4145.9 4146.2 4151.6 4153.6 4094.3 4112.8 4156.2 4193.6 4202.2 4679.3 4695.1 4702.4 4705.0 4706.6 5507.7 5519.3 5542.4 5551.8 5554.3 1362.3 1418.4 1432.0 1433.8 1435.8 892.8 897.2 907.7 908.5 925.2 4831.6 4840.4 4852.6 4894.9 4898.0 5032.0 5054.7 5070.2 5070.5 5080.7 4866.5 4867.7 4945.5 4950.2 5090.9 3032.8 3058.9 3068.9 3069.5 3087.5 6041.3 6048.2 6050.5 6054.2 6074.5 5556.8 5894.7 5903.9 5910.9 5917.0 5916.5 5978.0 5984.7 5994.8 6011.2 5394.1 5555.9 5760.0 5761.9 5839.9 5656.9 5670.2 5683.2 5684.6 5687.8 5957.1 5977.5 5993.9 5997.5 5997.5 3966.5 4016.8 4019.4 4027.0 4032.7 5746.9 5749.4 5753.2 5778.7 5790.2 5577.7 5655.7 5659.2 5661.5 5668.3 5378.9 5566.2 5579.2 5581.9 5620.9 5438.5 5494.7 5506.7 5511.2 5529.1 5384.5 5567.8 5596.2 5607.9 5630.0 5475.4 5508.8 5514.4 5518.3 5526.6 03:29:23 INFO - PROCESS | 27673 | 03:29:23 INFO - PROCESS | 27673 | [#5] yui.html Cycles:180 Average:20175.90 Median:4170.54 stddev:26291.50 (630.4%) stddev-sans-first:26324.95 03:29:23 INFO - PROCESS | 27673 | Values: 787.7 795.7 805.0 871.7 904.9 17200.2 17583.1 17586.0 17630.6 17634.1 16908.7 17019.5 17043.4 17060.0 17064.6 728.1 852.0 878.6 882.4 883.3 838.7 844.7 845.5 845.9 845.9 886.2 892.5 893.1 893.5 894.0 762.7 896.3 898.4 928.8 930.4 648.9 670.9 672.6 673.1 673.1 15909.6 15996.5 16008.2 16027.4 16028.7 16104.8 16472.3 16576.7 16691.5 16705.2 12749.7 12835.7 12978.5 13066.0 13070.7 4153.5 4163.8 4167.4 4173.7 4205.4 77850.6 79164.6 79256.0 81221.8 81525.0 12385.3 12677.6 12760.9 12816.7 12922.4 22877.2 23047.4 23051.4 24746.3 24831.9 9854.7 9951.9 9955.2 10007.2 10072.8 5185.9 5224.5 5259.9 5357.3 5365.9 3883.7 3996.4 4000.1 4004.9 4007.8 692.7 694.9 702.8 706.7 715.5 676.5 748.7 824.0 837.4 839.0 11097.7 11184.5 11315.7 11435.0 11518.8 654.7 766.7 792.7 824.6 856.1 4990.7 5114.6 5138.3 5183.2 5233.1 71202.3 71436.6 71587.6 87375.6 125086.0 60599.7 62347.4 64011.4 91963.0 94977.5 78964.2 80278.2 87890.6 91270.5 93009.5 10492.5 10907.1 11291.9 11336.1 11604.4 48531.0 51188.0 51663.7 51914.0 54576.2 69515.0 70051.6 74862.0 75069.6 78695.0 13786.7 13862.4 14035.6 14235.8 14680.0 14915.9 15255.8 16165.3 16269.3 16448.9 14960.0 15188.4 15235.4 15662.9 15869.2 14979.1 15138.7 15148.2 15208.9 15211.9 14127.8 14303.6 15222.1 15362.3 16159.7 11854.8 12276.8 12440.9 12445.6 12465.4 12075.9 12489.8 12517.9 12656.8 12858.0 03:29:23 INFO - PROCESS | 27673 | -------- Summary: end -------- 03:29:23 INFO - PROCESS | 27673 | 03:29:24 INFO - TEST-INFO | 27673: exit 0 03:29:24 INFO - TEST-OK | dromaeo_css | took 1113622ms 03:29:24 INFO - TEST-START | kraken 03:29:24 INFO - operating with platform_type : linux_ 03:29:24 INFO - Initialising browser for kraken test... 03:29:24 INFO - TEST-INFO | started process 27866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTufti/profile http://localhost:53722/getInfo.html) 03:29:28 INFO - PROCESS | 27866 | __metrics Screen width/height:1600/1200 03:29:28 INFO - PROCESS | 27866 | colorDepth:24 03:29:28 INFO - PROCESS | 27866 | Browser inner width/height: 1024/697 03:29:28 INFO - PROCESS | 27866 | __metrics 03:29:30 INFO - PROCESS | 27866 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:29:30 ERROR - PROCESS | 27866 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:31 INFO - TEST-INFO | 27866: exit 0 03:29:31 INFO - Browser initialized. 03:29:31 INFO - Running cycle 1/1 for kraken test... 03:29:31 INFO - TEST-INFO | started process 27958 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTufti/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:43 INFO - PROCESS | 27958 | RSS: Main: 145313792 03:29:43 INFO - PROCESS | 27958 | 03:29:45 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53722/tests/kraken/driver.html?testName=audio-beat-detection) 03:29:46 INFO - PROCESS | 27958 | RSS: Main: 194789376 03:29:46 INFO - PROCESS | 27958 | 03:29:49 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53722/tests/kraken/driver.html?testName=audio-dft) 03:29:49 INFO - PROCESS | 27958 | RSS: Main: 187740160 03:29:49 INFO - PROCESS | 27958 | 03:29:52 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53722/tests/kraken/driver.html?testName=audio-fft) 03:29:53 INFO - PROCESS | 27958 | RSS: Main: 278822912 03:29:53 INFO - PROCESS | 27958 | 03:29:55 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53722/tests/kraken/driver.html?testName=audio-oscillator) 03:29:55 INFO - PROCESS | 27958 | RSS: Main: 187297792 03:29:55 INFO - PROCESS | 27958 | 03:29:57 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:29:58 INFO - PROCESS | 27958 | RSS: Main: 188493824 03:29:58 INFO - PROCESS | 27958 | 03:30:01 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53722/tests/kraken/driver.html?testName=imaging-darkroom) 03:30:02 INFO - PROCESS | 27958 | RSS: Main: 222924800 03:30:02 INFO - PROCESS | 27958 | 03:30:05 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53722/tests/kraken/driver.html?testName=imaging-desaturate) 03:30:06 INFO - PROCESS | 27958 | RSS: Main: 221949952 03:30:06 INFO - PROCESS | 27958 | 03:30:08 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53722/tests/kraken/driver.html?testName=json-parse-financial) 03:30:09 INFO - PROCESS | 27958 | RSS: Main: 222593024 03:30:09 INFO - PROCESS | 27958 | 03:30:10 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:30:11 INFO - PROCESS | 27958 | RSS: Main: 201256960 03:30:11 INFO - PROCESS | 27958 | 03:30:13 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:30:13 INFO - PROCESS | 27958 | RSS: Main: 201682944 03:30:13 INFO - PROCESS | 27958 | 03:30:15 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:30:16 INFO - PROCESS | 27958 | RSS: Main: 211107840 03:30:16 INFO - PROCESS | 27958 | 03:30:18 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:30:19 INFO - PROCESS | 27958 | RSS: Main: 217288704 03:30:19 INFO - PROCESS | 27958 | 03:30:22 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:30:22 INFO - PROCESS | 27958 | RSS: Main: 219041792 03:30:22 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | Cycle 1(1): loaded http://localhost:53722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53722/tests/kraken/driver.html?testName=ai-astar) 03:30:24 INFO - PROCESS | 27958 | RSS: Main: 261222400 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | __start_tp_report 03:30:24 INFO - PROCESS | 27958 | _x_x_mozilla_page_load 03:30:24 INFO - PROCESS | 27958 | _x_x_mozilla_page_load_details 03:30:24 INFO - PROCESS | 27958 | |i|pagename|runs| 03:30:24 INFO - PROCESS | 27958 | |0;ai-astar;112;106;110;110;110;111;109;110;110;109 03:30:24 INFO - PROCESS | 27958 | |1;audio-beat-detection;157;132;128;170;124;125;125;150;162;123 03:30:24 INFO - PROCESS | 27958 | |2;audio-dft;162;161;162;161;161;161;160;162;160;159 03:30:24 INFO - PROCESS | 27958 | |3;audio-fft;77;76;74;100;74;75;75;75;102;75 03:30:24 INFO - PROCESS | 27958 | |4;audio-oscillator;93;85;117;84;83;85;123;84;84;121 03:30:24 INFO - PROCESS | 27958 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;116 03:30:24 INFO - PROCESS | 27958 | |6;imaging-darkroom;145;146;145;145;145;146;146;147;147;145 03:30:24 INFO - PROCESS | 27958 | |7;imaging-desaturate;94;95;95;95;95;95;94;95;95;95 03:30:24 INFO - PROCESS | 27958 | |8;json-parse-financial;51;50;50;52;51;60;53;54;50;54 03:30:24 INFO - PROCESS | 27958 | |9;json-stringify-tinderbox;61;61;60;62;61;61;61;61;61;61 03:30:24 INFO - PROCESS | 27958 | |10;stanford-crypto-aes;77;78;76;79;77;78;83;87;103;77 03:30:24 INFO - PROCESS | 27958 | |11;stanford-crypto-ccm;118;130;126;125;118;122;120;129;131;121 03:30:24 INFO - PROCESS | 27958 | |12;stanford-crypto-pbkdf2;153;153;157;158;159;154;159;153;154;152 03:30:24 INFO - PROCESS | 27958 | |13;stanford-crypto-sha256-iterative;65;61;61;60;63;61;61;60;60;63 03:30:24 INFO - PROCESS | 27958 | __end_tp_report 03:30:24 INFO - PROCESS | 27958 | __start_cc_report 03:30:24 INFO - PROCESS | 27958 | _x_x_mozilla_cycle_collect,1567 03:30:24 INFO - PROCESS | 27958 | __end_cc_report 03:30:24 INFO - PROCESS | 27958 | __startTimestamp1469874624723__endTimestamp 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | ------- Summary: start ------- 03:30:24 INFO - PROCESS | 27958 | Number of tests: 14 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:1.57 (1.4%) stddev-sans-first:1.42 03:30:24 INFO - PROCESS | 27958 | Values: 112.0 106.0 110.0 110.0 110.0 111.0 109.0 110.0 110.0 109.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:141.00 stddev:18.18 (12.9%) stddev-sans-first:18.16 03:30:24 INFO - PROCESS | 27958 | Values: 157.0 132.0 128.0 170.0 124.0 125.0 125.0 150.0 162.0 123.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 03:30:24 INFO - PROCESS | 27958 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 160.0 162.0 160.0 159.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#3] audio-fft Cycles:10 Average:80.30 Median:75.00 stddev:10.95 (14.6%) stddev-sans-first:11.55 03:30:24 INFO - PROCESS | 27958 | Values: 77.0 76.0 74.0 100.0 74.0 75.0 75.0 75.0 102.0 75.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.00 stddev:17.15 (20.4%) stddev-sans-first:18.16 03:30:24 INFO - PROCESS | 27958 | Values: 93.0 85.0 117.0 84.0 83.0 85.0 123.0 84.0 84.0 121.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:30:24 INFO - PROCESS | 27958 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 03:30:24 INFO - PROCESS | 27958 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 146.0 147.0 147.0 145.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:30:24 INFO - PROCESS | 27958 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:3.06 (5.8%) stddev-sans-first:3.20 03:30:24 INFO - PROCESS | 27958 | Values: 51.0 50.0 50.0 52.0 51.0 60.0 53.0 54.0 50.0 54.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 03:30:24 INFO - PROCESS | 27958 | Values: 61.0 61.0 60.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:78.00 stddev:8.28 (10.6%) stddev-sans-first:8.62 03:30:24 INFO - PROCESS | 27958 | Values: 77.0 78.0 76.0 79.0 77.0 78.0 83.0 87.0 103.0 77.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.50 stddev:4.90 (3.9%) stddev-sans-first:4.69 03:30:24 INFO - PROCESS | 27958 | Values: 118.0 130.0 126.0 125.0 118.0 122.0 120.0 129.0 131.0 121.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:2.74 (1.8%) stddev-sans-first:2.79 03:30:24 INFO - PROCESS | 27958 | Values: 153.0 153.0 157.0 158.0 159.0 154.0 159.0 153.0 154.0 152.0 03:30:24 INFO - PROCESS | 27958 | 03:30:24 INFO - PROCESS | 27958 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.17 03:30:24 INFO - PROCESS | 27958 | Values: 65.0 61.0 61.0 60.0 63.0 61.0 61.0 60.0 60.0 63.0 03:30:24 INFO - PROCESS | 27958 | -------- Summary: end -------- 03:30:24 INFO - PROCESS | 27958 | 03:30:25 INFO - TEST-INFO | 27958: exit 0 03:30:25 INFO - TEST-OK | kraken | took 61723ms 03:30:25 INFO - SUITE-END | took 1175s 03:30:25 INFO - Completed test suite (00:19:35) 03:30:25 INFO - javascript benchmark 03:30:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.7027567518926, 3330.7168890644293, 3332.1336452522337, 3340.36533058719, 3382.4926261060837, 5404.621676482643, 5470.726463676815, 5482.150266708666, 5508.338999320087, 5517.062099443095, 5442.374126975399, 5492.011437941169, 5497.862553436156, 5505.724713764316, 5531.197976293445, 4849.24836650318, 4934.629902757299, 4951.331570238026, 4988.65079444439, 5014.774335154909, 4835.564799168074, 4969.329140566014, 4991.40103187618, 5001.299818025479, 5003.12445322069, 4928.236123400879, 4932.210846264598, 4938.38270216223, 4954.504549545035, 4977.47736487669, 5043.646944713872, 5045.041442125985, 5057.898842023139, 5072.188449848043, 5081.136206844845, 4848.757562121879, 4868.805247790084, 4928.334674818925, 4966.379202599675, 4979.8008079676765, 5334.093204155303, 5349.411564727877, 5371.221172929942, 5377.0, 5405.972970135124, 5858.238429004245, 5868.941310586925, 5889.941100589025, 5908.261467316585, 5919.940800591982, 5785.47930686236, 5836.737346819404, 5859.736311865933, 5916.083007133901, 5946.524278057745, 5483.643563168382, 5518.448155184449, 5533.861653458695, 5536.2249285099315, 5536.612437129403, 5723.0, 6009.098635204667, 6022.789202377896, 6023.367546407564, 6024.3072046714315, 5678.659280443104, 5706.857328566819, 5737.569682273846, 5784.71076446176, 5811.564132690065, 5836.620619659709, 5838.32859221195, 5838.416158384212, 5875.059990401515, 5885.470307672244, 5571.526420254243, 5682.431756824284, 5830.067189249699, 5841.4450627190345, 5851.297844258716, 5701.686407247641, 5769.913451298234, 5771.394003629643, 5788.0, 5813.447722466359, 4456.242438785414, 4464.6428285737065, 4465.910681786346, 4475.686701930834, 4489.775511224426, 3968.960310396859, 3984.960150398459, 4002.779847108437, 4024.054347228399, 4040.717149799486, 5561.527270181999, 5569.777208911598, 5578.525825304813, 5590.413006634326, 5618.325800903917, 5860.238169037998, 5864.618799778086, 5876.706164691748, 5886.852828679232, 5915.615484993462, 5428.67427954324, 5444.8366549003595, 5485.835424937259, 5527.972360138174, 5579.525740312038, 4976.850694479099, 4982.701037937735, 4983.975080124576, 4985.451600323961, 4998.450170481244, 5967.224260846062, 5987.850303742354, 6010.639361638316, 6025.758969641253, 6049.939500604937, 5726.856828579319, 5736.110902810071, 5815.127730840408, 5828.417158284137, 5842.5325973921135, 6128.233970753656, 6134.6625935573975, 6140.17107690456, 6140.416660417253, 6142.078688196806, 5780.190773291826, 5796.594238403271, 5804.1293805929445, 5806.912896306643, 5808.796692115756, 5691.089425691869, 5693.259876216065, 5749.367569567428, 5755.280589926259, 5830.7959221427045, 5671.347795003628, 5684.147377893349, 5684.261046064151, 5686.744096515584, 5689.914651280317, 5465.9726701366235, 5658.066419040812, 5679.630823996427, 5685.744141513559, 5685.857853553694, 5579.6652200868075, 5580.21876937221, 5586.636868603528, 5627.0434026214825, 5677.687727175045, 5735.9139612905, 5778.682172480554, 5793.391693872083, 5816.302043754607, 5820.185174075717, 5536.584756143386, 5579.609427340048, 5660.066089095253, 5660.094384898396, 5691.032524470767], "value": 5389.688263615695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.8339639806256, 647.1942431672568, 651.9641419721913, 652.8335274505002, 663.8041777675585, 32835.34329313415, 45776.54223457768, 46499.07001859961, 46512.3023154653, 46554.0, 48426.515734842644, 48911.26633100506, 48940.2658960115, 48949.755251223694, 48982.26526602104, 8336.791580210513, 9066.410683305598, 9214.539273036355, 9221.907780922173, 10734.838977415346, 10541.947290263577, 10912.290701104403, 10921.781564368748, 10923.890761092407, 10969.122470202405, 10929.890701092967, 10986.890131098666, 11012.17408694347, 11025.83461248082, 11030.28303160296, 8405.285550728166, 10688.893111068868, 10909.18181136414, 11018.338899665965, 11038.889611103867, 10460.581576736922, 10988.120950323955, 11001.889981100247, 11003.944980275048, 11019.83470247947, 45696.0, 46149.077018459444, 46230.30654540184, 46251.76874115642, 46320.305195422094, 3753.3056384568667, 3875.9224815503812, 3944.842206311744, 4045.5145382553987, 4498.910021799578, 35150.296994060234, 35322.823385883166, 35397.292054158774, 35410.64589354099, 35564.288714225826, 4579.5878370946775, 4641.396618439615, 4656.278276867091, 4672.415948006499, 4680.859574212779, 390035.0, 391900.04049979855, 393611.0, 393861.0, 394628.0, 39138.0, 70412.0, 70749.2925070753, 71371.2862871375, 71399.0, 41398.0, 41679.374809377885, 41773.79113104415, 41798.58201418008, 41801.79099104546, 16159.0, 16721.749173762404, 16793.496195114167, 16801.15994200285, 16806.663866722596, 11563.0, 13609.863901360859, 13859.307034648227, 13890.236037018061, 14280.42878284857, 9327.580258888367, 9334.066593340747, 9370.34407591462, 9393.671221507351, 9432.858507122399, 3551.2364841558674, 3564.108972756811, 3575.570931488186, 3616.3309787689363, 3623.873164439232, 1069.0, 1074.3661239868359, 1131.3833960491552, 1156.7166044319197, 1223.4311045363947, 34022.14944626404, 34043.48934765981, 34143.31713365719, 34229.82885085609, 34327.313453730785, 1151.6582484035307, 1162.6918866500384, 1177.3171560494893, 1178.6935396796723, 1233.6360773571819, 18105.185266663033, 18115.54711132206, 18216.726749098772, 18243.45269641913, 18285.451436456926, 605108.0, 605250.0, 608616.0, 608625.0, 610685.0, 64931.350686493475, 65264.0, 65530.34469655243, 65599.0, 65626.0, 1330.2484096485455, 1446.4286606790258, 1450.0864455393246, 1474.46182143519, 1494.8729358004691, 33182.0, 33832.1541961453, 34333.656663433045, 34395.312093757486, 34551.30897382089, 53928.46071539234, 54415.18377224424, 54481.18278225909, 54550.45449545613, 54586.45413545814, 414978.0, 424083.0, 425874.0, 426360.0, 427336.0, 27867.303317417227, 28370.85814570914, 29909.850450747606, 30979.845100775252, 31284.06147815569, 47970.28044579264, 48839.75580122077, 49744.50255497399, 51325.74337128291, 53595.46404535905, 44106.338404924594, 45280.54719452763, 45417.0, 46350.30474542817, 47051.05897882092, 44954.0, 45405.31892021689, 45649.54350456453, 45744.77127614341, 46960.7651961738, 44378.77810610926, 44966.1006779856, 45330.77334613306, 45702.77148614236, 45766.313505298116, 38626.0, 39376.97494463957, 39609.405858912716, 39974.0, 40174.0, 30117.849410752806, 30239.697603023687, 30268.54597181, 30757.0, 30798.69201308048], "value": 20760.602066443604, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.66038018634634, 412.18798966036917, 414.9087200815823, 423.3480440122211, 431.0731926358329, 18070.5482362941, 19029.2388304468, 19460.41618751438, 19477.0, 19985.800141998574, 11898.64304070877, 11927.761444771098, 12018.218815776969, 12609.4325755341, 12908.741825163492, 5234.528892399693, 5307.548858347045, 5405.648632838853, 5414.377346605132, 5468.234447177379, 5870.090136028923, 5879.794207202727, 5900.114982752579, 5939.227900372945, 5940.2871655401195, 5881.206037184989, 5883.8234852954265, 5889.734961926723, 5895.997680394344, 6217.59585626935, 6453.225612926455, 6560.671966401661, 6589.242237142742, 6601.3728695773825, 6608.7686930957425, 5613.298337707786, 5728.083506638918, 5728.455796699307, 5736.139579063132, 5901.822945311647, 13288.069835111546, 13297.933510332483, 13358.933205333911, 13387.531436399679, 13597.52408665692, 2418.8790560471907, 2504.461540768725, 2514.6353778701987, 2833.121732263005, 3065.080475857234, 9793.461359625218, 9951.601935922554, 10065.446400447972, 10385.42880141592, 10576.629817956335, 1968.0946764488353, 1973.2994786850604, 1979.0500559731408, 1992.561636439981, 2092.215419217793, 79368.0, 80962.0, 81816.0, 82427.0, 83499.16500835035, 11305.71735706614, 11422.31466112036, 11577.76844463106, 11597.18819682614, 11639.709007274885, 16284.918575407048, 16333.26500307489, 16411.0, 16437.506874793777, 16452.506424807274, 8195.7951051223, 8347.54088525137, 8352.958235208907, 8407.8318433631, 8676.392652514263, 7900.525968441912, 8005.399595030396, 8027.7993050173045, 8112.75661730149, 8216.712415065444, 4347.500037495665, 4478.731276123443, 4782.971661092882, 4806.2310030394965, 5003.574696150868, 2000.1099510717881, 2030.878147311166, 2099.601075795594, 2107.589020141058, 2108.50450144216, 912.6942474271061, 1013.9543720532594, 1022.5807418958192, 1098.9120870330355, 1113.5323164270865, 18681.43955681332, 18870.90564547196, 19435.611287774165, 19795.10922008513, 19797.208111675372, 982.3467394182932, 982.5283863745442, 1003.5433877585681, 1019.4240254256322, 1047.9790404191874, 10170.796584068277, 10850.0777433919, 10960.0, 10976.286541374786, 11031.448427578589, 494153.0, 497562.0, 509099.0, 511025.0, 513081.0, 89315.0, 89789.55105224432, 90551.0, 91121.54439227762, 91625.0, 1059.5338051257422, 1072.9731756706144, 1121.8429419881222, 1154.1286328821686, 1156.0578128824982, 17119.464086341646, 17135.914320428317, 17507.38724144649, 17524.91237543804, 17668.911655442156, 34799.65200347964, 38842.0, 38866.61133388743, 39885.999999998836, 41615.58384416117, 56101.438985609624, 57336.0, 58261.417385825596, 58618.0, 58670.41329586649, 8363.707270245755, 8577.399582029198, 8775.42959707617, 8869.64521419136, 9001.234895033995, 12101.576444824388, 12990.155639883378, 13032.54386096482, 13146.408411621309, 13324.067315287837, 11191.216614836883, 11388.715282118013, 11425.485853136463, 11913.0, 11961.102917281412, 11377.374244416636, 11471.885281147082, 11698.06415486742, 11757.647270581554, 12061.0, 11648.359340236368, 11700.47347869365, 11712.88287117118, 11813.940930295294, 12218.75562488763, 8225.095239523527, 8397.664093436195, 8635.956820215859, 8691.652333906573, 9176.353700943864, 9823.705288841345, 11372.943135284271, 11388.202825802446, 11670.124740644655, 11748.412579371168], "value": 9135.363589883193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.343278808142, 1455.294182321573, 1543.5909483986745, 1704.8977061376318, 1911.5507855653918, 8884.378093533454, 9269.397489163208, 9308.90691093089, 9385.577649005794, 9389.953050234739, 9215.769605759842, 9357.391769534976, 9396.0, 9418.905810941906, 9421.340506164572, 2118.5868755592664, 2335.1943579465055, 2379.8572085674873, 2419.177479656916, 2420.1529464687396, 2427.5387676341525, 2434.720007199177, 2436.8659723715186, 2438.9024439022505, 2439.7926176275037, 2313.2828823064906, 2359.95280094398, 2362.5511152880986, 2362.7164740231196, 2364.160722943356, 2029.3607513633233, 2322.837401381904, 2398.3524448399007, 2404.5912194926905, 2404.97595024051, 2329.79031887131, 2338.275134708246, 2345.601247787863, 2346.894389752448, 2363.881805909715, 9324.953375233148, 9343.71968840929, 9373.671921482784, 9387.295952803499, 9390.765230869214, 5178.0679477694, 5267.973660131714, 5277.445868183862, 5302.125149350352, 5307.761150748225, 3194.8242846643425, 3314.1548905029063, 3359.5968483782103, 3476.930461390758, 3485.89542313731, 1033.41095575522, 1038.0709265207672, 1056.1972900595526, 1115.676453828397, 1117.1398023521924, 12563.246205227715, 12608.180468269533, 12609.0, 12618.242905425612, 12618.68453288666, 4433.334999749999, 4572.9314060289125, 4579.290210017452, 4653.883652908637, 4654.371659825948, 10446.68659940203, 10449.0, 10450.16398688103, 10465.68602941913, 10472.633457828939, 4849.684770489906, 5178.275041494194, 5275.709835958983, 5279.340082489689, 5281.996420680135, 4679.578837904605, 4820.325154478376, 4835.975820120947, 4855.878603034882, 4916.680415772963, 4135.17296540687, 4138.52406973196, 4259.8083086261195, 4288.142371525707, 4322.481302243751, 1300.7008388070797, 1345.656857501331, 1346.4614154338342, 1357.7080927600614, 1365.283226306197, 1024.7386916336436, 1089.4443833644739, 1091.8307662312354, 1093.6227001684406, 1101.3446999035561, 6189.412005859526, 6382.20222472191, 6391.2330520337855, 6460.289368169498, 6648.66756662165, 394.89732669506134, 396.15025769724355, 397.45747055269925, 408.8671181865906, 409.89957460422386, 4466.508684044752, 4494.325851122358, 4495.25828238337, 4509.909801803946, 4514.300283456004, 11334.149938754626, 11611.419429028514, 11615.6515304541, 11620.0, 11634.6509604712, 10941.343519388862, 11350.14873884462, 11350.3757293348, 11454.541818327174, 11479.13906457019, 8476.872846907301, 8597.613107410307, 8612.311015118776, 8630.5253211074, 8679.088695686989, 6334.33489483616, 6455.67721613908, 6488.059231411325, 6490.902636460362, 6573.8027859162385, 10321.277510574188, 10584.259101862795, 10691.999999999689, 10715.410652414192, 10828.729281768019, 10790.838137428102, 10941.45292735344, 10973.286736362112, 11022.779544409228, 11098.389588572383, 7881.527108373516, 8140.430169888288, 8221.0, 8225.465344752572, 8320.417570769989, 9029.729108126767, 9033.006369299503, 9056.683016094668, 9064.909350906406, 9138.634454622006, 7972.521648701097, 8140.959295203723, 8166.510009399455, 8212.671493140446, 8277.54473503939, 7717.807054823675, 7883.054033515786, 7995.12053674107, 8039.839203215786, 8054.0, 7344.118705755343, 7368.962127147792, 7436.814079647836, 7539.208383119693, 7553.169151393452, 5639.407862174577, 5688.63023903445, 5714.314282285986, 5743.62666426681, 5840.036393994943, 5409.918851217313, 5619.943800561942, 5664.546836253007, 5696.544276457957, 5731.3408957968695], "value": 4723.8836368204675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.64966784875884, 335.1804837173111, 339.2485644297881, 342.3563700243542, 343.6340297583075, 5339.332583427072, 5367.516923476886, 5392.622516423852, 5417.4289456057795, 5449.182622606611, 5319.723266416061, 5342.610921160507, 5352.973235133829, 5362.65142765721, 5365.195220716894, 3961.7821019843896, 4026.335654616985, 4027.496562929634, 4145.917081658365, 4146.1914926589325, 4131.277026520362, 4203.957960420387, 4207.747535147885, 4217.1987322408795, 4219.346001369792, 4153.667706583481, 4168.353905144692, 4176.7469759072155, 4179.665626749868, 4186.476690413699, 3933.878844529324, 4056.9594304056877, 4134.338505839081, 4177.310743727281, 4188.1204946961025, 3691.7046636269033, 3694.9445758313377, 3708.61059588742, 3715.888523344304, 3716.628337166289, 5070.8225212117395, 5071.467495912912, 5101.087092340373, 5101.897962040738, 5117.0, 4710.528947105262, 4715.245560710304, 4748.264019077049, 4805.111054454902, 4823.686460380064, 5562.332520097614, 5565.9443405565835, 5599.916001259943, 5602.1596760485845, 5609.382967873531, 3894.162755007687, 3993.5407428145845, 4000.19996000801, 4010.498687664042, 4042.191561687645, 5573.637713548606, 5654.943450565442, 5784.913226301609, 5791.594588378773, 5822.417758224144, 4129.1625226774395, 4145.854895078718, 4146.232946904832, 4151.626353628128, 4153.605407486284, 4094.341791574417, 4112.773797441109, 4156.168766246763, 4193.559676234013, 4202.201581699467, 4679.321498382716, 4695.131400690883, 4702.388689470347, 4705.035467729107, 4706.576408123286, 5507.7246137692955, 5519.2824932758485, 5542.362628297717, 5551.806361632269, 5554.277943867352, 1362.2507620808515, 1418.4255376572505, 1431.9689823327187, 1433.8207724034496, 1435.7702767557141, 892.8169725206317, 897.1701176411923, 907.6550910653909, 908.52756566585, 925.2089463508738, 4831.613470922318, 4840.419149702058, 4852.563269305709, 4894.926576101361, 4898.0, 5031.974840125849, 5054.69671819692, 5070.239464080418, 5070.518300761421, 5080.695158290514, 4866.48901865299, 4867.683600565952, 4945.505449455098, 4950.2079667253065, 5090.9236361454605, 3032.757379409642, 3058.877644894224, 3068.8671373395723, 3069.4935335669365, 3087.521434177706, 6041.275046994301, 6048.153258543807, 6050.45545900871, 6054.182685337511, 6074.51403887688, 5556.805511807067, 5894.705264736746, 5903.911441328383, 5910.911336329958, 5916.970415147896, 5916.526677865761, 5978.013627751372, 5984.670843103584, 5994.7602095916545, 6011.188489553854, 5394.056040192872, 5555.944440555542, 5760.0, 5761.8559536011935, 5839.89042082003, 5656.88686226265, 5670.234518340137, 5683.23276357703, 5684.602077854511, 5687.7724891005555, 5957.106434034929, 5977.521798256216, 5993.910091348546, 5997.490213331916, 5997.490213331916, 3966.524017117849, 4016.7991600420446, 4019.397090436341, 4026.979865100656, 4032.6975476838766, 5746.913796292975, 5749.396313387201, 5753.165790960371, 5778.682172480554, 5790.189373487631, 5577.693226872399, 5655.660660360391, 5659.179418984142, 5661.490465858093, 5668.26312579362, 5378.919316210182, 5566.192902029102, 5579.163125531203, 5581.9162712560155, 5620.875824835131, 5438.510534051954, 5494.725263736877, 5506.724663766876, 5511.22842802016, 5529.142982837667, 5384.461553844584, 5567.777288908398, 5596.1605759136455, 5607.887842243051, 5630.0, 5475.370332411823, 5508.807191748269, 5514.420985796433, 5518.2826232589505, 5526.613137080366], "value": 4227.88166675932, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.6927998080749, 795.6737737527615, 804.9678012879485, 871.65569600008, 904.9140331668493, 17200.225989830455, 17583.120843957815, 17586.0, 17630.64738705225, 17634.118294085292, 16908.746368804477, 17019.48941531753, 17043.403480878173, 17060.0, 17064.573385665364, 728.0644371982004, 852.0031563071191, 878.5519385113606, 882.4176043811086, 883.3463237204454, 838.7483754873514, 844.7381311793364, 845.5434065604566, 845.8984921809391, 845.9196376344238, 886.1581497577295, 892.5180402582598, 893.1158153428124, 893.5487578772743, 894.021046953588, 762.672051018062, 896.26058501736, 898.3980732908934, 928.8467402878517, 930.3998920696113, 648.9123968264271, 670.8993650952348, 672.6367761408833, 673.1182151381705, 673.1282988529865, 15909.602259943478, 15996.52010439677, 16008.199590020453, 16027.439039633557, 16028.679426411523, 16104.83895161045, 16472.25874835623, 16576.66846663072, 16691.49925502237, 16705.164741762987, 12749.681257968625, 12835.679108022374, 12978.545750898767, 13066.0, 13070.738585228242, 4153.460050193486, 4163.83344666213, 4167.395727619509, 4173.686973477002, 4205.432266644025, 77850.61074694646, 79164.60417697932, 79256.0, 81221.78167327555, 81525.0, 12385.256884586774, 12677.619671409873, 12760.936195318964, 12816.679583010313, 12922.353882306035, 22877.19929802449, 23047.423814404774, 23051.423714406938, 24746.25761227166, 24831.87584062068, 9854.655087071918, 9951.850722239173, 9955.203583713286, 10007.249456290807, 10072.848907266396, 5185.922211166836, 5224.529792318634, 5259.894802103937, 5357.303550538405, 5365.865853353619, 3883.7475564088245, 3996.3805610130476, 4000.119973605802, 4004.8598299059977, 4007.779572123503, 692.6640579319027, 694.8679750847323, 702.8488874891923, 706.6890568149997, 715.488425775573, 676.5027704637088, 748.6855520681327, 823.9794005149919, 837.380338549469, 839.0, 11097.667069987914, 11184.496697648625, 11315.717107072389, 11434.970852623304, 11518.827217591743, 654.6759354119741, 766.7201471462876, 792.7463211772177, 824.6000689665508, 856.1224744636797, 4990.72551009698, 5114.5652619527755, 5138.30632864566, 5183.170692689152, 5233.110371236899, 71202.28797711956, 71436.64281678558, 71587.64206178936, 87375.56312218525, 125086.0, 60599.69700151559, 62347.376526235064, 64011.35988640054, 91963.0, 94977.525112374, 78964.21035789684, 80278.19721802825, 87890.56054719686, 91270.54364728267, 93009.53495232615, 10492.527836247235, 10907.127429805756, 11291.943540282246, 11336.149788765711, 11604.419779011185, 48531.0, 51188.0, 51663.74168129286, 51914.0, 54576.18135727888, 69515.0, 70051.64974175097, 74862.0, 75069.6246518764, 78695.0, 13786.724265514835, 13862.376193071537, 14035.559138340372, 14235.786463202852, 14680.0, 14915.850841491447, 15255.847441525886, 16165.272562734941, 16269.349226030827, 16448.917755411625, 14959.963349534093, 15188.392464301745, 15235.3905843765, 15662.9216853915, 15869.20653967274, 14979.101253924799, 15138.697226055638, 15148.16685082287, 15208.923955380153, 15211.923940380228, 14127.788083178555, 14303.64240893986, 15222.086674799548, 15362.30869610848, 16159.67680646404, 11854.798607657882, 12276.81584776247, 12440.875591243972, 12445.564405246136, 12465.404296836212, 12075.879241207827, 12489.750204996031, 12517.93741031289, 12656.810147847606, 12858.0], "value": 8083.502347814221, "unit": "score"}], "name": "dromaeo_css", "value": 7406.268138109094, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 132.0, 128.0, 170.0, 124.0, 125.0, 125.0, 150.0, 162.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 100.0, 74.0, 75.0, 75.0, 75.0, 102.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 117.0, 84.0, 83.0, 85.0, 123.0, 84.0, 84.0, 121.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 147.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 52.0, 51.0, 60.0, 53.0, 54.0, 50.0, 54.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 79.0, 77.0, 78.0, 83.0, 87.0, 103.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 130.0, 126.0, 125.0, 118.0, 122.0, 120.0, 129.0, 131.0, 121.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 157.0, 158.0, 159.0, 154.0, 159.0, 153.0, 154.0, 152.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 61.0, 60.0, 63.0, 61.0, 61.0, 60.0, 60.0, 63.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1479.2, "alertThreshold": 2.0}]} 03:30:25 INFO - Return code: 0 03:30:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:30:26 ERROR - # TBPL SUCCESS # 03:30:26 INFO - Running post-action listener: _resource_record_post_action 03:30:26 INFO - ##### 03:30:26 INFO - ##### Finished run-tests step (success) 03:30:26 INFO - ##### 03:30:26 INFO - Running post-run listener: _resource_record_post_run 03:30:26 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 502063104; Read time: 508; Write time: 851744 03:30:26 INFO - TinderboxPrint: CPU usage
13.1% 03:30:26 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 508 03:30:26 INFO - TinderboxPrint: I/O write bytes / time
502,063,104 / 851,744 03:30:26 INFO - TinderboxPrint: CPU idle
8,268.2 (86.9%) 03:30:26 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 03:30:26 INFO - TinderboxPrint: Swap in / out
0 / 0 03:30:26 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 252497920; Read time: 0; Write time: 538060 03:30:26 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 12288; Write bytes: 249565184; Read time: 508; Write time: 313684 03:30:26 INFO - Running post-run listener: _upload_blobber_files 03:30:26 INFO - Blob upload gear active. 03:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:30:26 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 03:30:26 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'] 03:30:26 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 03:30:27 INFO - (blobuploader) - INFO - Open directory for files ... 03:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:32 INFO - (blobuploader) - INFO - Done attempting. 03:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:33 INFO - (blobuploader) - INFO - Done attempting. 03:30:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:30:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:30:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:30:33 INFO - (blobuploader) - INFO - Done attempting. 03:30:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:30:33 INFO - Return code: 0 03:30:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:30:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:30:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5df6d00d99955876d81b72f6e31f120cea6fcc732c8e693ed36e73b19c21561fa24607e2322b6d9f533924f9b94e277dd679f1963aa4f3201f17042ec5f2f8ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee1873a79f7c249f48d339bdd97c0955f461d05fb81f002c786fc0351b08c85212287690ba86aee8e31dbe90ece4b88bcd49069d1793f9815587da947eb46d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9e799df9d9676a00bfe162bd580e2a9c48217faeb19c4dcf2ea95406b8ee3d9baacce209ea4664be21d07405efcee109a0414325598008a46d9d1f57f4a48be"} 03:30:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:30:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:30:33 INFO - Contents: 03:30:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5df6d00d99955876d81b72f6e31f120cea6fcc732c8e693ed36e73b19c21561fa24607e2322b6d9f533924f9b94e277dd679f1963aa4f3201f17042ec5f2f8ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee1873a79f7c249f48d339bdd97c0955f461d05fb81f002c786fc0351b08c85212287690ba86aee8e31dbe90ece4b88bcd49069d1793f9815587da947eb46d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9e799df9d9676a00bfe162bd580e2a9c48217faeb19c4dcf2ea95406b8ee3d9baacce209ea4664be21d07405efcee109a0414325598008a46d9d1f57f4a48be"} 03:30:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:30:33 INFO - Copying logs to upload dir... 03:30:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:30:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.498086 ========= master_lag: 1.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-30 03:30:34.629784) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:34.638333) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5df6d00d99955876d81b72f6e31f120cea6fcc732c8e693ed36e73b19c21561fa24607e2322b6d9f533924f9b94e277dd679f1963aa4f3201f17042ec5f2f8ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee1873a79f7c249f48d339bdd97c0955f461d05fb81f002c786fc0351b08c85212287690ba86aee8e31dbe90ece4b88bcd49069d1793f9815587da947eb46d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9e799df9d9676a00bfe162bd580e2a9c48217faeb19c4dcf2ea95406b8ee3d9baacce209ea4664be21d07405efcee109a0414325598008a46d9d1f57f4a48be"} build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5df6d00d99955876d81b72f6e31f120cea6fcc732c8e693ed36e73b19c21561fa24607e2322b6d9f533924f9b94e277dd679f1963aa4f3201f17042ec5f2f8ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee1873a79f7c249f48d339bdd97c0955f461d05fb81f002c786fc0351b08c85212287690ba86aee8e31dbe90ece4b88bcd49069d1793f9815587da947eb46d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d9e799df9d9676a00bfe162bd580e2a9c48217faeb19c4dcf2ea95406b8ee3d9baacce209ea4664be21d07405efcee109a0414325598008a46d9d1f57f4a48be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:34.664431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:34.664740) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1469873397.625054-1565031303 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.71 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:30:35.378521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:30:35.378829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:30:35.383134) ========= ========= Total master_lag: 1.91 =========