builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1465512867.5 results: success (0) buildid: 20160609130607 builduid: 6a4fdc5838bc41dfaee730cf1bbdf452 revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.497912) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.498361) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.498649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.513549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.513915) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 15:54:27-- 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% 18.5M=0.001s 2016-06-09 15:54:27 (18.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096749 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.624662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.624967) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018660 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.674350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:27.674703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3ccccf8e5036179a3178437cabc154b5e04b333d --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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 15:54:27,745 truncating revision to first 12 chars 2016-06-09 15:54:27,745 Setting DEBUG logging. 2016-06-09 15:54:27,745 attempt 1/10 2016-06-09 15:54:27,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ccccf8e5036?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 15:54:28,069 unpacking tar archive at: mozilla-central-3ccccf8e5036/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675181 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:28.363138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:28.363486) ========= script_repo_revision: 3ccccf8e5036179a3178437cabc154b5e04b333d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:28.363917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:28.364180) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 15:54:28.373732) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-09 15:54:28.374103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:28 INFO - MultiFileLogger online at 20160609 15:54:28 in /builds/slave/test 15:54:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:54:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:28 INFO - {'append_to_log': False, 15:54:28 INFO - 'base_work_dir': '/builds/slave/test', 15:54:28 INFO - 'blob_upload_branch': 'Firefox', 15:54:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:28 INFO - 'branch': 'Firefox', 15:54:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:28 INFO - 'config_files': ('talos/linux_config.py',), 15:54:28 INFO - 'default_actions': ('clobber', 15:54:28 INFO - 'read-buildbot-config', 15:54:28 INFO - 'download-and-extract', 15:54:28 INFO - 'populate-webroot', 15:54:28 INFO - 'create-virtualenv', 15:54:28 INFO - 'install', 15:54:28 INFO - 'run-tests'), 15:54:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:28 INFO - 'download_minidump_stackwalk': True, 15:54:28 INFO - 'download_symbols': 'ondemand', 15:54:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:28 INFO - 'installer_path': 'installer.exe', 15:54:28 INFO - 'log_level': 'info', 15:54:28 INFO - 'log_name': 'talos', 15:54:28 INFO - 'log_to_console': True, 15:54:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:28 INFO - 'opt_config_files': (), 15:54:28 INFO - 'pip_index': False, 15:54:28 INFO - 'sps_profile': False, 15:54:28 INFO - 'sps_profile_interval': 0, 15:54:28 INFO - 'suite': 'dromaeojs-e10s', 15:54:28 INFO - 'system_bits': '32', 15:54:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:28 INFO - 'title': 'talos-linux64-ix-047', 15:54:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:28 INFO - 'use_talos_json': True, 15:54:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:28 INFO - 'work_dir': 'build'} 15:54:28 INFO - ##### 15:54:28 INFO - ##### Running clobber step. 15:54:28 INFO - ##### 15:54:28 INFO - Running pre-action listener: _resource_record_pre_action 15:54:28 INFO - Running main action method: clobber 15:54:28 INFO - rmtree: /builds/slave/test/build 15:54:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:29 INFO - Running post-action listener: _resource_record_post_action 15:54:29 INFO - ##### 15:54:29 INFO - ##### Finished clobber step (success) 15:54:29 INFO - ##### 15:54:29 INFO - ##### 15:54:29 INFO - ##### Running read-buildbot-config step. 15:54:29 INFO - ##### 15:54:29 INFO - Running pre-action listener: _resource_record_pre_action 15:54:29 INFO - Running main action method: read_buildbot_config 15:54:29 INFO - Using buildbot properties: 15:54:29 INFO - { 15:54:29 INFO - "project": "", 15:54:29 INFO - "product": "firefox", 15:54:29 INFO - "script_repo_revision": "production", 15:54:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:54:29 INFO - "repository": "", 15:54:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:54:29 INFO - "buildid": "20160609130607", 15:54:29 INFO - "stage_platform": "linux64-pgo", 15:54:29 INFO - "basedir": "/builds/slave/test", 15:54:29 INFO - "nightly_build": "True", 15:54:29 INFO - "buildnumber": 749, 15:54:29 INFO - "slavename": "talos-linux64-ix-047", 15:54:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:54:29 INFO - "platform": "ubuntu64_hw", 15:54:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 15:54:29 INFO - "branch": "mozilla-central", 15:54:29 INFO - "repo_path": "mozilla-central", 15:54:29 INFO - "revision": "3ccccf8e5036179a3178437cabc154b5e04b333d", 15:54:29 INFO - "pgo_build": "True", 15:54:29 INFO - "builduid": "6a4fdc5838bc41dfaee730cf1bbdf452", 15:54:29 INFO - "slavebuilddir": "test" 15:54:29 INFO - } 15:54:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:54:29 INFO - Running post-action listener: _resource_record_post_action 15:54:29 INFO - ##### 15:54:29 INFO - ##### Finished read-buildbot-config step (success) 15:54:29 INFO - ##### 15:54:29 INFO - ##### 15:54:29 INFO - ##### Running download-and-extract step. 15:54:29 INFO - ##### 15:54:29 INFO - Running pre-action listener: _resource_record_pre_action 15:54:29 INFO - Running main action method: download_and_extract 15:54:29 INFO - mkdir: /builds/slave/test/build/tests 15:54: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')]} 15:54:29 INFO - https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:54:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:54:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:54:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:54:29 INFO - Downloaded 1361 bytes. 15:54:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:54:29 INFO - Using the following test package requirements: 15:54:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:54:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'jsshell-linux-x86_64.zip'], 15:54:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:54:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:54:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54: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')]} 15:54:29 INFO - https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:30 INFO - Downloaded 24452140 bytes. 15:54:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:54:32 INFO - Return code: 0 15:54:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:32 INFO - https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:54:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:54:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:33 INFO - Downloaded 24452140 bytes. 15:54:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:54:35 INFO - Return code: 0 15:54:35 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')]} 15:54:35 INFO - https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:54:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:36 INFO - Downloaded 10833377 bytes. 15:54:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:54:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:54:36 INFO - Return code: 0 15:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:36 INFO - https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:54:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:54:38 INFO - Downloaded 59355004 bytes. 15:54:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:54:38 INFO - mkdir: /builds/slave/test/properties 15:54:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:38 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:38 INFO - Contents: 15:54:38 INFO - build_url:https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:54:38 INFO - Running post-action listener: _resource_record_post_action 15:54:38 INFO - Running post-action listener: set_extra_try_arguments 15:54:38 INFO - ##### 15:54:38 INFO - ##### Finished download-and-extract step (success) 15:54:38 INFO - ##### 15:54:38 INFO - ##### 15:54:38 INFO - ##### Running populate-webroot step. 15:54:38 INFO - ##### 15:54:38 INFO - Running pre-action listener: _resource_record_pre_action 15:54:38 INFO - Running main action method: populate_webroot 15:54:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:38 INFO - '--tppagecycles', 15:54:38 INFO - '7'], 15:54:38 INFO - 'tests': ['tsvgm']}}, 15:54:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['damp', 'tps']}, 15:54:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'tests': ['damp', 'tps']}, 15:54:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['dromaeo_dom']}, 15:54:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['a11yr', 15:54:38 INFO - 'ts_paint', 15:54:38 INFO - 'tpaint', 15:54:38 INFO - 'sessionrestore', 15:54:38 INFO - 'sessionrestore_no_auto_restore', 15:54:38 INFO - 'tabpaint']}, 15:54:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['tsvgx', 15:54:38 INFO - 'tsvgr_opacity', 15:54:38 INFO - 'tart', 15:54:38 INFO - 'tscrollx', 15:54:38 INFO - 'cart']}, 15:54:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:38 INFO - 'tsvgr_opacity', 15:54:38 INFO - 'tart', 15:54:38 INFO - 'tscrollx', 15:54:38 INFO - 'cart']}, 15:54:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'talos_options': ['--disable-e10s'], 15:54:38 INFO - 'tests': ['tp5o']}, 15:54:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'tests': ['tp5o']}, 15:54:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'talos_options': ['--disable-e10s', 15:54:38 INFO - '--xperf_path', 15:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:38 INFO - 'tests': ['tp5n']}, 15:54:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:38 INFO - 'talos_options': ['--xperf_path', 15:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:38 INFO - 'tests': ['tp5n']}}, 15:54:38 INFO - 'talos.zip': {'path': '', 15:54:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:38 INFO - Running post-action listener: _resource_record_post_action 15:54:38 INFO - ##### 15:54:38 INFO - ##### Finished populate-webroot step (success) 15:54:38 INFO - ##### 15:54:38 INFO - ##### 15:54:38 INFO - ##### Running create-virtualenv step. 15:54:38 INFO - ##### 15:54:38 INFO - Running pre-action listener: _resource_record_pre_action 15:54:38 INFO - Running main action method: create_virtualenv 15:54:38 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:38 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 15:54:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:39 INFO - Using real prefix '/usr' 15:54:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:39 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:41 INFO - Installing pip.................done. 15:54:41 INFO - Return code: 0 15:54:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:41 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 15:54:41 INFO - Cleaning up... 15:54:41 INFO - Return code: 0 15:54:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:54:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:54:41 INFO - Using env: {'DISPLAY': ':0', 15:54:41 INFO - 'HOME': '/home/cltbld', 15:54:41 INFO - 'LANG': 'en_US.UTF-8', 15:54:41 INFO - 'LANGUAGE': 'en_US:en', 15:54:41 INFO - 'LOGNAME': 'cltbld', 15:54:41 INFO - 'MAIL': '/var/mail/cltbld', 15:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:41 INFO - 'MOZ_NO_REMOTE': '1', 15:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:41 INFO - 'NO_EM_RESTART': '1', 15:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:41 INFO - 'PWD': '/builds/slave/test', 15:54:41 INFO - 'SHELL': '/bin/bash', 15:54:41 INFO - 'SHLVL': '1', 15:54:41 INFO - 'TERM': 'linux', 15:54:41 INFO - 'TMOUT': '86400', 15:54:41 INFO - 'USER': 'cltbld', 15:54:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:41 INFO - '_': '/tools/buildbot/bin/python'} 15:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:41 INFO - Downloading/unpacking psutil>=3.1.1 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:44 INFO - Installing collected packages: psutil 15:54:44 INFO - Running setup.py install for psutil 15:54:44 INFO - building 'psutil._psutil_linux' extension 15:54:44 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 15:54:44 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 15:54:44 INFO - building 'psutil._psutil_posix' extension 15:54:44 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 15:54:44 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 15:54:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:44 INFO - Successfully installed psutil 15:54:44 INFO - Cleaning up... 15:54:44 INFO - Return code: 0 15:54:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:44 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')]} 15:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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')]} 15:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:44 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 15:54:44 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 15:54:44 INFO - Using env: {'DISPLAY': ':0', 15:54:44 INFO - 'HOME': '/home/cltbld', 15:54:44 INFO - 'LANG': 'en_US.UTF-8', 15:54:44 INFO - 'LANGUAGE': 'en_US:en', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MAIL': '/var/mail/cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SHLVL': '1', 15:54:44 INFO - 'TERM': 'linux', 15:54:44 INFO - 'TMOUT': '86400', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - '_': '/tools/buildbot/bin/python'} 15:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:44 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 15:54:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:46 INFO - Installing collected packages: mozsystemmonitor 15:54:46 INFO - Running setup.py install for mozsystemmonitor 15:54:46 INFO - Successfully installed mozsystemmonitor 15:54:46 INFO - Cleaning up... 15:54:46 INFO - Return code: 0 15:54:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:46 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:46 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 15:54:46 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 15:54:46 INFO - Using env: {'DISPLAY': ':0', 15:54:46 INFO - 'HOME': '/home/cltbld', 15:54:46 INFO - 'LANG': 'en_US.UTF-8', 15:54:46 INFO - 'LANGUAGE': 'en_US:en', 15:54:46 INFO - 'LOGNAME': 'cltbld', 15:54:46 INFO - 'MAIL': '/var/mail/cltbld', 15:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:46 INFO - 'MOZ_NO_REMOTE': '1', 15:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:46 INFO - 'NO_EM_RESTART': '1', 15:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:46 INFO - 'PWD': '/builds/slave/test', 15:54:46 INFO - 'SHELL': '/bin/bash', 15:54:46 INFO - 'SHLVL': '1', 15:54:46 INFO - 'TERM': 'linux', 15:54:46 INFO - 'TMOUT': '86400', 15:54:46 INFO - 'USER': 'cltbld', 15:54:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:46 INFO - '_': '/tools/buildbot/bin/python'} 15:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:47 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:47 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 15:54:47 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 15:54:47 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 15:54:47 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 15:54:47 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 15:54:47 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 15:54:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:48 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 15:54:48 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 15:54:48 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 15:54:48 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 15:54:48 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 15:54:48 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 15:54:49 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:49 INFO - warning: no files found matching '*.txt' 15:54:49 INFO - no previously-included directories found matching 'build' 15:54:49 INFO - no previously-included directories found matching 'dist' 15:54:49 INFO - no previously-included directories found matching '.git*' 15:54:49 INFO - Installing collected packages: jsonschema, functools32 15:54:49 INFO - Running setup.py install for functools32 15:54:49 INFO - warning: no files found matching '*.txt' 15:54:49 INFO - no previously-included directories found matching 'build' 15:54:49 INFO - no previously-included directories found matching 'dist' 15:54:49 INFO - no previously-included directories found matching '.git*' 15:54:49 INFO - Successfully installed jsonschema functools32 15:54:49 INFO - Cleaning up... 15:54:49 INFO - Return code: 0 15:54:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:49 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:49 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 15:54:49 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 15:54:49 INFO - Using env: {'DISPLAY': ':0', 15:54:49 INFO - 'HOME': '/home/cltbld', 15:54:49 INFO - 'LANG': 'en_US.UTF-8', 15:54:49 INFO - 'LANGUAGE': 'en_US:en', 15:54:49 INFO - 'LOGNAME': 'cltbld', 15:54:49 INFO - 'MAIL': '/var/mail/cltbld', 15:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:49 INFO - 'MOZ_NO_REMOTE': '1', 15:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:49 INFO - 'NO_EM_RESTART': '1', 15:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:49 INFO - 'PWD': '/builds/slave/test', 15:54:49 INFO - 'SHELL': '/bin/bash', 15:54:49 INFO - 'SHLVL': '1', 15:54:49 INFO - 'TERM': 'linux', 15:54:49 INFO - 'TMOUT': '86400', 15:54:49 INFO - 'USER': 'cltbld', 15:54:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:49 INFO - '_': '/tools/buildbot/bin/python'} 15:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:49 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:49 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 15:54:49 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 15:54:49 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 15:54:49 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 15:54:49 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 15:54:49 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 15:54:51 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:51 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 15:54:51 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 15:54:51 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 15:54:51 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 15:54:51 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 15:54:51 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 15:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 INFO - Downloading docopt-0.6.1.tar.gz 15:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:52 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:52 INFO - Running setup.py install for blobuploader 15:54:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:52 INFO - Running setup.py install for requests 15:54:52 INFO - Running setup.py install for docopt 15:54:53 INFO - Successfully installed blobuploader requests docopt 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:53 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 15:54:53 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 15:54:53 INFO - Using env: {'DISPLAY': ':0', 15:54:53 INFO - 'HOME': '/home/cltbld', 15:54:53 INFO - 'LANG': 'en_US.UTF-8', 15:54:53 INFO - 'LANGUAGE': 'en_US:en', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MAIL': '/var/mail/cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SHLVL': '1', 15:54:53 INFO - 'TERM': 'linux', 15:54:53 INFO - 'TMOUT': '86400', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - '_': '/tools/buildbot/bin/python'} 15:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:53 INFO - Running setup.py (path:/tmp/pip-uJfyMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:53 INFO - Running setup.py (path:/tmp/pip-5iGluu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:53 INFO - Running setup.py (path:/tmp/pip-y4KjWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:53 INFO - Running setup.py (path:/tmp/pip-7Sp3R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:53 INFO - Running setup.py (path:/tmp/pip-V4DmCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:53 INFO - Running setup.py (path:/tmp/pip-K5PIgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:53 INFO - Running setup.py (path:/tmp/pip-YddX0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:53 INFO - Running setup.py (path:/tmp/pip-RGMr57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:53 INFO - Running setup.py (path:/tmp/pip-CugFHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:53 INFO - Running setup.py (path:/tmp/pip-PQVh4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:54 INFO - Running setup.py (path:/tmp/pip-LbQOir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:54 INFO - Running setup.py (path:/tmp/pip-ex5K2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:54 INFO - Running setup.py (path:/tmp/pip-5T7y2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:54 INFO - Running setup.py (path:/tmp/pip-Y7Xkv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:54 INFO - Running setup.py (path:/tmp/pip-8kRU5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:54 INFO - Running setup.py (path:/tmp/pip-N2IhC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:54 INFO - Running setup.py (path:/tmp/pip-OZK0n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:54 INFO - Running setup.py install for manifestparser 15:54:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:54 INFO - Running setup.py install for mozcrash 15:54:54 INFO - Running setup.py install for mozdebug 15:54:54 INFO - Running setup.py install for mozdevice 15:54:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozfile 15:54:55 INFO - Running setup.py install for mozhttpd 15:54:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozinfo 15:54:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozInstall 15:54:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozleak 15:54:55 INFO - Running setup.py install for mozlog 15:54:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for moznetwork 15:54:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozprocess 15:54:55 INFO - Running setup.py install for mozprofile 15:54:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:55 INFO - Running setup.py install for mozrunner 15:54:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:56 INFO - Running setup.py install for mozscreenshot 15:54:56 INFO - Running setup.py install for moztest 15:54:56 INFO - Running setup.py install for mozversion 15:54:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:54:56 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 15:54:56 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 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:56 INFO - Running setup.py (path:/tmp/pip-qoGqOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:56 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)) 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:56 INFO - Running setup.py (path:/tmp/pip-kBRoMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:56 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)) 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:56 INFO - Running setup.py (path:/tmp/pip-pjVsfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:56 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)) 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:56 INFO - Running setup.py (path:/tmp/pip-lqqMB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:56 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)) 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:56 INFO - Running setup.py (path:/tmp/pip-XYOaEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:56 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)) 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:56 INFO - Running setup.py (path:/tmp/pip-__vMCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:57 INFO - Running setup.py (path:/tmp/pip-sYjPSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:57 INFO - Running setup.py (path:/tmp/pip-9jO8fL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:57 INFO - Running setup.py (path:/tmp/pip-oYIHdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:57 INFO - Running setup.py (path:/tmp/pip-L8XRL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:57 INFO - Running setup.py (path:/tmp/pip-MhNW6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:57 INFO - Running setup.py (path:/tmp/pip-NCVnfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:57 INFO - Running setup.py (path:/tmp/pip-OBdf9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:57 INFO - Running setup.py (path:/tmp/pip-EIYPIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:57 INFO - Running setup.py (path:/tmp/pip-xSnO7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:57 INFO - Running setup.py (path:/tmp/pip-rAcbbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:57 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)) 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:57 INFO - Running setup.py (path:/tmp/pip-s4lDj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 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)) 15:54:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:57 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 15:54:59 INFO - Downloading blessings-1.6.tar.gz 15:54:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:59 INFO - Installing collected packages: blessings 15:54:59 INFO - Running setup.py install for blessings 15:54:59 INFO - Successfully installed blessings 15:54:59 INFO - Cleaning up... 15:54:59 INFO - Return code: 0 15:54:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:00 INFO - Reading from file tmpfile_stdout 15:55:00 INFO - Current package versions: 15:55:00 INFO - argparse == 1.2.1 15:55:00 INFO - blessings == 1.6 15:55:00 INFO - blobuploader == 1.2.4 15:55:00 INFO - docopt == 0.6.1 15:55:00 INFO - functools32 == 3.2.3-2 15:55:00 INFO - jsonschema == 2.5.1 15:55:00 INFO - manifestparser == 1.1 15:55:00 INFO - mozInstall == 1.12 15:55:00 INFO - mozcrash == 0.17 15:55:00 INFO - mozdebug == 0.1 15:55:00 INFO - mozdevice == 0.48 15:55:00 INFO - mozfile == 1.2 15:55:00 INFO - mozhttpd == 0.7 15:55:00 INFO - mozinfo == 0.9 15:55:00 INFO - mozleak == 0.1 15:55:00 INFO - mozlog == 3.2 15:55:00 INFO - moznetwork == 0.27 15:55:00 INFO - mozprocess == 0.22 15:55:00 INFO - mozprofile == 0.28 15:55:00 INFO - mozrunner == 6.11 15:55:00 INFO - mozscreenshot == 0.1 15:55:00 INFO - mozsystemmonitor == 0.3 15:55:00 INFO - moztest == 0.7 15:55:00 INFO - mozversion == 1.4 15:55:00 INFO - psutil == 3.1.1 15:55:00 INFO - requests == 1.2.3 15:55:00 INFO - wsgiref == 0.1.2 15:55:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:00 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:55:00 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 15:55:00 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 15:55:00 INFO - Using env: {'DISPLAY': ':0', 15:55:00 INFO - 'HOME': '/home/cltbld', 15:55:00 INFO - 'LANG': 'en_US.UTF-8', 15:55:00 INFO - 'LANGUAGE': 'en_US:en', 15:55:00 INFO - 'LOGNAME': 'cltbld', 15:55:00 INFO - 'MAIL': '/var/mail/cltbld', 15:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:00 INFO - 'MOZ_NO_REMOTE': '1', 15:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:00 INFO - 'NO_EM_RESTART': '1', 15:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:00 INFO - 'PWD': '/builds/slave/test', 15:55:00 INFO - 'SHELL': '/bin/bash', 15:55:00 INFO - 'SHLVL': '1', 15:55:00 INFO - 'TERM': 'linux', 15:55:00 INFO - 'TMOUT': '86400', 15:55:00 INFO - 'USER': 'cltbld', 15:55:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:00 INFO - '_': '/tools/buildbot/bin/python'} 15:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 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)) 15:55:00 INFO - Cleaning up... 15:55:00 INFO - Return code: 0 15:55:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:00 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:55:00 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 15:55:00 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 15:55:00 INFO - Using env: {'DISPLAY': ':0', 15:55:00 INFO - 'HOME': '/home/cltbld', 15:55:00 INFO - 'LANG': 'en_US.UTF-8', 15:55:00 INFO - 'LANGUAGE': 'en_US:en', 15:55:00 INFO - 'LOGNAME': 'cltbld', 15:55:00 INFO - 'MAIL': '/var/mail/cltbld', 15:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:00 INFO - 'MOZ_NO_REMOTE': '1', 15:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:00 INFO - 'NO_EM_RESTART': '1', 15:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:00 INFO - 'PWD': '/builds/slave/test', 15:55:00 INFO - 'SHELL': '/bin/bash', 15:55:00 INFO - 'SHLVL': '1', 15:55:00 INFO - 'TERM': 'linux', 15:55:00 INFO - 'TMOUT': '86400', 15:55:00 INFO - 'USER': 'cltbld', 15:55:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:00 INFO - '_': '/tools/buildbot/bin/python'} 15:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:55:00 INFO - Cleaning up... 15:55:00 INFO - Return code: 0 15:55:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:55: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')]} 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55: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')]} 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:00 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 0x7f2044063f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a5190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, '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': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', '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 15:55:00 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 15:55:00 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 15:55:00 INFO - Using env: {'DISPLAY': ':0', 15:55:00 INFO - 'HOME': '/home/cltbld', 15:55:00 INFO - 'LANG': 'en_US.UTF-8', 15:55:00 INFO - 'LANGUAGE': 'en_US:en', 15:55:00 INFO - 'LOGNAME': 'cltbld', 15:55:00 INFO - 'MAIL': '/var/mail/cltbld', 15:55:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:00 INFO - 'MOZ_NO_REMOTE': '1', 15:55:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:00 INFO - 'NO_EM_RESTART': '1', 15:55:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:00 INFO - 'PWD': '/builds/slave/test', 15:55:00 INFO - 'SHELL': '/bin/bash', 15:55:00 INFO - 'SHLVL': '1', 15:55:00 INFO - 'TERM': 'linux', 15:55:00 INFO - 'TMOUT': '86400', 15:55:00 INFO - 'USER': 'cltbld', 15:55:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:55:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:00 INFO - '_': '/tools/buildbot/bin/python'} 15:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:00 INFO - Downloading/unpacking flake8 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:55:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:55:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:55:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:55:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:55:03 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 15:55:03 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 15:55:03 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 15:55:03 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 15:55:03 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 15:55:03 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 15:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:03 INFO - no previously-included directories found matching 'docs/_build' 15:55:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:55:03 INFO - Running setup.py install for pep8 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:55:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:55:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:55:03 INFO - no previously-included directories found matching 'docs/_build' 15:55:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:55:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:55:03 INFO - Cleaning up... 15:55:03 INFO - Return code: 0 15:55:03 INFO - Running post-action listener: _resource_record_post_action 15:55:03 INFO - Running post-action listener: _start_resource_monitoring 15:55:03 INFO - Starting resource monitoring. 15:55:03 INFO - ##### 15:55:03 INFO - ##### Finished create-virtualenv step (success) 15:55:03 INFO - ##### 15:55:03 INFO - ##### 15:55:03 INFO - ##### Running install step. 15:55:03 INFO - ##### 15:55:03 INFO - Running pre-action listener: _resource_record_pre_action 15:55:03 INFO - Running main action method: install 15:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:03 INFO - Reading from file tmpfile_stdout 15:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:55:04 INFO - Reading from file tmpfile_stdout 15:55:04 INFO - Output received: 15:55:04 INFO - Usage: mozinstall [options] installer 15:55:04 INFO - Options: 15:55:04 INFO - -h, --help show this help message and exit 15:55:04 INFO - -d DEST, --destination=DEST 15:55:04 INFO - Directory to install application into. [default: 15:55:04 INFO - "/builds/slave/test"] 15:55:04 INFO - --app=APP Application being installed. [default: firefox] 15:55:04 INFO - mkdir: /builds/slave/test/build/application 15:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:55:20 INFO - Reading from file tmpfile_stdout 15:55:20 INFO - Output received: 15:55:20 INFO - /builds/slave/test/build/application/firefox/firefox 15:55:20 INFO - Running post-action listener: _resource_record_post_action 15:55:20 INFO - ##### 15:55:20 INFO - ##### Finished install step (success) 15:55:20 INFO - ##### 15:55:20 INFO - ##### 15:55:20 INFO - ##### Running run-tests step. 15:55:20 INFO - ##### 15:55:20 INFO - Running pre-action listener: _resource_record_pre_action 15:55:20 INFO - Running main action method: run_tests 15:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:20 INFO - Python 2.7.3 15:55:20 INFO - Return code: 0 15:55:20 INFO - grabbing minidump binary from tooltool 15:55:20 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')]} 15:55:20 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 0x2237110>, '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 0x21a3230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21a36c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:20 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 15:55:20 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 15:55:20 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 15:55:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:20 INFO - Return code: 0 15:55:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:55:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:55:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:55:21 INFO - Return code: 0 15:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:55:21 INFO - Using env: {'DISPLAY': ':0', 15:55:21 INFO - 'HOME': '/home/cltbld', 15:55:21 INFO - 'LANG': 'en_US.UTF-8', 15:55:21 INFO - 'LANGUAGE': 'en_US:en', 15:55:21 INFO - 'LOGNAME': 'cltbld', 15:55:21 INFO - 'MAIL': '/var/mail/cltbld', 15:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:21 INFO - 'MOZ_NO_REMOTE': '1', 15:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:21 INFO - 'NO_EM_RESTART': '1', 15:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:21 INFO - 'PWD': '/builds/slave/test', 15:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:21 INFO - 'SHELL': '/bin/bash', 15:55:21 INFO - 'SHLVL': '1', 15:55:21 INFO - 'TERM': 'linux', 15:55:21 INFO - 'TMOUT': '86400', 15:55:21 INFO - 'USER': 'cltbld', 15:55:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117', 15:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:21 INFO - '_': '/tools/buildbot/bin/python'} 15:55:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:55:22 INFO - mozversion application_buildid: 20160609130607 15:55:22 INFO - mozversion application_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 15:55:22 INFO - mozversion application_display_name: Nightly 15:55:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:22 INFO - mozversion application_name: Firefox 15:55:22 INFO - mozversion application_remotingname: firefox 15:55:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:55:22 INFO - mozversion application_vendor: Mozilla 15:55:22 INFO - mozversion application_version: 50.0a1 15:55:22 INFO - mozversion platform_buildid: 20160609130607 15:55:22 INFO - mozversion platform_changeset: 3ccccf8e5036179a3178437cabc154b5e04b333d 15:55:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:55:22 INFO - mozversion platform_version: 50.0a1 15:55:22 INFO - using testdate: 1465512922 15:55:22 INFO - actual date: 1465512922 15:55:22 INFO - starting webserver on 'localhost:49900' 15:55:22 INFO - SUITE-START | Running 2 tests 15:55:22 INFO - TEST-START | dromaeo_css 15:55:22 INFO - operating with platform_type : linux_ 15:55:22 INFO - Initialising browser for dromaeo_css test... 15:55:22 INFO - TEST-INFO | started process 17839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3tjnt/profile http://localhost:49900/getInfo.html) 15:55:26 INFO - PROCESS | 17839 | __metrics Screen width/height:1600/1200 15:55:26 INFO - PROCESS | 17839 | colorDepth:24 15:55:26 INFO - PROCESS | 17839 | Browser inner width/height: 1024/697 15:55:26 INFO - PROCESS | 17839 | __metrics 15:55:27 ERROR - PROCESS | 17839 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:55:28 INFO - TEST-INFO | 17839: exit 0 15:55:28 INFO - Browser initialized. 15:55:28 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:28 INFO - TEST-INFO | started process 17957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN3tjnt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:40 INFO - PROCESS | 17957 | RSS: Main: 184737792 15:55:40 INFO - PROCESS | 17957 | 15:56:29 INFO - PROCESS | 17957 | 1465512989665 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] 15:58:37 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49900/tests/dromaeo/cssquery-ext.html) 15:58:38 INFO - PROCESS | 17957 | RSS: Main: 188092416 15:58:38 INFO - PROCESS | 17957 | 16:01:40 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-ext.html (next: http://localhost:49900/tests/dromaeo/cssquery-jquery.html) 16:01:41 INFO - PROCESS | 17957 | RSS: Main: 187060224 16:01:41 INFO - PROCESS | 17957 | 16:04:43 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49900/tests/dromaeo/cssquery-mootools.html) 16:04:44 INFO - PROCESS | 17957 | RSS: Main: 188411904 16:04:44 INFO - PROCESS | 17957 | 16:07:45 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49900/tests/dromaeo/cssquery-prototype.html) 16:07:46 INFO - PROCESS | 17957 | RSS: Main: 186322944 16:07:46 INFO - PROCESS | 17957 | 16:10:49 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49900/tests/dromaeo/cssquery-yui.html) 16:10:49 INFO - PROCESS | 17957 | RSS: Main: 188260352 16:10:49 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-yui.html (next: http://localhost:49900/tests/dromaeo/cssquery-dojo.html) 16:13:52 INFO - PROCESS | 17957 | RSS: Main: 188952576 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | __start_tp_report 16:13:52 INFO - PROCESS | 17957 | _x_x_mozilla_page_load 16:13:52 INFO - PROCESS | 17957 | _x_x_mozilla_page_load_details 16:13:52 INFO - PROCESS | 17957 | |i|pagename|runs| 16:13:52 INFO - PROCESS | 17957 | |0;dojo.html;3114.766392520561;3184.4586420308547;3184.601924759405;3205.5512228288057;3211.42194405007;5502.80740174094;5511.200875873001;5518;5548.140038294061;5565.165225216219;5381.546982314772;5442.83671489855;5448.482394172557;5460.699661518614;5513.476219759126;4911.435184953741;4946.505349465043;5000.049990501811;5066.949330506703;5119.692818430906;732.7382108357103;4930.556249937505;4985.002999400116;5026.874328141807;5103.897922041557;5064.645474816764;5074.086664400406;5099.872503187413;5105.106606343894;5110.182370820651;5113.488651134857;5127.179651255781;5142.254373115878;5149.76826042829;5150.922736158961;4932.556069953722;4990.65065445419;5013.122703526905;5024.547790698818;5031.471695471996;5521.337439507245;5521.889562208774;5526.447355264481;5529.30883639545;5593.74828132735;5783.306003279633;5894.675792831393;5967.522598192134;6046.213992181032;6050.515958723292;5984.551158663117;6013.218281623361;6024.668643224621;6044.093385992092;6067.908981365283;5653.886922261573;5656.660600363992;5661.5187709044785;5661.745221465044;5672.914906276409;5915.792947246826;6031.909521357183;6052.697365131726;6153.1693221415435;6177.69111544421;5873.4126587340925;5878.412158784087;5883.882322353529;5892.381299963442;5918.526517878559;5930.584859059824;5935.287765468085;5941.287045554561;5953.970230148821;5962.1056841473255;5679.176519404663;5930.406959304121;5930.822075337746;5960.85097872548;6015.0676645120075;5971.611845230046;6004.5496587755215;6007.729652165575;6017.217761691039;6021.518278537794;4540.477845047796;4576.290674945389;4587.9082418351445;4590.977045114753;4653.139169253699;3877.651011408987;3991.7006224533275;4002.779847108437;4027.1140349123148;4048.4736984192455;5693.800716974886;5706.80026199081;5723.284589426322;5730.971345143331;5773.076307790733;6099.9390006099375;6102.511799056065;6102.542309326818;6102.603330783485;6118.694065296718;5545.306836645419;5639.069553523705;5715.228444160069;5752.424757524298;5781.971090144522;5008.348914641073;5016.2224855147515;5023.623228257822;5035.446100928895;5078.542931136216;5956.85107872298;6155.529581457846;6200.038993955944;6205.2553693557065;6214.1921550198185;5901.468867801918;5936.050231962865;5946.583739138218;5967.433093856077;5972.163897054329;6132.233470816148;6154.476869465966;6194.690265486798;6201.782937597162;6209.441150296495;5726.5418766499415;5856.677882716492;5906.468417842415;5913.319968203712;5921.348651648229;6006.939930600638;6058.5153187745755;6071.423214794588;6075.605085669417;6121.296050954197;5727.226824378822;5866.384029676993;5884.35272120075;5889.234399528034;5891.49922256613;5676.801311954062;5748.712564371681;5761.567882408753;5855.3266374365785;5863.149843272787;5625.043742563692;5699.5725320600295;5729.312482502127;5740.712964351849;5795.652260864362;5908.320543137423;5952.285725712942;5952.345242023461;5954.970225148846;5956.285245770535;5611.775528978795;5816.447437493432;5816.970915145397;5827.4172582741385;5833.416658334133 16:13:52 INFO - PROCESS | 17957 | |1;ext.html;575.884823035393;606.484488185043;616.417485476225;642.5373730913741;644.3395519592418;37463.62536374635;41200.38199427007;41234.7938260309;41337.37993930093;41411.17177656452;41917.79041104798;42513.57486425135;42530.787346063225;42619.786901065454;42664;8789.64841406343;8940.955295223548;8954.776130596754;8964.551772411385;8966.462012279251;8757.25563327118;8862.86705699415;8874.955625221897;8876.644934202624;8881.445746994283;8905.287576993858;8926.419782714136;8951.910480895205;8970.10298970101;8985.910140898573;8854.247388971913;8911;8920.776980575472;8948.552572371356;8959.820803583956;8718;8838.86741698875;8855.822883542292;8856.114388561156;8857.645694172226;39997.60002399968;40095.39856902149;40167.196656067004;40372.192556149006;40459.19081618351;3384.712299454525;3640.453931910208;3859.3439115350457;3910.804459777028;3944.2505923874373;32113.1971700707;32155.19612009695;32406.189845253823;32436;33107.172320692174;4296.355546667994;4387.946892745718;4437.733735975852;4469.687121901468;4510.188166130095;246564;247450.9999999982;247595;247821;247894;55573.722131389084;56312.71843640837;56398.15402768962;56509.152362714594;56528.71735641378;35354.64645353565;35736.821315893256;35771.82114089413;58348;59158.40841591529;17765.555861103316;17865.910670446825;17891.46325610234;17957.820421795615;17993.19030643624;13626.250556219504;13703.45186192541;13772.931135344259;13777.242251676254;13876.028677992444;19260.052343564097;19358;19437.611247775247;19437.708434373497;19554;7056.894146587805;7140.393756279024;7200.675969581277;7255.8911616325795;7362.190159082496;899.4333569850952;972.8248915195333;985.5762022330323;991.4150651115876;1035.2753072849036;33286.66713332884;33308.66691333104;33400.66599334024;33720.49419258713;33969;1068.1614932278123;1069.8983596558314;1073.812082885492;1116.0959622705634;1143.6054561176381;16846.831531684773;17126.828731712772;17231.56921076958;17494.912525437292;17559.824401756076;571437;576409;580513;582109;584129;39594.20811583752;57986.420135798944;58350.41649583535;58439;58490.70754646284;1310.960671179866;1357.2060344698461;1371.615947534692;1372.1766939836218;1388.3891087921281;31167.220819479695;32041.359172815948;32124.196895076875;32268.19329516781;32700.83649581737;49599;49629.25556116733;50159.74920125376;50193;50279.74860125676;452641;452654;452930;455663;455857;27209.86395068012;27566;27678.169654910384;27754.5836812452;28460.430791383642;45678.04595924722;46532.7673361631;46716.53283467258;46728.766356168;48869;40870;42017.57982420137;42023.15953680848;42134;42456;40321.798391007855;40483.3927491082;40626.79686601548;40822.18355632811;41445.1710965785;37737.43393849149;40405.19189616133;40944.59055409408;41445;44027.77986110177;35396.29207415889;37448.438273426465;37891.431628526145;38044.61955380411;38049.80975095107;28208.435831282848;28532.615456576517;28546.572671366765;28592.85703571469;28976.13071607855 16:13:52 INFO - PROCESS | 17957 | |2;jquery.html;376.779583943393;383.8982669592557;393.2685205517737;396.6014155773447;399.5485101834926;17449.825501744977;18652.53368665784;20354.08406621702;20723.896380518116;20740.48148796281;11439.942800286008;11792.174547781637;11895.7620847583;11996.100292478055;16663.50009499714;5102.54077133057;5270.762815673284;5297.602679799012;5301;5304.681719096867;3850;5483.8080667176655;5740.741666624991;5749.885002299951;5800.796972105977;5644.040513112781;5702.315722113352;5768.077107662775;5787.797427090053;5796.681182534959;5779.075347944351;5833.949889019975;5837.41625837415;5880.353161152269;5881.500072493843;5502.367227768817;5671.234383358235;5680.6591604503865;5681.488666020036;5702.2301989231755;21765.891170544044;22481.325560233217;22658.886705566365;22674.88662556693;22860.885695571582;2169.3383518026994;2226.6326056200705;2295.2081531871645;2537.695476542827;2723.72762723728;9963.601455941754;9984.251181161442;10129.89870101297;10296.07335339823;10391.584336626525;1844.9077546122774;1881.2851116575614;1907.7233801098762;1921.625283069802;1961.695937129747;80735.5963220186;85516.99999999937;86632;86767.56616216942;87419;9666.709998700051;9816.803663926825;10303.433311167957;10607.681769546925;10833.512491937725;14904.776428353583;15010.849891501164;15030.699386012437;15031.248437578077;15077.54767356981;7948.324392426593;8116.472429292077;8127.552984585786;8136.918630813616;8273.627686754111;7905.288524032865;7920.485168464032;8050.194980501903;8119.704701976958;8204.548749818818;4394.758288294174;4397.450318710161;4484.417025786627;4496.1906856765445;4639.121155931853;1780.777402824647;1782.393986044751;1877.1552801239498;1940.3305859478457;1972.260402349119;1006.9295149339476;1007.1388962437011;1010.4745532323298;1027.429776474064;1056.0917610854658;17058.914705426392;18096.547586310448;18932.905335473235;19259.133338999778;19332.226710931685;985.9161971232382;992.2607657295362;1018.8879223285433;1041.4792603698152;1071.1591400750374;10650.414227217423;10828.458577071273;10833.241673082808;10867.565297388173;10878.075363594184;479236;483526;487104;490095;509532;64416;66323.33676663268;94935;96371.51814240884;98800;966.7003228998892;980.8970058143935;991.7124034030195;992.3400938376044;993.9900600994042;16814.327426903277;16996.830031700018;17006;17142;17306.740398893773;34960.825195873855;40449.1910161801;41660.58339416567;41708.1658366837;42587.7870610645;56824;58220.708896455246;58530;58730;59450.216493505264;6350.364963503613;6433.517486188648;7420.369268612012;7946.721864734706;8302.875456868273;9434.764130896783;9640;9969.451680157661;12499.187552809402;12635.305058221886;6683.532152749261;9325.440473571607;11695.649130526097;11817.231879927776;12379.566715164927;11058.668239952814;11499.19505634631;11741;12013.279203247834;12082.818757718816;12194;12244.326562039174;12270.631881043582;12372.81440778371;12444.813327800272;7361.227071157666;8201.466904651179;8489.915100848912;8618.956905215684;8828.514431706319;10101.79796404053;11602.825957610474;12142.089343299465;12226.87773122293;12271.57049503263 16:13:52 INFO - PROCESS | 17957 | |3;mootools.html;1463.8023866777985;1465.3552436927755;1527.74455871801;1674.0206978917333;1679.4038116468653;7891.4081443891655;8378.37162212835;8625;9009.954950225248;9066.592003359849;8486.53324067176;8660.133986601337;8777.16616921393;8863.556822158882;8868.556572171381;2344.894479748407;2368.9644655330185;2382.4877651304964;2385.355953892448;2387.6537902004197;2322.7096612923383;2346.6831977682964;2370.691810064689;2372.6796882420826;2376.6316220985686;2345.7771511706446;2350.6003979323555;2359.3983534198755;2382.1424287256573;2386.4391867911027;2260.513989492259;2277.8633282003134;2278.168468508999;2278.1798552521077;2282.931512054641;2251.786080322383;2271.704678391815;2284.554511870186;2285.1316499729996;2300.562893050315;8679.913200867974;8782.60478278479;8815.250703690193;8830.955845220797;8845.911540884574;5298.682079075268;5352.304200453955;5542.334919809608;5543;5544.667319960775;3445.3109378124223;3555.306715190539;3615;3632.8546858125906;3678.9632103678887;1184.3545267829054;1216.1000859364008;1226.7546490701895;1236.8886800187936;1251.599488163788;12217.877821221762;12465.75068498634;12478.43847026877;12482;12515.186512876633;4715.159076731129;4859.489753575895;4884.0476107158765;4892.8532144035735;4914.164592019365;10487.94756026215;10607.681769546925;10626.246669299479;10671.039606435457;10700.518476668569;5294.973525132426;5344;5351.143816989263;5366;5379.435159308295;4425.867223983286;4946.455889852114;4981.90036199274;5103.744812759347;5118.513741194581;4112.403701463331;4150.252954468225;4196.91606167881;4227.682923780729;4372.759498227628;1294.6569159172827;1306.4969986555245;1312.8030795380769;1342.8992825538123;1343.3484759891444;812.561216942856;871.7166920750655;901.7520181950016;911.2118017914456;962.2638681408728;6210.937890621126;6256.624602523863;6277.52918531112;6319.747210111544;6500.9349906501275;962.932594718377;993.7267251505893;1012.281280290987;1013.9695809125737;1027.106417416837;4214.452121224222;4341.848035318749;4391.297392417198;4417.757023363682;4460.955390446054;10890.183236257153;11276.041536469327;11328.32030078198;11354.943225283985;11356.602518911965;10534.36793792375;10986.285891417032;11017.944910275397;11331.206815522833;11355.375454349925;8189.7133600323705;8418.116097809765;8443.831123377498;8458.999999999876;8486.0665326814;5978.222831031938;6198.721057552511;6250.749970001149;6252.280987686474;6279;10159.390436573829;10447;10493.47532623381;10537.57849686004;10616.044555989998;10585.364878107339;10628.468576571295;10651.254412191072;10708.464576771286;10739.979701928305;7255.455840812066;7590.468667193243;7823.06123265189;8110.635021423932;8200.220979006985;8468.280196183394;8482.448640838325;8504.319654427754;8517.23344898962;8530.74407767768;7794.883076753967;7991.92008079935;7999.400044996532;8055;8108.148644392254;7708.267714567107;7767;7879.054513458422;7910.446268761361;8085.393595480245;6791.898121528082;7305.817354566178;7355.521891077063;7425.628718564159;7429.07136607924;5123.38519377677;5221.947780522146;5243.842684719464;5246.947530524646;5300.01949639318;5244.160934250502;5279.947200527946;5351.759170837399;5499.477549632778;5522.3649280333275 16:13:52 INFO - PROCESS | 17957 | |4;prototype.html;315.6117974890884;326.50697446855247;326.88722390775183;331.5060559765948;331.61532622158273;5494.697791621459;5580.720963951796;5674.858128546788;5689.516391106756;5754.899461696482;5560.972195139028;5609.57928155389;5610.326760788701;5614.326280846294;5632.577556683244;4388.078503514266;4407.206702793504;4427.1367083418745;4431.224535706255;4451.132029254297;4139.979300103495;4350.2387082260475;4355.843857290645;4454.198244316021;4466.8436604718845;4260.36094585813;4314.935275970863;4315.719478233905;4316.374125751764;4355.54266801986;4213.199492096523;4330.112326972963;4357.346398040288;4384.758838263894;4385.649148068147;3793.487879136309;3801.182745709658;3801.4297855321647;3808.409696497047;3828.587989566583;5504.972475137639;5534.916976245359;5562.9443705562835;5572.442755724395;5573.888522229573;4799.6400269979895;4920.785646459108;4923.630727695438;4972.378452693413;5021.372328458942;5828.475437210629;5870.559708021873;5896.024831681392;5909.911351329733;5986.820395388146;4118.814653340607;4164.292070348048;4175.830767385137;4190.476190476191;4208.768517731523;6021.849453763647;6076.817695469143;6135.509159267248;6214.782482613132;6282.2461304643275;4239.8092085856215;4255.76593287366;4268.957310426918;4301.397804307399;4308.590683885026;4349.499807522112;4352.630026447724;4369.815092453773;4370.628496577763;4384.802683879169;4678.485366609671;4948.727819969936;4974.756310922269;5013.573846223039;5018.369030065171;5730.971345143247;5901.232839730894;5932.881342373128;5949.077892926603;6008.819735407945;1499.3852520466774;1499.6475828180369;1502.9479364444715;1505.744023516005;1505.8720008799155;933.7021788039716;941.5547135147516;954.1555723185031;956.5886668732372;963.4412041016194;5118.082692865031;5158.458361872024;5237.292965449616;5253.212018197224;5269.499397557226;5353.785848566014;5370.013095154818;5390.568754499631;5424.213489044067;5571.690652696613;4920.950790492121;5049.166887463527;5119.976004799055;5173.508516690908;5230.267762513251;2929.8974535891143;2940.3972185701878;2943.3818898031227;2952.822830630126;2954.1875984104545;5573.27547418833;5633.8309850704545;5639.915401268984;5653.236813030188;5664.51851592611;5313.548348390353;5459.617826752089;5479.767052413175;5513.8345849624575;5607.579431542569;5441.29263195782;5529.557635389159;5592.552595792326;5604.8318550443555;5674.411164873759;5103.208746102631;5334.973325133349;5404.973294895328;5430.266913966564;5454.4272851351625;5382.515573598238;5383.300170977905;5385.192221166856;5399.487048730364;5405.675609475704;5534.889302214014;5544.61187716856;5559.72201389937;5599.692016939108;5641.464060914206;3761.307411664707;3853.826577804062;3866.7819636814315;3897.7466464679705;3928.508936382952;5421.430749771217;5430.239766432782;5431.1262614397965;5931.7627294907725;6016.819495415145;5920.674362910081;5990.7004649768205;6016.909746353896;6028.367021462858;6038.6678732670125;5877.382874798255;5912.970435147797;5970.611910225822;6048.818535443944;6069.241344831896;5696.572757043321;5926.2295901532525;5939.524838013035;5953.464188223081;5985.640861548147;6046.637201767908;6073.423024812636;6074.969625151846;6084.665343406155;6093.750781089954;5523.2819733436;5886.823395298148;5895.616784909139;5898.793542226002;5945.810837832537 16:13:52 INFO - PROCESS | 17957 | |5;yui.html;745.6495447139846;758.4451873658998;759.6429678051314;790.9841803163937;794.5947566740962;14182.290885455724;14926.701465970675;15181.924090379533;15255.92372038141;15279;15033.323500442479;15115.093094414315;15120.621984450394;15155.54533363998;15243;677.3226773226774;787.7046107709609;800.4756884240817;803.1887793328722;823.9670413183466;791.2562191539963;801.2348207461889;801.6072124658905;802.626778547975;805.3557154276584;858.7638399440142;859.2138193552922;859.8280343931208;860.4880096342666;860.496609483453;853.3983541603186;855.3285670748495;856.3705676327894;857.2884505860152;857.4683696108452;619.1115748900297;619.4486906653083;621.8911690454153;622.5548732656127;622.9439350458435;14982.400703971827;15020.399184032625;15022.399104035934;15032.549023529311;15097.849021509754;14650.487232946796;14653;14677.339519721638;14750.55748327552;14795.778063329059;12191.329476878856;12277.140600157993;12289.56986505477;12350.073744469111;12839.753043217399;3833;3874.8837534874;4004.539477960043;4076.612721791425;4078.6940979426363;72722;73193;73355;73575.63212183959;74015;11360.318380897008;11740.941295293469;11936.701582460508;12149.574764883188;12219.633410997685;22623;22660.433489162904;22665.660015099787;22675.319740407813;22932.885335573217;8333.083360830304;8410;8627.309815214769;8670.826583468295;8759.781005474913;4734.881627959259;4742.549457801503;4781.784819683123;4891.804327826847;4896.4124305083615;3309.9172520686693;3404.1829960809227;3416.4704470807064;3436.0207340908223;3439.226174110855;583.4573846322876;605.1709158452948;608.5162295974711;609.7591451376682;616.0635833533095;665.9600423974578;701.8070030741587;710.2932582080759;710.5878590417545;747.3946103656056;10011.549480273405;10378.221633377376;10534.947325263478;10564.418956957288;10750.838737418944;639.6162302618392;737.4727070144872;741.4365082537203;745;751.1099347273498;4784.330193772875;4940.752962351868;4986.825461108916;5024.497550244946;5025.648204625714;106804;106861.46569267104;107767.46116269525;110164.27666078613;112835;92315.5384223088;93808;95121.5243923776;96133;96788;85670;85953;86734.56632716797;87333.12666873376;87773.56113219394;9025;9231.723048308562;9275.25797936177;9525.333226674065;9593.760155996157;38387.6161238384;46904;48955.12538495403;49972.75013624909;50046;51941.48058519366;67383.66308168428;69910.30089699241;71850.64074679594;76689.2331076682;11922.582709605122;11951.103667225167;12002.75994480123;12048.518059277882;12349.93825030869;12708.618741437771;13102.803457948328;13132.606021819362;13343.466261349437;13903;12341.568045118378;12572.937135314265;12744.61766147017;13198.736025279633;13216.603501894959;11855.70360740954;12008.39958002114;12331.69170770702;12333.75332493363;12810.67973300675;12443.688907777378;13505.034182722187;13574.524891628746;13670.52153174634;14337.283135842958;11546.32578276162;11856.76286474283;12070.336131512851;12111.394430278628;12290.20113692643;11837.644870653894;12433.254004759743;12524.812127817908;12673.93663031679;12692.271161700279 16:13:52 INFO - PROCESS | 17957 | __end_tp_report 16:13:52 INFO - PROCESS | 17957 | __start_cc_report 16:13:52 INFO - PROCESS | 17957 | _x_x_mozilla_cycle_collect,342 16:13:52 INFO - PROCESS | 17957 | __end_cc_report 16:13:52 INFO - PROCESS | 17957 | __startTimestamp1465514032462__endTimestamp 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | ------- Summary: start ------- 16:13:52 INFO - PROCESS | 17957 | Number of tests: 6 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#0] dojo.html Cycles:165 Average:5513.34 Median:5761.57 stddev:749.77 (13.0%) stddev-sans-first:728.08 16:13:52 INFO - PROCESS | 17957 | Values: 3114.8 3184.5 3184.6 3205.6 3211.4 5502.8 5511.2 5518.0 5548.1 5565.2 5381.5 5442.8 5448.5 5460.7 5513.5 4911.4 4946.5 5000.0 5066.9 5119.7 732.7 4930.6 4985.0 5026.9 5103.9 5064.6 5074.1 5099.9 5105.1 5110.2 5113.5 5127.2 5142.3 5149.8 5150.9 4932.6 4990.7 5013.1 5024.5 5031.5 5521.3 5521.9 5526.4 5529.3 5593.7 5783.3 5894.7 5967.5 6046.2 6050.5 5984.6 6013.2 6024.7 6044.1 6067.9 5653.9 5656.7 5661.5 5661.7 5672.9 5915.8 6031.9 6052.7 6153.2 6177.7 5873.4 5878.4 5883.9 5892.4 5918.5 5930.6 5935.3 5941.3 5954.0 5962.1 5679.2 5930.4 5930.8 5960.9 6015.1 5971.6 6004.5 6007.7 6017.2 6021.5 4540.5 4576.3 4587.9 4591.0 4653.1 3877.7 3991.7 4002.8 4027.1 4048.5 5693.8 5706.8 5723.3 5731.0 5773.1 6099.9 6102.5 6102.5 6102.6 6118.7 5545.3 5639.1 5715.2 5752.4 5782.0 5008.3 5016.2 5023.6 5035.4 5078.5 5956.9 6155.5 6200.0 6205.3 6214.2 5901.5 5936.1 5946.6 5967.4 5972.2 6132.2 6154.5 6194.7 6201.8 6209.4 5726.5 5856.7 5906.5 5913.3 5921.3 6006.9 6058.5 6071.4 6075.6 6121.3 5727.2 5866.4 5884.4 5889.2 5891.5 5676.8 5748.7 5761.6 5855.3 5863.1 5625.0 5699.6 5729.3 5740.7 5795.7 5908.3 5952.3 5952.3 5955.0 5956.3 5611.8 5816.4 5817.0 5827.4 5833.4 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#1] ext.html Cycles:180 Average:58432.66 Median:41286.09 stddev:119428.14 (289.3%) stddev-sans-first:119684.17 16:13:52 INFO - PROCESS | 17957 | Values: 575.9 606.5 616.4 642.5 644.3 37463.6 41200.4 41234.8 41337.4 41411.2 41917.8 42513.6 42530.8 42619.8 42664.0 8789.6 8941.0 8954.8 8964.6 8966.5 8757.3 8862.9 8875.0 8876.6 8881.4 8905.3 8926.4 8951.9 8970.1 8985.9 8854.2 8911.0 8920.8 8948.6 8959.8 8718.0 8838.9 8855.8 8856.1 8857.6 39997.6 40095.4 40167.2 40372.2 40459.2 3384.7 3640.5 3859.3 3910.8 3944.3 32113.2 32155.2 32406.2 32436.0 33107.2 4296.4 4387.9 4437.7 4469.7 4510.2 246564.0 247451.0 247595.0 247821.0 247894.0 55573.7 56312.7 56398.2 56509.2 56528.7 35354.6 35736.8 35771.8 58348.0 59158.4 17765.6 17865.9 17891.5 17957.8 17993.2 13626.3 13703.5 13772.9 13777.2 13876.0 19260.1 19358.0 19437.6 19437.7 19554.0 7056.9 7140.4 7200.7 7255.9 7362.2 899.4 972.8 985.6 991.4 1035.3 33286.7 33308.7 33400.7 33720.5 33969.0 1068.2 1069.9 1073.8 1116.1 1143.6 16846.8 17126.8 17231.6 17494.9 17559.8 571437.0 576409.0 580513.0 582109.0 584129.0 39594.2 57986.4 58350.4 58439.0 58490.7 1311.0 1357.2 1371.6 1372.2 1388.4 31167.2 32041.4 32124.2 32268.2 32700.8 49599.0 49629.3 50159.7 50193.0 50279.7 452641.0 452654.0 452930.0 455663.0 455857.0 27209.9 27566.0 27678.2 27754.6 28460.4 45678.0 46532.8 46716.5 46728.8 48869.0 40870.0 42017.6 42023.2 42134.0 42456.0 40321.8 40483.4 40626.8 40822.2 41445.2 37737.4 40405.2 40944.6 41445.0 44027.8 35396.3 37448.4 37891.4 38044.6 38049.8 28208.4 28532.6 28546.6 28592.9 28976.1 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#2] jquery.html Cycles:180 Average:28478.98 Median:20424.37 stddev:80832.94 (395.8%) stddev-sans-first:81032.15 16:13:52 INFO - PROCESS | 17957 | Values: 376.8 383.9 393.3 396.6 399.5 17449.8 18652.5 20354.1 20723.9 20740.5 11439.9 11792.2 11895.8 11996.1 16663.5 5102.5 5270.8 5297.6 5301.0 5304.7 3850.0 5483.8 5740.7 5749.9 5800.8 5644.0 5702.3 5768.1 5787.8 5796.7 5779.1 5833.9 5837.4 5880.4 5881.5 5502.4 5671.2 5680.7 5681.5 5702.2 21765.9 22481.3 22658.9 22674.9 22860.9 2169.3 2226.6 2295.2 2537.7 2723.7 9963.6 9984.3 10129.9 10296.1 10391.6 1844.9 1881.3 1907.7 1921.6 1961.7 80735.6 85517.0 86632.0 86767.6 87419.0 9666.7 9816.8 10303.4 10607.7 10833.5 14904.8 15010.8 15030.7 15031.2 15077.5 7948.3 8116.5 8127.6 8136.9 8273.6 7905.3 7920.5 8050.2 8119.7 8204.5 4394.8 4397.5 4484.4 4496.2 4639.1 1780.8 1782.4 1877.2 1940.3 1972.3 1006.9 1007.1 1010.5 1027.4 1056.1 17058.9 18096.5 18932.9 19259.1 19332.2 985.9 992.3 1018.9 1041.5 1071.2 10650.4 10828.5 10833.2 10867.6 10878.1 479236.0 483526.0 487104.0 490095.0 509532.0 64416.0 66323.3 94935.0 96371.5 98800.0 966.7 980.9 991.7 992.3 994.0 16814.3 16996.8 17006.0 17142.0 17306.7 34960.8 40449.2 41660.6 41708.2 42587.8 56824.0 58220.7 58530.0 58730.0 59450.2 6350.4 6433.5 7420.4 7946.7 8302.9 9434.8 9640.0 9969.5 12499.2 12635.3 6683.5 9325.4 11695.6 11817.2 12379.6 11058.7 11499.2 11741.0 12013.3 12082.8 12194.0 12244.3 12270.6 12372.8 12444.8 7361.2 8201.5 8489.9 8619.0 8828.5 10101.8 11602.8 12142.1 12226.9 12271.6 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#3] mootools.html Cycles:180 Average:5941.12 Median:4871.77 stddev:3354.84 (68.9%) stddev-sans-first:3347.37 16:13:52 INFO - PROCESS | 17957 | Values: 1463.8 1465.4 1527.7 1674.0 1679.4 7891.4 8378.4 8625.0 9010.0 9066.6 8486.5 8660.1 8777.2 8863.6 8868.6 2344.9 2369.0 2382.5 2385.4 2387.7 2322.7 2346.7 2370.7 2372.7 2376.6 2345.8 2350.6 2359.4 2382.1 2386.4 2260.5 2277.9 2278.2 2278.2 2282.9 2251.8 2271.7 2284.6 2285.1 2300.6 8679.9 8782.6 8815.3 8831.0 8845.9 5298.7 5352.3 5542.3 5543.0 5544.7 3445.3 3555.3 3615.0 3632.9 3679.0 1184.4 1216.1 1226.8 1236.9 1251.6 12217.9 12465.8 12478.4 12482.0 12515.2 4715.2 4859.5 4884.0 4892.9 4914.2 10487.9 10607.7 10626.2 10671.0 10700.5 5295.0 5344.0 5351.1 5366.0 5379.4 4425.9 4946.5 4981.9 5103.7 5118.5 4112.4 4150.3 4196.9 4227.7 4372.8 1294.7 1306.5 1312.8 1342.9 1343.3 812.6 871.7 901.8 911.2 962.3 6210.9 6256.6 6277.5 6319.7 6500.9 962.9 993.7 1012.3 1014.0 1027.1 4214.5 4341.8 4391.3 4417.8 4461.0 10890.2 11276.0 11328.3 11354.9 11356.6 10534.4 10986.3 11017.9 11331.2 11355.4 8189.7 8418.1 8443.8 8459.0 8486.1 5978.2 6198.7 6250.7 6252.3 6279.0 10159.4 10447.0 10493.5 10537.6 10616.0 10585.4 10628.5 10651.3 10708.5 10740.0 7255.5 7590.5 7823.1 8110.6 8200.2 8468.3 8482.4 8504.3 8517.2 8530.7 7794.9 7991.9 7999.4 8055.0 8108.1 7708.3 7767.0 7879.1 7910.4 8085.4 6791.9 7305.8 7355.5 7425.6 7429.1 5123.4 5221.9 5243.8 5246.9 5300.0 5244.2 5279.9 5351.8 5499.5 5522.4 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#4] prototype.html Cycles:180 Average:4787.95 Median:5405.32 stddev:1400.00 (25.9%) stddev-sans-first:1363.09 16:13:52 INFO - PROCESS | 17957 | Values: 315.6 326.5 326.9 331.5 331.6 5494.7 5580.7 5674.9 5689.5 5754.9 5561.0 5609.6 5610.3 5614.3 5632.6 4388.1 4407.2 4427.1 4431.2 4451.1 4140.0 4350.2 4355.8 4454.2 4466.8 4260.4 4314.9 4315.7 4316.4 4355.5 4213.2 4330.1 4357.3 4384.8 4385.6 3793.5 3801.2 3801.4 3808.4 3828.6 5505.0 5534.9 5562.9 5572.4 5573.9 4799.6 4920.8 4923.6 4972.4 5021.4 5828.5 5870.6 5896.0 5909.9 5986.8 4118.8 4164.3 4175.8 4190.5 4208.8 6021.8 6076.8 6135.5 6214.8 6282.2 4239.8 4255.8 4269.0 4301.4 4308.6 4349.5 4352.6 4369.8 4370.6 4384.8 4678.5 4948.7 4974.8 5013.6 5018.4 5731.0 5901.2 5932.9 5949.1 6008.8 1499.4 1499.6 1502.9 1505.7 1505.9 933.7 941.6 954.2 956.6 963.4 5118.1 5158.5 5237.3 5253.2 5269.5 5353.8 5370.0 5390.6 5424.2 5571.7 4921.0 5049.2 5120.0 5173.5 5230.3 2929.9 2940.4 2943.4 2952.8 2954.2 5573.3 5633.8 5639.9 5653.2 5664.5 5313.5 5459.6 5479.8 5513.8 5607.6 5441.3 5529.6 5592.6 5604.8 5674.4 5103.2 5335.0 5405.0 5430.3 5454.4 5382.5 5383.3 5385.2 5399.5 5405.7 5534.9 5544.6 5559.7 5599.7 5641.5 3761.3 3853.8 3866.8 3897.7 3928.5 5421.4 5430.2 5431.1 5931.8 6016.8 5920.7 5990.7 6016.9 6028.4 6038.7 5877.4 5913.0 5970.6 6048.8 6069.2 5696.6 5926.2 5939.5 5953.5 5985.6 6046.6 6073.4 6075.0 6084.7 6093.8 5523.3 5886.8 5895.6 5898.8 5945.8 16:13:52 INFO - PROCESS | 17957 | 16:13:52 INFO - PROCESS | 17957 | [#5] yui.html Cycles:180 Average:20152.66 Median:25491.35 stddev:28538.69 (112.0%) stddev-sans-first:28581.54 16:13:52 INFO - PROCESS | 17957 | Values: 745.6 758.4 759.6 791.0 794.6 14182.3 14926.7 15181.9 15255.9 15279.0 15033.3 15115.1 15120.6 15155.5 15243.0 677.3 787.7 800.5 803.2 824.0 791.3 801.2 801.6 802.6 805.4 858.8 859.2 859.8 860.5 860.5 853.4 855.3 856.4 857.3 857.5 619.1 619.4 621.9 622.6 622.9 14982.4 15020.4 15022.4 15032.5 15097.8 14650.5 14653.0 14677.3 14750.6 14795.8 12191.3 12277.1 12289.6 12350.1 12839.8 3833.0 3874.9 4004.5 4076.6 4078.7 72722.0 73193.0 73355.0 73575.6 74015.0 11360.3 11740.9 11936.7 12149.6 12219.6 22623.0 22660.4 22665.7 22675.3 22932.9 8333.1 8410.0 8627.3 8670.8 8759.8 4734.9 4742.5 4781.8 4891.8 4896.4 3309.9 3404.2 3416.5 3436.0 3439.2 583.5 605.2 608.5 609.8 616.1 666.0 701.8 710.3 710.6 747.4 10011.5 10378.2 10534.9 10564.4 10750.8 639.6 737.5 741.4 745.0 751.1 4784.3 4940.8 4986.8 5024.5 5025.6 106804.0 106861.5 107767.5 110164.3 112835.0 92315.5 93808.0 95121.5 96133.0 96788.0 85670.0 85953.0 86734.6 87333.1 87773.6 9025.0 9231.7 9275.3 9525.3 9593.8 38387.6 46904.0 48955.1 49972.8 50046.0 51941.5 67383.7 69910.3 71850.6 76689.2 11922.6 11951.1 12002.8 12048.5 12349.9 12708.6 13102.8 13132.6 13343.5 13903.0 12341.6 12572.9 12744.6 13198.7 13216.6 11855.7 12008.4 12331.7 12333.8 12810.7 12443.7 13505.0 13574.5 13670.5 14337.3 11546.3 11856.8 12070.3 12111.4 12290.2 11837.6 12433.3 12524.8 12673.9 12692.3 16:13:52 INFO - PROCESS | 17957 | -------- Summary: end -------- 16:13:52 INFO - PROCESS | 17957 | 16:13:53 INFO - TEST-INFO | 17957: exit 0 16:13:53 INFO - TEST-OK | dromaeo_css | took 1111100ms 16:13:53 INFO - TEST-START | kraken 16:13:53 INFO - operating with platform_type : linux_ 16:13:53 INFO - Initialising browser for kraken test... 16:13:53 INFO - TEST-INFO | started process 18196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNgGkv/profile http://localhost:49900/getInfo.html) 16:13:57 INFO - PROCESS | 18196 | __metrics Screen width/height:1600/1200 16:13:57 INFO - PROCESS | 18196 | colorDepth:24 16:13:57 INFO - PROCESS | 18196 | Browser inner width/height: 1024/697 16:13:57 INFO - PROCESS | 18196 | __metrics 16:13:58 ERROR - PROCESS | 18196 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:13:59 INFO - TEST-INFO | 18196: exit 0 16:13:59 INFO - Browser initialized. 16:13:59 INFO - Running cycle 1/1 for kraken test... 16:13:59 INFO - TEST-INFO | started process 18315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNgGkv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:10 INFO - PROCESS | 18315 | RSS: Main: 185114624 16:14:10 INFO - PROCESS | 18315 | 16:14:13 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:14 INFO - PROCESS | 18315 | RSS: Main: 189493248 16:14:14 INFO - PROCESS | 18315 | 16:14:17 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-dft) 16:14:17 INFO - PROCESS | 18315 | RSS: Main: 189259776 16:14:17 INFO - PROCESS | 18315 | 16:14:20 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-fft) 16:14:21 INFO - PROCESS | 18315 | RSS: Main: 184840192 16:14:21 INFO - PROCESS | 18315 | 16:14:23 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-oscillator) 16:14:23 INFO - PROCESS | 18315 | RSS: Main: 184893440 16:14:23 INFO - PROCESS | 18315 | 16:14:26 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:26 INFO - PROCESS | 18315 | RSS: Main: 185446400 16:14:26 INFO - PROCESS | 18315 | 16:14:29 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:30 INFO - PROCESS | 18315 | RSS: Main: 185344000 16:14:30 INFO - PROCESS | 18315 | 16:14:33 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:34 INFO - PROCESS | 18315 | RSS: Main: 183263232 16:14:34 INFO - PROCESS | 18315 | 16:14:37 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49900/tests/kraken/driver.html?testName=json-parse-financial) 16:14:38 INFO - PROCESS | 18315 | RSS: Main: 184856576 16:14:38 INFO - PROCESS | 18315 | 16:14:39 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:40 INFO - PROCESS | 18315 | RSS: Main: 185401344 16:14:40 INFO - PROCESS | 18315 | 16:14:42 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:42 INFO - PROCESS | 18315 | RSS: Main: 185413632 16:14:42 INFO - PROCESS | 18315 | 16:14:44 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:45 INFO - PROCESS | 18315 | RSS: Main: 185524224 16:14:45 INFO - PROCESS | 18315 | 16:14:47 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:48 INFO - PROCESS | 18315 | RSS: Main: 186109952 16:14:48 INFO - PROCESS | 18315 | 16:14:51 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:51 INFO - PROCESS | 18315 | RSS: Main: 185913344 16:14:51 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49900/tests/kraken/driver.html?testName=ai-astar) 16:14:53 INFO - PROCESS | 18315 | RSS: Main: 186650624 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | __start_tp_report 16:14:53 INFO - PROCESS | 18315 | _x_x_mozilla_page_load 16:14:53 INFO - PROCESS | 18315 | _x_x_mozilla_page_load_details 16:14:53 INFO - PROCESS | 18315 | |i|pagename|runs| 16:14:53 INFO - PROCESS | 18315 | |0;ai-astar;110;106;110;111;111;111;109;109;110;111 16:14:53 INFO - PROCESS | 18315 | |1;audio-beat-detection;158;124;155;176;134;159;155;128;188;135 16:14:53 INFO - PROCESS | 18315 | |2;audio-dft;162;163;162;162;166;175;163;161;164;162 16:14:53 INFO - PROCESS | 18315 | |3;audio-fft;78;75;76;156;75;76;84;75;157;76 16:14:53 INFO - PROCESS | 18315 | |4;audio-oscillator;84;83;149;84;84;85;139;85;85;145 16:14:53 INFO - PROCESS | 18315 | |5;imaging-gaussian-blur;120;119;118;119;118;118;119;119;118;118 16:14:53 INFO - PROCESS | 18315 | |6;imaging-darkroom;147;147;150;146;147;148;146;146;146;147 16:14:53 INFO - PROCESS | 18315 | |7;imaging-desaturate;96;95;96;96;95;95;96;95;95;95 16:14:53 INFO - PROCESS | 18315 | |8;json-parse-financial;55;55;56;54;55;53;57;54;55;54 16:14:53 INFO - PROCESS | 18315 | |9;json-stringify-tinderbox;61;61;60;61;61;60;61;61;60;62 16:14:53 INFO - PROCESS | 18315 | |10;stanford-crypto-aes;80;80;79;81;79;80;80;81;106;79 16:14:53 INFO - PROCESS | 18315 | |11;stanford-crypto-ccm;131;123;121;132;128;133;126;133;132;124 16:14:53 INFO - PROCESS | 18315 | |12;stanford-crypto-pbkdf2;157;164;162;162;156;161;159;165;157;160 16:14:53 INFO - PROCESS | 18315 | |13;stanford-crypto-sha256-iterative;64;64;69;64;63;66;63;63;63;63 16:14:53 INFO - PROCESS | 18315 | __end_tp_report 16:14:53 INFO - PROCESS | 18315 | __start_cc_report 16:14:53 INFO - PROCESS | 18315 | _x_x_mozilla_cycle_collect,895 16:14:53 INFO - PROCESS | 18315 | __end_cc_report 16:14:53 INFO - PROCESS | 18315 | __startTimestamp1465514093908__endTimestamp 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | ------- Summary: start ------- 16:14:53 INFO - PROCESS | 18315 | Number of tests: 14 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.50 stddev:1.55 (1.4%) stddev-sans-first:1.64 16:14:53 INFO - PROCESS | 18315 | Values: 110.0 106.0 110.0 111.0 111.0 111.0 109.0 109.0 110.0 111.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:156.50 stddev:20.93 (13.4%) stddev-sans-first:22.05 16:14:53 INFO - PROCESS | 18315 | Values: 158.0 124.0 155.0 176.0 134.0 159.0 155.0 128.0 188.0 135.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.11 (2.5%) stddev-sans-first:4.29 16:14:53 INFO - PROCESS | 18315 | Values: 162.0 163.0 162.0 162.0 166.0 175.0 163.0 161.0 164.0 162.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:33.68 (44.3%) stddev-sans-first:35.30 16:14:53 INFO - PROCESS | 18315 | Values: 78.0 75.0 76.0 156.0 75.0 76.0 84.0 75.0 157.0 76.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:29.11 (34.7%) stddev-sans-first:30.11 16:14:53 INFO - PROCESS | 18315 | Values: 84.0 83.0 149.0 84.0 84.0 85.0 139.0 85.0 85.0 145.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 16:14:53 INFO - PROCESS | 18315 | Values: 120.0 119.0 118.0 119.0 118.0 118.0 119.0 119.0 118.0 118.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 16:14:53 INFO - PROCESS | 18315 | Values: 147.0 147.0 150.0 146.0 147.0 148.0 146.0 146.0 146.0 147.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:14:53 INFO - PROCESS | 18315 | Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:1.20 16:14:53 INFO - PROCESS | 18315 | Values: 55.0 55.0 56.0 54.0 55.0 53.0 57.0 54.0 55.0 54.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:14:53 INFO - PROCESS | 18315 | Values: 61.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 60.0 62.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:80.00 stddev:8.29 (10.4%) stddev-sans-first:8.74 16:14:53 INFO - PROCESS | 18315 | Values: 80.0 80.0 79.0 81.0 79.0 80.0 80.0 81.0 106.0 79.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:131.50 stddev:4.52 (3.4%) stddev-sans-first:4.69 16:14:53 INFO - PROCESS | 18315 | Values: 131.0 123.0 121.0 132.0 128.0 133.0 126.0 133.0 132.0 124.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.50 stddev:3.06 (1.9%) stddev-sans-first:3.00 16:14:53 INFO - PROCESS | 18315 | Values: 157.0 164.0 162.0 162.0 156.0 161.0 159.0 165.0 157.0 160.0 16:14:53 INFO - PROCESS | 18315 | 16:14:53 INFO - PROCESS | 18315 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.00 stddev:1.93 (3.0%) stddev-sans-first:2.05 16:14:53 INFO - PROCESS | 18315 | Values: 64.0 64.0 69.0 64.0 63.0 66.0 63.0 63.0 63.0 63.0 16:14:53 INFO - PROCESS | 18315 | -------- Summary: end -------- 16:14:53 INFO - PROCESS | 18315 | 16:14:54 INFO - TEST-INFO | 18315: exit 0 16:14:54 INFO - TEST-OK | kraken | took 61727ms 16:14:54 INFO - SUITE-END | took 1172s 16:14:55 INFO - Completed test suite (00:19:32) 16:14:55 INFO - javascript benchmark 16:14:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7283.5804775197585, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.766392520561, 3184.4586420308547, 3184.601924759405, 3205.5512228288057, 3211.42194405007, 5502.80740174094, 5511.200875873001, 5518.0, 5548.140038294061, 5565.165225216219, 5381.546982314772, 5442.83671489855, 5448.482394172557, 5460.699661518614, 5513.476219759126, 4911.435184953741, 4946.505349465043, 5000.049990501811, 5066.949330506703, 5119.692818430906, 732.7382108357103, 4930.556249937505, 4985.002999400116, 5026.874328141807, 5103.897922041557, 5064.645474816764, 5074.086664400406, 5099.872503187413, 5105.106606343894, 5110.182370820651, 5113.488651134857, 5127.179651255781, 5142.254373115878, 5149.76826042829, 5150.922736158961, 4932.556069953722, 4990.65065445419, 5013.122703526905, 5024.547790698818, 5031.471695471996, 5521.337439507245, 5521.889562208774, 5526.447355264481, 5529.30883639545, 5593.74828132735, 5783.306003279633, 5894.675792831393, 5967.522598192134, 6046.213992181032, 6050.515958723292, 5984.551158663117, 6013.218281623361, 6024.668643224621, 6044.093385992092, 6067.908981365283, 5653.886922261573, 5656.660600363992, 5661.5187709044785, 5661.745221465044, 5672.914906276409, 5915.792947246826, 6031.909521357183, 6052.697365131726, 6153.1693221415435, 6177.69111544421, 5873.4126587340925, 5878.412158784087, 5883.882322353529, 5892.381299963442, 5918.526517878559, 5930.584859059824, 5935.287765468085, 5941.287045554561, 5953.970230148821, 5962.1056841473255, 5679.176519404663, 5930.406959304121, 5930.822075337746, 5960.85097872548, 6015.0676645120075, 5971.611845230046, 6004.5496587755215, 6007.729652165575, 6017.217761691039, 6021.518278537794, 4540.477845047796, 4576.290674945389, 4587.9082418351445, 4590.977045114753, 4653.139169253699, 3877.651011408987, 3991.7006224533275, 4002.779847108437, 4027.1140349123148, 4048.4736984192455, 5693.800716974886, 5706.80026199081, 5723.284589426322, 5730.971345143331, 5773.076307790733, 6099.9390006099375, 6102.511799056065, 6102.542309326818, 6102.603330783485, 6118.694065296718, 5545.306836645419, 5639.069553523705, 5715.228444160069, 5752.424757524298, 5781.971090144522, 5008.348914641073, 5016.2224855147515, 5023.623228257822, 5035.446100928895, 5078.542931136216, 5956.85107872298, 6155.529581457846, 6200.038993955944, 6205.2553693557065, 6214.1921550198185, 5901.468867801918, 5936.050231962865, 5946.583739138218, 5967.433093856077, 5972.163897054329, 6132.233470816148, 6154.476869465966, 6194.690265486798, 6201.782937597162, 6209.441150296495, 5726.5418766499415, 5856.677882716492, 5906.468417842415, 5913.319968203712, 5921.348651648229, 6006.939930600638, 6058.5153187745755, 6071.423214794588, 6075.605085669417, 6121.296050954197, 5727.226824378822, 5866.384029676993, 5884.35272120075, 5889.234399528034, 5891.49922256613, 5676.801311954062, 5748.712564371681, 5761.567882408753, 5855.3266374365785, 5863.149843272787, 5625.043742563692, 5699.5725320600295, 5729.312482502127, 5740.712964351849, 5795.652260864362, 5908.320543137423, 5952.285725712942, 5952.345242023461, 5954.970225148846, 5956.285245770535, 5611.775528978795, 5816.447437493432, 5816.970915145397, 5827.4172582741385, 5833.416658334133], "value": 5462.577634075848, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.884823035393, 606.484488185043, 616.417485476225, 642.5373730913741, 644.3395519592418, 37463.62536374635, 41200.38199427007, 41234.7938260309, 41337.37993930093, 41411.17177656452, 41917.79041104798, 42513.57486425135, 42530.787346063225, 42619.786901065454, 42664.0, 8789.64841406343, 8940.955295223548, 8954.776130596754, 8964.551772411385, 8966.462012279251, 8757.25563327118, 8862.86705699415, 8874.955625221897, 8876.644934202624, 8881.445746994283, 8905.287576993858, 8926.419782714136, 8951.910480895205, 8970.10298970101, 8985.910140898573, 8854.247388971913, 8911.0, 8920.776980575472, 8948.552572371356, 8959.820803583956, 8718.0, 8838.86741698875, 8855.822883542292, 8856.114388561156, 8857.645694172226, 39997.60002399968, 40095.39856902149, 40167.196656067004, 40372.192556149006, 40459.19081618351, 3384.712299454525, 3640.453931910208, 3859.3439115350457, 3910.804459777028, 3944.2505923874373, 32113.1971700707, 32155.19612009695, 32406.189845253823, 32436.0, 33107.172320692174, 4296.355546667994, 4387.946892745718, 4437.733735975852, 4469.687121901468, 4510.188166130095, 246564.0, 247450.9999999982, 247595.0, 247821.0, 247894.0, 55573.722131389084, 56312.71843640837, 56398.15402768962, 56509.152362714594, 56528.71735641378, 35354.64645353565, 35736.821315893256, 35771.82114089413, 58348.0, 59158.40841591529, 17765.555861103316, 17865.910670446825, 17891.46325610234, 17957.820421795615, 17993.19030643624, 13626.250556219504, 13703.45186192541, 13772.931135344259, 13777.242251676254, 13876.028677992444, 19260.052343564097, 19358.0, 19437.611247775247, 19437.708434373497, 19554.0, 7056.894146587805, 7140.393756279024, 7200.675969581277, 7255.8911616325795, 7362.190159082496, 899.4333569850952, 972.8248915195333, 985.5762022330323, 991.4150651115876, 1035.2753072849036, 33286.66713332884, 33308.66691333104, 33400.66599334024, 33720.49419258713, 33969.0, 1068.1614932278123, 1069.8983596558314, 1073.812082885492, 1116.0959622705634, 1143.6054561176381, 16846.831531684773, 17126.828731712772, 17231.56921076958, 17494.912525437292, 17559.824401756076, 571437.0, 576409.0, 580513.0, 582109.0, 584129.0, 39594.20811583752, 57986.420135798944, 58350.41649583535, 58439.0, 58490.70754646284, 1310.960671179866, 1357.2060344698461, 1371.615947534692, 1372.1766939836218, 1388.3891087921281, 31167.220819479695, 32041.359172815948, 32124.196895076875, 32268.19329516781, 32700.83649581737, 49599.0, 49629.25556116733, 50159.74920125376, 50193.0, 50279.74860125676, 452641.0, 452654.0, 452930.0, 455663.0, 455857.0, 27209.86395068012, 27566.0, 27678.169654910384, 27754.5836812452, 28460.430791383642, 45678.04595924722, 46532.7673361631, 46716.53283467258, 46728.766356168, 48869.0, 40870.0, 42017.57982420137, 42023.15953680848, 42134.0, 42456.0, 40321.798391007855, 40483.3927491082, 40626.79686601548, 40822.18355632811, 41445.1710965785, 37737.43393849149, 40405.19189616133, 40944.59055409408, 41445.0, 44027.77986110177, 35396.29207415889, 37448.438273426465, 37891.431628526145, 38044.61955380411, 38049.80975095107, 28208.435831282848, 28532.615456576517, 28546.572671366765, 28592.85703571469, 28976.13071607855], "value": 19842.22829515895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.779583943393, 383.8982669592557, 393.2685205517737, 396.6014155773447, 399.5485101834926, 17449.825501744977, 18652.53368665784, 20354.08406621702, 20723.896380518116, 20740.48148796281, 11439.942800286008, 11792.174547781637, 11895.7620847583, 11996.100292478055, 16663.50009499714, 5102.54077133057, 5270.762815673284, 5297.602679799012, 5301.0, 5304.681719096867, 3850.0, 5483.8080667176655, 5740.741666624991, 5749.885002299951, 5800.796972105977, 5644.040513112781, 5702.315722113352, 5768.077107662775, 5787.797427090053, 5796.681182534959, 5779.075347944351, 5833.949889019975, 5837.41625837415, 5880.353161152269, 5881.500072493843, 5502.367227768817, 5671.234383358235, 5680.6591604503865, 5681.488666020036, 5702.2301989231755, 21765.891170544044, 22481.325560233217, 22658.886705566365, 22674.88662556693, 22860.885695571582, 2169.3383518026994, 2226.6326056200705, 2295.2081531871645, 2537.695476542827, 2723.72762723728, 9963.601455941754, 9984.251181161442, 10129.89870101297, 10296.07335339823, 10391.584336626525, 1844.9077546122774, 1881.2851116575614, 1907.7233801098762, 1921.625283069802, 1961.695937129747, 80735.5963220186, 85516.99999999937, 86632.0, 86767.56616216942, 87419.0, 9666.709998700051, 9816.803663926825, 10303.433311167957, 10607.681769546925, 10833.512491937725, 14904.776428353583, 15010.849891501164, 15030.699386012437, 15031.248437578077, 15077.54767356981, 7948.324392426593, 8116.472429292077, 8127.552984585786, 8136.918630813616, 8273.627686754111, 7905.288524032865, 7920.485168464032, 8050.194980501903, 8119.704701976958, 8204.548749818818, 4394.758288294174, 4397.450318710161, 4484.417025786627, 4496.1906856765445, 4639.121155931853, 1780.777402824647, 1782.393986044751, 1877.1552801239498, 1940.3305859478457, 1972.260402349119, 1006.9295149339476, 1007.1388962437011, 1010.4745532323298, 1027.429776474064, 1056.0917610854658, 17058.914705426392, 18096.547586310448, 18932.905335473235, 19259.133338999778, 19332.226710931685, 985.9161971232382, 992.2607657295362, 1018.8879223285433, 1041.4792603698152, 1071.1591400750374, 10650.414227217423, 10828.458577071273, 10833.241673082808, 10867.565297388173, 10878.075363594184, 479236.0, 483526.0, 487104.0, 490095.0, 509532.0, 64416.0, 66323.33676663268, 94935.0, 96371.51814240884, 98800.0, 966.7003228998892, 980.8970058143935, 991.7124034030195, 992.3400938376044, 993.9900600994042, 16814.327426903277, 16996.830031700018, 17006.0, 17142.0, 17306.740398893773, 34960.825195873855, 40449.1910161801, 41660.58339416567, 41708.1658366837, 42587.7870610645, 56824.0, 58220.708896455246, 58530.0, 58730.0, 59450.216493505264, 6350.364963503613, 6433.517486188648, 7420.369268612012, 7946.721864734706, 8302.875456868273, 9434.764130896783, 9640.0, 9969.451680157661, 12499.187552809402, 12635.305058221886, 6683.532152749261, 9325.440473571607, 11695.649130526097, 11817.231879927776, 12379.566715164927, 11058.668239952814, 11499.19505634631, 11741.0, 12013.279203247834, 12082.818757718816, 12194.0, 12244.326562039174, 12270.631881043582, 12372.81440778371, 12444.813327800272, 7361.227071157666, 8201.466904651179, 8489.915100848912, 8618.956905215684, 8828.514431706319, 10101.79796404053, 11602.825957610474, 12142.089343299465, 12226.87773122293, 12271.57049503263], "value": 8900.329764310249, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.8023866777985, 1465.3552436927755, 1527.74455871801, 1674.0206978917333, 1679.4038116468653, 7891.4081443891655, 8378.37162212835, 8625.0, 9009.954950225248, 9066.592003359849, 8486.53324067176, 8660.133986601337, 8777.16616921393, 8863.556822158882, 8868.556572171381, 2344.894479748407, 2368.9644655330185, 2382.4877651304964, 2385.355953892448, 2387.6537902004197, 2322.7096612923383, 2346.6831977682964, 2370.691810064689, 2372.6796882420826, 2376.6316220985686, 2345.7771511706446, 2350.6003979323555, 2359.3983534198755, 2382.1424287256573, 2386.4391867911027, 2260.513989492259, 2277.8633282003134, 2278.168468508999, 2278.1798552521077, 2282.931512054641, 2251.786080322383, 2271.704678391815, 2284.554511870186, 2285.1316499729996, 2300.562893050315, 8679.913200867974, 8782.60478278479, 8815.250703690193, 8830.955845220797, 8845.911540884574, 5298.682079075268, 5352.304200453955, 5542.334919809608, 5543.0, 5544.667319960775, 3445.3109378124223, 3555.306715190539, 3615.0, 3632.8546858125906, 3678.9632103678887, 1184.3545267829054, 1216.1000859364008, 1226.7546490701895, 1236.8886800187936, 1251.599488163788, 12217.877821221762, 12465.75068498634, 12478.43847026877, 12482.0, 12515.186512876633, 4715.159076731129, 4859.489753575895, 4884.0476107158765, 4892.8532144035735, 4914.164592019365, 10487.94756026215, 10607.681769546925, 10626.246669299479, 10671.039606435457, 10700.518476668569, 5294.973525132426, 5344.0, 5351.143816989263, 5366.0, 5379.435159308295, 4425.867223983286, 4946.455889852114, 4981.90036199274, 5103.744812759347, 5118.513741194581, 4112.403701463331, 4150.252954468225, 4196.91606167881, 4227.682923780729, 4372.759498227628, 1294.6569159172827, 1306.4969986555245, 1312.8030795380769, 1342.8992825538123, 1343.3484759891444, 812.561216942856, 871.7166920750655, 901.7520181950016, 911.2118017914456, 962.2638681408728, 6210.937890621126, 6256.624602523863, 6277.52918531112, 6319.747210111544, 6500.9349906501275, 962.932594718377, 993.7267251505893, 1012.281280290987, 1013.9695809125737, 1027.106417416837, 4214.452121224222, 4341.848035318749, 4391.297392417198, 4417.757023363682, 4460.955390446054, 10890.183236257153, 11276.041536469327, 11328.32030078198, 11354.943225283985, 11356.602518911965, 10534.36793792375, 10986.285891417032, 11017.944910275397, 11331.206815522833, 11355.375454349925, 8189.7133600323705, 8418.116097809765, 8443.831123377498, 8458.999999999876, 8486.0665326814, 5978.222831031938, 6198.721057552511, 6250.749970001149, 6252.280987686474, 6279.0, 10159.390436573829, 10447.0, 10493.47532623381, 10537.57849686004, 10616.044555989998, 10585.364878107339, 10628.468576571295, 10651.254412191072, 10708.464576771286, 10739.979701928305, 7255.455840812066, 7590.468667193243, 7823.06123265189, 8110.635021423932, 8200.220979006985, 8468.280196183394, 8482.448640838325, 8504.319654427754, 8517.23344898962, 8530.74407767768, 7794.883076753967, 7991.92008079935, 7999.400044996532, 8055.0, 8108.148644392254, 7708.267714567107, 7767.0, 7879.054513458422, 7910.446268761361, 8085.393595480245, 6791.898121528082, 7305.817354566178, 7355.521891077063, 7425.628718564159, 7429.07136607924, 5123.38519377677, 5221.947780522146, 5243.842684719464, 5246.947530524646, 5300.01949639318, 5244.160934250502, 5279.947200527946, 5351.759170837399, 5499.477549632778, 5522.3649280333275], "value": 4755.620143924084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.6117974890884, 326.50697446855247, 326.88722390775183, 331.5060559765948, 331.61532622158273, 5494.697791621459, 5580.720963951796, 5674.858128546788, 5689.516391106756, 5754.899461696482, 5560.972195139028, 5609.57928155389, 5610.326760788701, 5614.326280846294, 5632.577556683244, 4388.078503514266, 4407.206702793504, 4427.1367083418745, 4431.224535706255, 4451.132029254297, 4139.979300103495, 4350.2387082260475, 4355.843857290645, 4454.198244316021, 4466.8436604718845, 4260.36094585813, 4314.935275970863, 4315.719478233905, 4316.374125751764, 4355.54266801986, 4213.199492096523, 4330.112326972963, 4357.346398040288, 4384.758838263894, 4385.649148068147, 3793.487879136309, 3801.182745709658, 3801.4297855321647, 3808.409696497047, 3828.587989566583, 5504.972475137639, 5534.916976245359, 5562.9443705562835, 5572.442755724395, 5573.888522229573, 4799.6400269979895, 4920.785646459108, 4923.630727695438, 4972.378452693413, 5021.372328458942, 5828.475437210629, 5870.559708021873, 5896.024831681392, 5909.911351329733, 5986.820395388146, 4118.814653340607, 4164.292070348048, 4175.830767385137, 4190.476190476191, 4208.768517731523, 6021.849453763647, 6076.817695469143, 6135.509159267248, 6214.782482613132, 6282.2461304643275, 4239.8092085856215, 4255.76593287366, 4268.957310426918, 4301.397804307399, 4308.590683885026, 4349.499807522112, 4352.630026447724, 4369.815092453773, 4370.628496577763, 4384.802683879169, 4678.485366609671, 4948.727819969936, 4974.756310922269, 5013.573846223039, 5018.369030065171, 5730.971345143247, 5901.232839730894, 5932.881342373128, 5949.077892926603, 6008.819735407945, 1499.3852520466774, 1499.6475828180369, 1502.9479364444715, 1505.744023516005, 1505.8720008799155, 933.7021788039716, 941.5547135147516, 954.1555723185031, 956.5886668732372, 963.4412041016194, 5118.082692865031, 5158.458361872024, 5237.292965449616, 5253.212018197224, 5269.499397557226, 5353.785848566014, 5370.013095154818, 5390.568754499631, 5424.213489044067, 5571.690652696613, 4920.950790492121, 5049.166887463527, 5119.976004799055, 5173.508516690908, 5230.267762513251, 2929.8974535891143, 2940.3972185701878, 2943.3818898031227, 2952.822830630126, 2954.1875984104545, 5573.27547418833, 5633.8309850704545, 5639.915401268984, 5653.236813030188, 5664.51851592611, 5313.548348390353, 5459.617826752089, 5479.767052413175, 5513.8345849624575, 5607.579431542569, 5441.29263195782, 5529.557635389159, 5592.552595792326, 5604.8318550443555, 5674.411164873759, 5103.208746102631, 5334.973325133349, 5404.973294895328, 5430.266913966564, 5454.4272851351625, 5382.515573598238, 5383.300170977905, 5385.192221166856, 5399.487048730364, 5405.675609475704, 5534.889302214014, 5544.61187716856, 5559.72201389937, 5599.692016939108, 5641.464060914206, 3761.307411664707, 3853.826577804062, 3866.7819636814315, 3897.7466464679705, 3928.508936382952, 5421.430749771217, 5430.239766432782, 5431.1262614397965, 5931.7627294907725, 6016.819495415145, 5920.674362910081, 5990.7004649768205, 6016.909746353896, 6028.367021462858, 6038.6678732670125, 5877.382874798255, 5912.970435147797, 5970.611910225822, 6048.818535443944, 6069.241344831896, 5696.572757043321, 5926.2295901532525, 5939.524838013035, 5953.464188223081, 5985.640861548147, 6046.637201767908, 6073.423024812636, 6074.969625151846, 6084.665343406155, 6093.750781089954, 5523.2819733436, 5886.823395298148, 5895.616784909139, 5898.793542226002, 5945.810837832537], "value": 4336.895008824471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.6495447139846, 758.4451873658998, 759.6429678051314, 790.9841803163937, 794.5947566740962, 14182.290885455724, 14926.701465970675, 15181.924090379533, 15255.92372038141, 15279.0, 15033.323500442479, 15115.093094414315, 15120.621984450394, 15155.54533363998, 15243.0, 677.3226773226774, 787.7046107709609, 800.4756884240817, 803.1887793328722, 823.9670413183466, 791.2562191539963, 801.2348207461889, 801.6072124658905, 802.626778547975, 805.3557154276584, 858.7638399440142, 859.2138193552922, 859.8280343931208, 860.4880096342666, 860.496609483453, 853.3983541603186, 855.3285670748495, 856.3705676327894, 857.2884505860152, 857.4683696108452, 619.1115748900297, 619.4486906653083, 621.8911690454153, 622.5548732656127, 622.9439350458435, 14982.400703971827, 15020.399184032625, 15022.399104035934, 15032.549023529311, 15097.849021509754, 14650.487232946796, 14653.0, 14677.339519721638, 14750.55748327552, 14795.778063329059, 12191.329476878856, 12277.140600157993, 12289.56986505477, 12350.073744469111, 12839.753043217399, 3833.0, 3874.8837534874, 4004.539477960043, 4076.612721791425, 4078.6940979426363, 72722.0, 73193.0, 73355.0, 73575.63212183959, 74015.0, 11360.318380897008, 11740.941295293469, 11936.701582460508, 12149.574764883188, 12219.633410997685, 22623.0, 22660.433489162904, 22665.660015099787, 22675.319740407813, 22932.885335573217, 8333.083360830304, 8410.0, 8627.309815214769, 8670.826583468295, 8759.781005474913, 4734.881627959259, 4742.549457801503, 4781.784819683123, 4891.804327826847, 4896.4124305083615, 3309.9172520686693, 3404.1829960809227, 3416.4704470807064, 3436.0207340908223, 3439.226174110855, 583.4573846322876, 605.1709158452948, 608.5162295974711, 609.7591451376682, 616.0635833533095, 665.9600423974578, 701.8070030741587, 710.2932582080759, 710.5878590417545, 747.3946103656056, 10011.549480273405, 10378.221633377376, 10534.947325263478, 10564.418956957288, 10750.838737418944, 639.6162302618392, 737.4727070144872, 741.4365082537203, 745.0, 751.1099347273498, 4784.330193772875, 4940.752962351868, 4986.825461108916, 5024.497550244946, 5025.648204625714, 106804.0, 106861.46569267104, 107767.46116269525, 110164.27666078613, 112835.0, 92315.5384223088, 93808.0, 95121.5243923776, 96133.0, 96788.0, 85670.0, 85953.0, 86734.56632716797, 87333.12666873376, 87773.56113219394, 9025.0, 9231.723048308562, 9275.25797936177, 9525.333226674065, 9593.760155996157, 38387.6161238384, 46904.0, 48955.12538495403, 49972.75013624909, 50046.0, 51941.48058519366, 67383.66308168428, 69910.30089699241, 71850.64074679594, 76689.2331076682, 11922.582709605122, 11951.103667225167, 12002.75994480123, 12048.518059277882, 12349.93825030869, 12708.618741437771, 13102.803457948328, 13132.606021819362, 13343.466261349437, 13903.0, 12341.568045118378, 12572.937135314265, 12744.61766147017, 13198.736025279633, 13216.603501894959, 11855.70360740954, 12008.39958002114, 12331.69170770702, 12333.75332493363, 12810.67973300675, 12443.688907777378, 13505.034182722187, 13574.524891628746, 13670.52153174634, 14337.283135842958, 11546.32578276162, 11856.76286474283, 12070.336131512851, 12111.394430278628, 12290.20113692643, 11837.644870653894, 12433.254004759743, 12524.812127817908, 12673.93663031679, 12692.271161700279], "value": 7503.217766617697, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 110.0, 111.0, 111.0, 111.0, 109.0, 109.0, 110.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 155.0, 176.0, 134.0, 159.0, 155.0, 128.0, 188.0, 135.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 166.0, 175.0, 163.0, 161.0, 164.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 156.0, 75.0, 76.0, 84.0, 75.0, 157.0, 76.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 149.0, 84.0, 84.0, 85.0, 139.0, 85.0, 85.0, 145.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 118.0, 119.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 55.0, 53.0, 57.0, 54.0, 55.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 81.0, 79.0, 80.0, 80.0, 81.0, 106.0, 79.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 123.0, 121.0, 132.0, 128.0, 133.0, 126.0, 133.0, 132.0, 124.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 164.0, 162.0, 162.0, 156.0, 161.0, 159.0, 165.0, 157.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 69.0, 64.0, 63.0, 66.0, 63.0, 63.0, 63.0, 63.0], "value": 64.2, "unit": "score"}]}]} 16:14:55 INFO - Return code: 0 16:14:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:55 ERROR - # TBPL SUCCESS # 16:14:55 INFO - Running post-action listener: _resource_record_post_action 16:14:55 INFO - ##### 16:14:55 INFO - ##### Finished run-tests step (success) 16:14:55 INFO - ##### 16:14:55 INFO - Running post-run listener: _resource_record_post_run 16:14:55 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 0; Write bytes: 543514624; Read time: 0; Write time: 407648 16:14:55 INFO - TinderboxPrint: CPU usage
13.6% 16:14:55 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:14:55 INFO - TinderboxPrint: I/O write bytes / time
543,514,624 / 407,648 16:14:55 INFO - TinderboxPrint: CPU idle
8,210.3 (86.4%) 16:14:55 INFO - TinderboxPrint: CPU user
1,233.8 (13.0%) 16:14:55 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:55 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248463360; Read time: 0; Write time: 222868 16:14:55 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 0; Write bytes: 295051264; Read time: 0; Write time: 184780 16:14:55 INFO - Running post-run listener: _upload_blobber_files 16:14:55 INFO - Blob upload gear active. 16:14:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:14:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:14:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:14:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:14:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:14:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:14:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:14:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:14:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:14:59 INFO - (blobuploader) - INFO - Done attempting. 16:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:00 INFO - (blobuploader) - INFO - Done attempting. 16:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:01 INFO - (blobuploader) - INFO - Done attempting. 16:15:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:01 INFO - Return code: 0 16:15:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:15:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/211a166045e67fa0516ea95f8e91c80a72704be76581018d9261fe6be8104b2fb7d5c63f52d3484193d630fdf58a8754eb36fb15849ddc095c6ef78e972f18b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25125840d0e3e2512a4ec4aa9c1b4bea2dfdead7258e494bd4a3697021d116318b5dcf334c6104786694ef178aa04fabe5e0bb8ae3bd59b5ce305afbe3fd74c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995c9b181851f05401948ac921e05fd94385db4a17c6bd155b400174769ecee0e53d3bb70afe6512795f09193f7a4ca5994df21f9c6fe17620f68950cbb2ab4c"} 16:15:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:15:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:15:01 INFO - Contents: 16:15:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/211a166045e67fa0516ea95f8e91c80a72704be76581018d9261fe6be8104b2fb7d5c63f52d3484193d630fdf58a8754eb36fb15849ddc095c6ef78e972f18b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25125840d0e3e2512a4ec4aa9c1b4bea2dfdead7258e494bd4a3697021d116318b5dcf334c6104786694ef178aa04fabe5e0bb8ae3bd59b5ce305afbe3fd74c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995c9b181851f05401948ac921e05fd94385db4a17c6bd155b400174769ecee0e53d3bb70afe6512795f09193f7a4ca5994df21f9c6fe17620f68950cbb2ab4c"} 16:15:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:15:01 INFO - Copying logs to upload dir... 16:15:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:15:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.905420 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-09 16:15:01.301154) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:15:01.304907) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/211a166045e67fa0516ea95f8e91c80a72704be76581018d9261fe6be8104b2fb7d5c63f52d3484193d630fdf58a8754eb36fb15849ddc095c6ef78e972f18b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25125840d0e3e2512a4ec4aa9c1b4bea2dfdead7258e494bd4a3697021d116318b5dcf334c6104786694ef178aa04fabe5e0bb8ae3bd59b5ce305afbe3fd74c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995c9b181851f05401948ac921e05fd94385db4a17c6bd155b400174769ecee0e53d3bb70afe6512795f09193f7a4ca5994df21f9c6fe17620f68950cbb2ab4c"} build_url:https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011397 build_url: 'https://queue.taskcluster.net/v1/task/NDz9q9AKTmi_YQLuWMv6Hw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/211a166045e67fa0516ea95f8e91c80a72704be76581018d9261fe6be8104b2fb7d5c63f52d3484193d630fdf58a8754eb36fb15849ddc095c6ef78e972f18b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25125840d0e3e2512a4ec4aa9c1b4bea2dfdead7258e494bd4a3697021d116318b5dcf334c6104786694ef178aa04fabe5e0bb8ae3bd59b5ce305afbe3fd74c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/995c9b181851f05401948ac921e05fd94385db4a17c6bd155b400174769ecee0e53d3bb70afe6512795f09193f7a4ca5994df21f9c6fe17620f68950cbb2ab4c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 16:15:01.330613) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:15:01.330947) ========= 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=03627c79f6bb3d1578c4a402000001ba-1465512866.725284-1575827117 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 16:15:01.413426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:15:01.413778) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 16:15:01.414112) ========= ========= Total master_lag: 0.17 =========