builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1469191874.52 results: success (0) buildid: 20160722032125 builduid: 691caff2e2644b959972c76f977a1e17 revision: 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.518991) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.519466) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.519745) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.552177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.552485) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 05:51:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.8M=0s 2016-07-22 05:51:15 (34.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.647690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.647993) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023984 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.717549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:14.717889) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 --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=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 05:51:15,367 truncating revision to first 12 chars 2016-07-22 05:51:15,367 Setting DEBUG logging. 2016-07-22 05:51:15,367 attempt 1/10 2016-07-22 05:51:15,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/99b62d79d2e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 05:51:15,683 unpacking tar archive at: mozilla-aurora-99b62d79d2e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:15.387881) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:15.388210) ========= script_repo_revision: 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:15.388610) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:15.388874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 05:51:15.399770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-22 05:51:15.400176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:16 INFO - MultiFileLogger online at 20160722 05:51:16 in /builds/slave/test 05:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:51:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:16 INFO - {'append_to_log': False, 05:51:16 INFO - 'base_work_dir': '/builds/slave/test', 05:51:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:16 INFO - 'branch': 'Mozilla-Aurora', 05:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:16 INFO - 'config_files': ('talos/linux_config.py',), 05:51:16 INFO - 'default_actions': ('clobber', 05:51:16 INFO - 'read-buildbot-config', 05:51:16 INFO - 'download-and-extract', 05:51:16 INFO - 'populate-webroot', 05:51:16 INFO - 'create-virtualenv', 05:51:16 INFO - 'install', 05:51:16 INFO - 'run-tests'), 05:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:16 INFO - 'download_minidump_stackwalk': True, 05:51:16 INFO - 'download_symbols': 'ondemand', 05:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:16 INFO - 'installer_path': 'installer.exe', 05:51:16 INFO - 'log_level': 'info', 05:51:16 INFO - 'log_name': 'talos', 05:51:16 INFO - 'log_to_console': True, 05:51:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:16 INFO - 'opt_config_files': (), 05:51:16 INFO - 'pip_index': False, 05:51:16 INFO - 'sps_profile': False, 05:51:16 INFO - 'sps_profile_interval': 0, 05:51:16 INFO - 'suite': 'dromaeojs', 05:51:16 INFO - 'system_bits': '32', 05:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:16 INFO - 'title': 'talos-linux64-ix-037', 05:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:16 INFO - 'use_talos_json': True, 05:51:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:16 INFO - 'work_dir': 'build'} 05:51:16 INFO - ##### 05:51:16 INFO - ##### Running clobber step. 05:51:16 INFO - ##### 05:51:16 INFO - Running pre-action listener: _resource_record_pre_action 05:51:16 INFO - Running main action method: clobber 05:51:16 INFO - rmtree: /builds/slave/test/build 05:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:17 INFO - Running post-action listener: _resource_record_post_action 05:51:17 INFO - ##### 05:51:17 INFO - ##### Finished clobber step (success) 05:51:17 INFO - ##### 05:51:17 INFO - ##### 05:51:17 INFO - ##### Running read-buildbot-config step. 05:51:17 INFO - ##### 05:51:17 INFO - Running pre-action listener: _resource_record_pre_action 05:51:17 INFO - Running main action method: read_buildbot_config 05:51:17 INFO - Using buildbot properties: 05:51:17 INFO - { 05:51:17 INFO - "project": "", 05:51:17 INFO - "product": "firefox", 05:51:17 INFO - "script_repo_revision": "production", 05:51:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:51:17 INFO - "repository": "", 05:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:51:17 INFO - "buildid": "20160722032125", 05:51:17 INFO - "pgo_build": "True", 05:51:17 INFO - "basedir": "/builds/slave/test", 05:51:17 INFO - "buildnumber": 423, 05:51:17 INFO - "slavename": "talos-linux64-ix-037", 05:51:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:51:17 INFO - "platform": "ubuntu64_hw", 05:51:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:51:17 INFO - "branch": "mozilla-aurora", 05:51:17 INFO - "repo_path": "releases/mozilla-aurora", 05:51:17 INFO - "revision": "99b62d79d2e4f8e8e5cb606891c1df80f0771bd1", 05:51:17 INFO - "stage_platform": "linux64-pgo", 05:51:17 INFO - "builduid": "691caff2e2644b959972c76f977a1e17", 05:51:17 INFO - "slavebuilddir": "test" 05:51:17 INFO - } 05:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 05:51:17 INFO - Running post-action listener: _resource_record_post_action 05:51:17 INFO - ##### 05:51:17 INFO - ##### Finished read-buildbot-config step (success) 05:51:17 INFO - ##### 05:51:17 INFO - ##### 05:51:17 INFO - ##### Running download-and-extract step. 05:51:17 INFO - ##### 05:51:17 INFO - Running pre-action listener: _resource_record_pre_action 05:51:17 INFO - Running main action method: download_and_extract 05:51:17 INFO - mkdir: /builds/slave/test/build/tests 05:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:17 INFO - https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:51:18 INFO - Downloaded 1361 bytes. 05:51:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:51:18 INFO - Using the following test package requirements: 05:51:18 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:51:18 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:18 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:51:18 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'jsshell-linux-x86_64.zip'], 05:51:18 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:18 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:51:18 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:51:18 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:51:18 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:18 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:18 INFO - https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:19 INFO - Downloaded 24489906 bytes. 05:51:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:51:21 INFO - Return code: 0 05:51:21 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:21 INFO - https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:51:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:22 INFO - Downloaded 24489906 bytes. 05:51:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:51:24 INFO - Return code: 0 05:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:24 INFO - https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:51:25 INFO - Downloaded 10833369 bytes. 05:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:51:25 INFO - Return code: 0 05:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:25 INFO - https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:51:26 INFO - Downloaded 63637058 bytes. 05:51:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:51:26 INFO - mkdir: /builds/slave/test/properties 05:51:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:26 INFO - Contents: 05:51:26 INFO - build_url:https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:51:27 INFO - Running post-action listener: _resource_record_post_action 05:51:27 INFO - Running post-action listener: set_extra_try_arguments 05:51:27 INFO - ##### 05:51:27 INFO - ##### Finished download-and-extract step (success) 05:51:27 INFO - ##### 05:51:27 INFO - ##### 05:51:27 INFO - ##### Running populate-webroot step. 05:51:27 INFO - ##### 05:51:27 INFO - Running pre-action listener: _resource_record_pre_action 05:51:27 INFO - Running main action method: populate_webroot 05:51:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:27 INFO - '--tppagecycles', 05:51:27 INFO - '7'], 05:51:27 INFO - 'tests': ['tsvgm']}}, 05:51:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['damp', 'tps']}, 05:51:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['damp', 'tps']}, 05:51:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['dromaeo_dom']}, 05:51:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['a11yr', 05:51:27 INFO - 'ts_paint', 05:51:27 INFO - 'tpaint', 05:51:27 INFO - 'sessionrestore', 05:51:27 INFO - 'sessionrestore_no_auto_restore', 05:51:27 INFO - 'tabpaint']}, 05:51:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tsvgx', 05:51:27 INFO - 'tsvgr_opacity', 05:51:27 INFO - 'tart', 05:51:27 INFO - 'tscrollx', 05:51:27 INFO - 'cart']}, 05:51:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:27 INFO - 'tsvgr_opacity', 05:51:27 INFO - 'tart', 05:51:27 INFO - 'tscrollx', 05:51:27 INFO - 'cart']}, 05:51:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s'], 05:51:27 INFO - 'tests': ['tp5o']}, 05:51:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'tests': ['tp5o']}, 05:51:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--disable-e10s', 05:51:27 INFO - '--xperf_path', 05:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:27 INFO - 'tests': ['tp5n']}, 05:51:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:27 INFO - 'talos_options': ['--xperf_path', 05:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:27 INFO - 'tests': ['tp5n']}}, 05:51:27 INFO - 'talos.zip': {'path': '', 05:51:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:27 INFO - Running post-action listener: _resource_record_post_action 05:51:27 INFO - ##### 05:51:27 INFO - ##### Finished populate-webroot step (success) 05:51:27 INFO - ##### 05:51:27 INFO - ##### 05:51:27 INFO - ##### Running create-virtualenv step. 05:51:27 INFO - ##### 05:51:27 INFO - Running pre-action listener: _resource_record_pre_action 05:51:27 INFO - Running main action method: create_virtualenv 05:51:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:27 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 05:51:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:27 INFO - Using real prefix '/usr' 05:51:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:30 INFO - Installing pip.................done. 05:51:30 INFO - Return code: 0 05:51:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:51:30 INFO - Using env: {'DISPLAY': ':0', 05:51:30 INFO - 'HOME': '/home/cltbld', 05:51:30 INFO - 'LANG': 'en_US.UTF-8', 05:51:30 INFO - 'LANGUAGE': 'en_US:en', 05:51:30 INFO - 'LOGNAME': 'cltbld', 05:51:30 INFO - 'MAIL': '/var/mail/cltbld', 05:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:30 INFO - 'MOZ_NO_REMOTE': '1', 05:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:30 INFO - 'NO_EM_RESTART': '1', 05:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:30 INFO - 'PWD': '/builds/slave/test', 05:51:30 INFO - 'SHELL': '/bin/bash', 05:51:30 INFO - 'SHLVL': '1', 05:51:30 INFO - 'TERM': 'linux', 05:51:30 INFO - 'TMOUT': '86400', 05:51:30 INFO - 'USER': 'cltbld', 05:51:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:30 INFO - '_': '/tools/buildbot/bin/python'} 05:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:30 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 05:51:30 INFO - Cleaning up... 05:51:30 INFO - Return code: 0 05:51:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:51:30 INFO - Using env: {'DISPLAY': ':0', 05:51:30 INFO - 'HOME': '/home/cltbld', 05:51:30 INFO - 'LANG': 'en_US.UTF-8', 05:51:30 INFO - 'LANGUAGE': 'en_US:en', 05:51:30 INFO - 'LOGNAME': 'cltbld', 05:51:30 INFO - 'MAIL': '/var/mail/cltbld', 05:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:30 INFO - 'MOZ_NO_REMOTE': '1', 05:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:30 INFO - 'NO_EM_RESTART': '1', 05:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:30 INFO - 'PWD': '/builds/slave/test', 05:51:30 INFO - 'SHELL': '/bin/bash', 05:51:30 INFO - 'SHLVL': '1', 05:51:30 INFO - 'TERM': 'linux', 05:51:30 INFO - 'TMOUT': '86400', 05:51:30 INFO - 'USER': 'cltbld', 05:51:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:30 INFO - '_': '/tools/buildbot/bin/python'} 05:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:30 INFO - Downloading/unpacking psutil>=3.1.1 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:32 INFO - Installing collected packages: psutil 05:51:32 INFO - Running setup.py install for psutil 05:51:32 INFO - building 'psutil._psutil_linux' extension 05:51:32 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 05:51:32 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 05:51:32 INFO - building 'psutil._psutil_posix' extension 05:51:32 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 05:51:32 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 05:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:33 INFO - Successfully installed psutil 05:51:33 INFO - Cleaning up... 05:51:33 INFO - Return code: 0 05:51:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:33 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:33 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 05:51:33 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 05:51:33 INFO - Using env: {'DISPLAY': ':0', 05:51:33 INFO - 'HOME': '/home/cltbld', 05:51:33 INFO - 'LANG': 'en_US.UTF-8', 05:51:33 INFO - 'LANGUAGE': 'en_US:en', 05:51:33 INFO - 'LOGNAME': 'cltbld', 05:51:33 INFO - 'MAIL': '/var/mail/cltbld', 05:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:33 INFO - 'MOZ_NO_REMOTE': '1', 05:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:33 INFO - 'NO_EM_RESTART': '1', 05:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:33 INFO - 'PWD': '/builds/slave/test', 05:51:33 INFO - 'SHELL': '/bin/bash', 05:51:33 INFO - 'SHLVL': '1', 05:51:33 INFO - 'TERM': 'linux', 05:51:33 INFO - 'TMOUT': '86400', 05:51:33 INFO - 'USER': 'cltbld', 05:51:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:33 INFO - '_': '/tools/buildbot/bin/python'} 05:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:33 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 05:51:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:51:35 INFO - Installing collected packages: mozsystemmonitor 05:51:35 INFO - Running setup.py install for mozsystemmonitor 05:51:35 INFO - Successfully installed mozsystemmonitor 05:51:35 INFO - Cleaning up... 05:51:35 INFO - Return code: 0 05:51:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:35 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:35 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 05:51:35 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 05:51:35 INFO - Using env: {'DISPLAY': ':0', 05:51:35 INFO - 'HOME': '/home/cltbld', 05:51:35 INFO - 'LANG': 'en_US.UTF-8', 05:51:35 INFO - 'LANGUAGE': 'en_US:en', 05:51:35 INFO - 'LOGNAME': 'cltbld', 05:51:35 INFO - 'MAIL': '/var/mail/cltbld', 05:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:35 INFO - 'MOZ_NO_REMOTE': '1', 05:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:35 INFO - 'NO_EM_RESTART': '1', 05:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:35 INFO - 'PWD': '/builds/slave/test', 05:51:35 INFO - 'SHELL': '/bin/bash', 05:51:35 INFO - 'SHLVL': '1', 05:51:35 INFO - 'TERM': 'linux', 05:51:35 INFO - 'TMOUT': '86400', 05:51:35 INFO - 'USER': 'cltbld', 05:51:35 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:35 INFO - '_': '/tools/buildbot/bin/python'} 05:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:51:35 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 05:51:35 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 05:51:35 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 05:51:35 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 05:51:35 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 05:51:35 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 05:51:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:37 INFO - warning: no files found matching '*.txt' 05:51:37 INFO - no previously-included directories found matching 'build' 05:51:37 INFO - no previously-included directories found matching 'dist' 05:51:37 INFO - no previously-included directories found matching '.git*' 05:51:38 INFO - Installing collected packages: jsonschema, functools32 05:51:38 INFO - Running setup.py install for functools32 05:51:38 INFO - warning: no files found matching '*.txt' 05:51:38 INFO - no previously-included directories found matching 'build' 05:51:38 INFO - no previously-included directories found matching 'dist' 05:51:38 INFO - no previously-included directories found matching '.git*' 05:51:38 INFO - Successfully installed jsonschema functools32 05:51:38 INFO - Cleaning up... 05:51:38 INFO - Return code: 0 05:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:38 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:38 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 05:51:38 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 05:51:38 INFO - Using env: {'DISPLAY': ':0', 05:51:38 INFO - 'HOME': '/home/cltbld', 05:51:38 INFO - 'LANG': 'en_US.UTF-8', 05:51:38 INFO - 'LANGUAGE': 'en_US:en', 05:51:38 INFO - 'LOGNAME': 'cltbld', 05:51:38 INFO - 'MAIL': '/var/mail/cltbld', 05:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:38 INFO - 'MOZ_NO_REMOTE': '1', 05:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:38 INFO - 'NO_EM_RESTART': '1', 05:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:38 INFO - 'PWD': '/builds/slave/test', 05:51:38 INFO - 'SHELL': '/bin/bash', 05:51:38 INFO - 'SHLVL': '1', 05:51:38 INFO - 'TERM': 'linux', 05:51:38 INFO - 'TMOUT': '86400', 05:51:38 INFO - 'USER': 'cltbld', 05:51:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:38 INFO - '_': '/tools/buildbot/bin/python'} 05:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:40 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 05:51:41 INFO - Downloading docopt-0.6.1.tar.gz 05:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:41 INFO - Running setup.py install for blobuploader 05:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:41 INFO - Running setup.py install for requests 05:51:41 INFO - Running setup.py install for docopt 05:51:41 INFO - Successfully installed blobuploader requests docopt 05:51:41 INFO - Cleaning up... 05:51:41 INFO - Return code: 0 05:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:41 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:41 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 05:51:41 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 05:51:41 INFO - Using env: {'DISPLAY': ':0', 05:51:41 INFO - 'HOME': '/home/cltbld', 05:51:41 INFO - 'LANG': 'en_US.UTF-8', 05:51:41 INFO - 'LANGUAGE': 'en_US:en', 05:51:41 INFO - 'LOGNAME': 'cltbld', 05:51:41 INFO - 'MAIL': '/var/mail/cltbld', 05:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:41 INFO - 'MOZ_NO_REMOTE': '1', 05:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:41 INFO - 'NO_EM_RESTART': '1', 05:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:41 INFO - 'PWD': '/builds/slave/test', 05:51:41 INFO - 'SHELL': '/bin/bash', 05:51:41 INFO - 'SHLVL': '1', 05:51:41 INFO - 'TERM': 'linux', 05:51:41 INFO - 'TMOUT': '86400', 05:51:41 INFO - 'USER': 'cltbld', 05:51:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:41 INFO - '_': '/tools/buildbot/bin/python'} 05:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:41 INFO - Running setup.py (path:/tmp/pip-l4qd4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:41 INFO - Running setup.py (path:/tmp/pip-XwndHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:42 INFO - Running setup.py (path:/tmp/pip-mCt70P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:42 INFO - Running setup.py (path:/tmp/pip-DIe2b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:42 INFO - Running setup.py (path:/tmp/pip-6E2xzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 INFO - Running setup.py (path:/tmp/pip-3kqgla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:42 INFO - Running setup.py (path:/tmp/pip-_ueyq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:42 INFO - Running setup.py (path:/tmp/pip-q_hDrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:42 INFO - Running setup.py (path:/tmp/pip-l6HIuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:42 INFO - Running setup.py (path:/tmp/pip-0T3mkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:42 INFO - Running setup.py (path:/tmp/pip-c0yJdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:42 INFO - Running setup.py (path:/tmp/pip-QbhlQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:42 INFO - Running setup.py (path:/tmp/pip-NQxqeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:42 INFO - Running setup.py (path:/tmp/pip-QOBg2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:42 INFO - Running setup.py (path:/tmp/pip-8yuohw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:43 INFO - Running setup.py (path:/tmp/pip-CWu94N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:43 INFO - Running setup.py (path:/tmp/pip-LzyJec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:43 INFO - Running setup.py install for manifestparser 05:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Running setup.py install for mozcrash 05:51:43 INFO - Running setup.py install for mozdebug 05:51:43 INFO - Running setup.py install for mozdevice 05:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Running setup.py install for mozfile 05:51:43 INFO - Running setup.py install for mozhttpd 05:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Running setup.py install for mozinfo 05:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Running setup.py install for mozInstall 05:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:43 INFO - Running setup.py install for mozleak 05:51:44 INFO - Running setup.py install for mozlog 05:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Running setup.py install for moznetwork 05:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Running setup.py install for mozprocess 05:51:44 INFO - Running setup.py install for mozprofile 05:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Running setup.py install for mozrunner 05:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Running setup.py install for mozscreenshot 05:51:44 INFO - Running setup.py install for moztest 05:51:44 INFO - Running setup.py install for mozversion 05:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:44 INFO - Cleaning up... 05:51:44 INFO - Return code: 0 05:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:44 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:44 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 05:51:44 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 05:51:44 INFO - Using env: {'DISPLAY': ':0', 05:51:44 INFO - 'HOME': '/home/cltbld', 05:51:44 INFO - 'LANG': 'en_US.UTF-8', 05:51:44 INFO - 'LANGUAGE': 'en_US:en', 05:51:44 INFO - 'LOGNAME': 'cltbld', 05:51:44 INFO - 'MAIL': '/var/mail/cltbld', 05:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:44 INFO - 'MOZ_NO_REMOTE': '1', 05:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:44 INFO - 'NO_EM_RESTART': '1', 05:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:44 INFO - 'PWD': '/builds/slave/test', 05:51:44 INFO - 'SHELL': '/bin/bash', 05:51:44 INFO - 'SHLVL': '1', 05:51:44 INFO - 'TERM': 'linux', 05:51:44 INFO - 'TMOUT': '86400', 05:51:44 INFO - 'USER': 'cltbld', 05:51:44 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:44 INFO - '_': '/tools/buildbot/bin/python'} 05:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:45 INFO - Running setup.py (path:/tmp/pip-KS5W5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:45 INFO - Running setup.py (path:/tmp/pip-1EIjzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:45 INFO - Running setup.py (path:/tmp/pip-5mF_35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:45 INFO - Running setup.py (path:/tmp/pip-35wGhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:45 INFO - Running setup.py (path:/tmp/pip-4QhPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:45 INFO - Running setup.py (path:/tmp/pip-sWRxyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:45 INFO - Running setup.py (path:/tmp/pip-YkuUR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:45 INFO - Running setup.py (path:/tmp/pip-j5zlym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:45 INFO - Running setup.py (path:/tmp/pip-owc81u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:45 INFO - Running setup.py (path:/tmp/pip-zj3Fgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:45 INFO - Running setup.py (path:/tmp/pip-S2XdVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:45 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)) 05:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:45 INFO - Running setup.py (path:/tmp/pip-w6SUrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:46 INFO - Running setup.py (path:/tmp/pip-ldY10E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:46 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)) 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:46 INFO - Running setup.py (path:/tmp/pip-nmLv14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:46 INFO - Running setup.py (path:/tmp/pip-kUPvtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:46 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)) 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:46 INFO - Running setup.py (path:/tmp/pip-W5hY06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:46 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)) 05:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:46 INFO - Running setup.py (path:/tmp/pip-F6Gtwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 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)) 05:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:46 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 05:51:48 INFO - Downloading blessings-1.6.tar.gz 05:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:48 INFO - Installing collected packages: blessings 05:51:48 INFO - Running setup.py install for blessings 05:51:48 INFO - Successfully installed blessings 05:51:48 INFO - Cleaning up... 05:51:48 INFO - Return code: 0 05:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:48 INFO - Reading from file tmpfile_stdout 05:51:48 INFO - Current package versions: 05:51:48 INFO - argparse == 1.2.1 05:51:48 INFO - blessings == 1.6 05:51:48 INFO - blobuploader == 1.2.4 05:51:48 INFO - docopt == 0.6.1 05:51:48 INFO - functools32 == 3.2.3-2 05:51:48 INFO - jsonschema == 2.5.1 05:51:48 INFO - manifestparser == 1.1 05:51:48 INFO - mozInstall == 1.12 05:51:48 INFO - mozcrash == 0.17 05:51:48 INFO - mozdebug == 0.1 05:51:48 INFO - mozdevice == 0.48 05:51:48 INFO - mozfile == 1.2 05:51:48 INFO - mozhttpd == 0.7 05:51:48 INFO - mozinfo == 0.9 05:51:48 INFO - mozleak == 0.1 05:51:48 INFO - mozlog == 3.2 05:51:48 INFO - moznetwork == 0.27 05:51:48 INFO - mozprocess == 0.23 05:51:48 INFO - mozprofile == 0.28 05:51:48 INFO - mozrunner == 6.12 05:51:48 INFO - mozscreenshot == 0.1 05:51:48 INFO - mozsystemmonitor == 0.3 05:51:48 INFO - moztest == 0.7 05:51:48 INFO - mozversion == 1.4 05:51:48 INFO - psutil == 3.1.1 05:51:48 INFO - requests == 1.2.3 05:51:48 INFO - wsgiref == 0.1.2 05:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:48 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')]} 05:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:48 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')]} 05:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:48 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:48 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 05:51:48 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 05:51:48 INFO - Using env: {'DISPLAY': ':0', 05:51:48 INFO - 'HOME': '/home/cltbld', 05:51:48 INFO - 'LANG': 'en_US.UTF-8', 05:51:48 INFO - 'LANGUAGE': 'en_US:en', 05:51:48 INFO - 'LOGNAME': 'cltbld', 05:51:48 INFO - 'MAIL': '/var/mail/cltbld', 05:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:48 INFO - 'MOZ_NO_REMOTE': '1', 05:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:48 INFO - 'NO_EM_RESTART': '1', 05:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:48 INFO - 'PWD': '/builds/slave/test', 05:51:48 INFO - 'SHELL': '/bin/bash', 05:51:48 INFO - 'SHLVL': '1', 05:51:48 INFO - 'TERM': 'linux', 05:51:48 INFO - 'TMOUT': '86400', 05:51:48 INFO - 'USER': 'cltbld', 05:51:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:48 INFO - '_': '/tools/buildbot/bin/python'} 05:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 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)) 05:51:48 INFO - Cleaning up... 05:51:48 INFO - Return code: 0 05:51:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:48 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')]} 05:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:48 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')]} 05:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:48 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 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51:48 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 05:51:48 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 05:51:48 INFO - Using env: {'DISPLAY': ':0', 05:51:48 INFO - 'HOME': '/home/cltbld', 05:51:48 INFO - 'LANG': 'en_US.UTF-8', 05:51:48 INFO - 'LANGUAGE': 'en_US:en', 05:51:48 INFO - 'LOGNAME': 'cltbld', 05:51:48 INFO - 'MAIL': '/var/mail/cltbld', 05:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:48 INFO - 'MOZ_NO_REMOTE': '1', 05:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:48 INFO - 'NO_EM_RESTART': '1', 05:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:48 INFO - 'PWD': '/builds/slave/test', 05:51:48 INFO - 'SHELL': '/bin/bash', 05:51:48 INFO - 'SHLVL': '1', 05:51:48 INFO - 'TERM': 'linux', 05:51:48 INFO - 'TMOUT': '86400', 05:51:48 INFO - 'USER': 'cltbld', 05:51:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:48 INFO - '_': '/tools/buildbot/bin/python'} 05:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:51:49 INFO - Cleaning up... 05:51:49 INFO - Return code: 0 05:51:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7ae41c0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ace020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', '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 05:51: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', 'flake8'] in /builds/slave/test/build 05:51: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 flake8 05:51:49 INFO - Using env: {'DISPLAY': ':0', 05:51:49 INFO - 'HOME': '/home/cltbld', 05:51:49 INFO - 'LANG': 'en_US.UTF-8', 05:51:49 INFO - 'LANGUAGE': 'en_US:en', 05:51:49 INFO - 'LOGNAME': 'cltbld', 05:51:49 INFO - 'MAIL': '/var/mail/cltbld', 05:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:49 INFO - 'MOZ_NO_REMOTE': '1', 05:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:49 INFO - 'NO_EM_RESTART': '1', 05:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:49 INFO - 'PWD': '/builds/slave/test', 05:51:49 INFO - 'SHELL': '/bin/bash', 05:51:49 INFO - 'SHLVL': '1', 05:51:49 INFO - 'TERM': 'linux', 05:51:49 INFO - 'TMOUT': '86400', 05:51:49 INFO - 'USER': 'cltbld', 05:51:49 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:49 INFO - '_': '/tools/buildbot/bin/python'} 05:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:49 INFO - Downloading/unpacking flake8 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51: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 05:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:51 INFO - no previously-included directories found matching 'docs/_build' 05:51:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:52 INFO - Running setup.py install for pep8 05:51:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:52 INFO - no previously-included directories found matching 'docs/_build' 05:51:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:51:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:52 INFO - Cleaning up... 05:51:52 INFO - Return code: 0 05:51:52 INFO - Running post-action listener: _resource_record_post_action 05:51:52 INFO - Running post-action listener: _start_resource_monitoring 05:51:52 INFO - Starting resource monitoring. 05:51:52 INFO - ##### 05:51:52 INFO - ##### Finished create-virtualenv step (success) 05:51:52 INFO - ##### 05:51:52 INFO - ##### 05:51:52 INFO - ##### Running install step. 05:51:52 INFO - ##### 05:51:52 INFO - Running pre-action listener: _resource_record_pre_action 05:51:52 INFO - Running main action method: install 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:52 INFO - Reading from file tmpfile_stdout 05:51:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:52 INFO - Reading from file tmpfile_stdout 05:51:52 INFO - Output received: 05:51:52 INFO - Usage: mozinstall [options] installer 05:51:52 INFO - Options: 05:51:52 INFO - -h, --help show this help message and exit 05:51:52 INFO - -d DEST, --destination=DEST 05:51:52 INFO - Directory to install application into. [default: 05:51:52 INFO - "/builds/slave/test"] 05:51:52 INFO - --app=APP Application being installed. [default: firefox] 05:51:52 INFO - mkdir: /builds/slave/test/build/application 05:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:52:08 INFO - Reading from file tmpfile_stdout 05:52:08 INFO - Output received: 05:52:08 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:08 INFO - Running post-action listener: _resource_record_post_action 05:52:08 INFO - ##### 05:52:08 INFO - ##### Finished install step (success) 05:52:08 INFO - ##### 05:52:08 INFO - ##### 05:52:08 INFO - ##### Running run-tests step. 05:52:08 INFO - ##### 05:52:08 INFO - Running pre-action listener: _resource_record_pre_action 05:52:08 INFO - Running main action method: run_tests 05:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:08 INFO - Python 2.7.3 05:52:08 INFO - Return code: 0 05:52:08 INFO - grabbing minidump binary from tooltool 05:52:08 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')]} 05:52:08 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 0x2b602e0>, '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 0x2acc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acc5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:08 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 05:52:08 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 05:52:08 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 05:52:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:08 INFO - Return code: 0 05:52:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:52:09 INFO - Return code: 0 05:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:52:09 INFO - Using env: {'DISPLAY': ':0', 05:52:09 INFO - 'HOME': '/home/cltbld', 05:52:09 INFO - 'LANG': 'en_US.UTF-8', 05:52:09 INFO - 'LANGUAGE': 'en_US:en', 05:52:09 INFO - 'LOGNAME': 'cltbld', 05:52:09 INFO - 'MAIL': '/var/mail/cltbld', 05:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:09 INFO - 'MOZ_NO_REMOTE': '1', 05:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:09 INFO - 'NO_EM_RESTART': '1', 05:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:09 INFO - 'PWD': '/builds/slave/test', 05:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:09 INFO - 'SHELL': '/bin/bash', 05:52:09 INFO - 'SHLVL': '1', 05:52:09 INFO - 'TERM': 'linux', 05:52:09 INFO - 'TMOUT': '86400', 05:52:09 INFO - 'USER': 'cltbld', 05:52:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446', 05:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:09 INFO - '_': '/tools/buildbot/bin/python'} 05:52:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:52:09 INFO - mozversion application_buildid: 20160722032125 05:52:09 INFO - mozversion application_changeset: 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 05:52:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:09 INFO - mozversion application_name: Firefox 05:52:09 INFO - mozversion application_remotingname: firefox-dev 05:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:52:09 INFO - mozversion application_vendor: Mozilla 05:52:09 INFO - mozversion application_version: 49.0a2 05:52:09 INFO - mozversion platform_buildid: 20160722032125 05:52:09 INFO - mozversion platform_changeset: 99b62d79d2e4f8e8e5cb606891c1df80f0771bd1 05:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:52:09 INFO - mozversion platform_version: 49.0a2 05:52:09 INFO - using testdate: 1469191929 05:52:09 INFO - actual date: 1469191929 05:52:09 INFO - starting webserver on 'localhost:47237' 05:52:09 INFO - SUITE-START | Running 2 tests 05:52:09 INFO - TEST-START | dromaeo_css 05:52:09 INFO - operating with platform_type : linux_ 05:52:09 INFO - Initialising browser for dromaeo_css test... 05:52:09 INFO - TEST-INFO | started process 7607 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawUfBf/profile http://localhost:47237/getInfo.html) 05:52:13 INFO - PROCESS | 7607 | __metrics Screen width/height:1600/1200 05:52:13 INFO - PROCESS | 7607 | colorDepth:24 05:52:13 INFO - PROCESS | 7607 | Browser inner width/height: 1024/697 05:52:13 INFO - PROCESS | 7607 | __metrics 05:52:14 INFO - PROCESS | 7607 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:52:14 ERROR - PROCESS | 7607 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:52:15 INFO - TEST-INFO | 7607: exit 0 05:52:15 INFO - Browser initialized. 05:52:15 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:15 INFO - TEST-INFO | started process 7701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpawUfBf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:27 INFO - PROCESS | 7701 | RSS: Main: 145195008 05:52:27 INFO - PROCESS | 7701 | 05:53:18 INFO - PROCESS | 7701 | 1469191998528 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] 05:55:26 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47237/tests/dromaeo/cssquery-ext.html) 05:55:27 INFO - PROCESS | 7701 | RSS: Main: 252416000 05:55:27 INFO - PROCESS | 7701 | 05:58:30 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-ext.html (next: http://localhost:47237/tests/dromaeo/cssquery-jquery.html) 05:58:30 INFO - PROCESS | 7701 | RSS: Main: 232501248 05:58:30 INFO - PROCESS | 7701 | 06:01:32 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47237/tests/dromaeo/cssquery-mootools.html) 06:01:33 INFO - PROCESS | 7701 | RSS: Main: 220295168 06:01:33 INFO - PROCESS | 7701 | 06:04:35 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47237/tests/dromaeo/cssquery-prototype.html) 06:04:35 INFO - PROCESS | 7701 | RSS: Main: 219246592 06:04:35 INFO - PROCESS | 7701 | 06:07:38 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47237/tests/dromaeo/cssquery-yui.html) 06:07:38 INFO - PROCESS | 7701 | RSS: Main: 195301376 06:07:38 INFO - PROCESS | 7701 | 06:10:40 INFO - PROCESS | 7701 | Cycle 1(1): loaded http://localhost:47237/tests/dromaeo/cssquery-yui.html (next: http://localhost:47237/tests/dromaeo/cssquery-dojo.html) 06:10:41 INFO - PROCESS | 7701 | RSS: Main: 252919808 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | __start_tp_report 06:10:41 INFO - PROCESS | 7701 | _x_x_mozilla_page_load 06:10:41 INFO - PROCESS | 7701 | _x_x_mozilla_page_load_details 06:10:41 INFO - PROCESS | 7701 | |i|pagename|runs| 06:10:41 INFO - PROCESS | 7701 | |0;dojo.html;3307.7519186061045;3331.533585298059;3342.715869151122;3365.0409633254526;3382.7632065755392;5400.540954018908;5469.808556700516;5505.0916598761205;5537.861553461161;5540.722963851801;5414.106672399059;5475.0966090595;5489.258950041753;5497.092979658361;5531.225628412026;4911.312416261726;4933.210686290195;4964.57801086909;4992.2262049382225;5026.723530205837;4938.530839570235;5039.470855560168;5042.873928151789;5046.596272298226;5048.798048078091;4934.1611925972675;4954.479779623141;4972.875678108058;4977.228529577921;5003.874903127415;5068.746562671889;5099.13314736492;5100.056489549445;5102.515261050213;5127.615428842833;4862.6839255448285;4897.559219670211;4923.950760492421;5007.048660754445;5025.974870125662;5317.46825317469;5336.573074154058;5356.758945847446;5359.437259087778;5377.8117765878005;5851.531877449794;5860.355360910296;5876.41235876409;5887.764489420418;5890.676012819294;5770.6249093808765;5811.6803575803315;5842.2405087338375;5866.501347385477;5950.315713692938;5524.1989911462615;5532.723363831792;5559.110542313251;5571.749271282762;5571.804986825442;5800.709964501758;6048.032314829607;6053.909191362133;6059.36376680451;6064.4541991221;5637.126245431965;5654.264945557051;5676.602637815396;5745.712714364265;5769.942300577024;5811.535077193815;5811.767529298781;5814.156947242626;5849.853753656193;5850.765969361178;5623.240862483594;5774.48029677331;5777.075667893117;5788.18965344852;5800.53595712342;5815.883682326415;5878.970605146947;5885.382034886361;5889.734961926723;5932.169496270526;4525.728456292567;4530.139273538017;4544.1593305237975;4546.090781843644;4570.565796249351;3942.802859856996;3977.5226972763453;4025.094353770437;4060.2488539620263;4091.774952377648;5605.607607467519;5615.241942337814;5621.494065534122;5634.774609015675;5647.37878833328;5897.026990546512;5906.5570082244;5907.409259074058;5929.703514824241;5957.79147729836;5298.81454149103;5435.374931882805;5472.097103977799;5602.991461536963;5605.66366018032;4993.675411098267;4994.225894986283;4995.500449955048;5004.574611158092;5011.072951503984;6086.147939288503;6091.878162436727;6093.025115981422;6094.695265236809;6100.847478812976;5672.744726487235;5752.165935939349;5767.625104368202;5831.970840145772;5866.266716660418;6095.1771510845465;6105.084237364431;6106.816795496142;6108.419700128481;6110.236220472441;5710.486056254957;5772.451617096369;5779;5783.045797443375;5788.82633520995;5672.2058911751565;5770.682612456355;5843.970780146072;5845.503132233808;5862.149988251765;5739.483446489836;5740.167675686918;5751.568632352507;5754.539636829128;5759.884802304015;5480.91778623313;5733.799317023884;5737.397573254915;5746.080627099644;5752.798652047159;5572.554195664418;5608.242887210337;5623.015972204929;5663.801766938137;5692.260006199168;5785.797497087582;5792.304923409218;5830.970845145747;5839.678817664899;5840.036393995113;5538.6122971391615;5613.989481893298;5655.660660360391;5673.290838645169;5680.744366503434 06:10:41 INFO - PROCESS | 7701 | |1;ext.html;609.3906093906094;646.1245013007377;648.3710800523492;665.4609766089467;671;32611.347773044527;45773.08453830925;46719.76640116803;46880.76559617197;46884.296735549;48705.75647121768;49220.50779492204;49228;49389.75305123469;49418.25872611914;8248.175182481733;8989.820203595924;9165.908340916605;10633.946830265877;10928.398938058404;10900.945495272512;11009.339439633608;11010.779784404307;11015.228933974626;11016.614418495354;11120.99911008009;11154.665360039171;11169.609063682772;11176.050035746972;11177.66467005987;8352.958235208815;10892.346459212473;11116.44417779116;11146.888531114666;11535.826962595567;10645.52095155712;10721.571137154504;10730.892691073068;11047.392393418359;11053.668389948314;45595.544044559465;46077.53922460766;46091.53908460906;46180;46244;3723.7579557328686;3845.942310865339;3964.738084749346;4253.237840940265;4329.134173165379;34923.30153396918;35075.298494030234;35370.823145884104;35896.10259743501;36972.26055478902;4754.168020596382;4754.548317909827;4774.045190961821;4861;4893.143699852547;412716;412836;413432;414903;415377;40295.19409611791;41280.38079428811;70192;71088;71125.64437177782;41774.791126044176;41824.58175418268;41941.58058419438;41978.79010604927;42011.36982945258;15885.205739712968;17480;17587.12064396775;17587.648247034987;17628.559286017695;14060;14445.711085778436;14462.20457874827;14681.265936703336;14699.853001470063;9308.208802251884;9316.8602470963;9347.158755712018;9398.295127865438;9403.529823508798;3567.250877315793;3628;3649.5255616770182;3668.669819716238;3683.594804571495;1029.4749677664445;1092.5848177692426;1127.1658972360394;1129.5989923577176;1171.0865524890598;31042;32521.674783252336;33074.17314567107;33240.069376456384;33731.32537349239;1179.0626451970531;1209.5282839692527;1226.47874653272;1264.8102784582386;1313.159577870164;17203.752855378978;18122.546936326697;18149.0997430693;18225;18258.360957366694;625519.1068312587;627758;629795;630832;632547;65235.347646522925;65762;65800.34199658038;65890.34109658842;65943;1386.3207028555935;1451.4049239811627;1469.2433396800657;1497.977530337046;1527.1676936069646;34458;35526.111847204025;35871.64128358787;36535.26929461449;36630.45054324134;54772.72613636906;55492;55558;55656.16515752348;55691.721541392035;436103;436996;437834;439513;439714;31460;32453.837730811196;32554.83722581372;32653;32676.83661581772;51602.96794064173;52730.472695272554;53458.1981270289;53768.46231537791;54005;44895;45066.3240051406;45158.77420612876;45208;45757;43787.78106109449;44097.82630431678;44371.556284436745;45570.31644525268;45829.54170458253;44166.55833441753;44834.55165448434;45161.548384515736;45206.0958780816;45235.321470178635;37331.44002840014;39165.608343916196;39519.407208891316;39954;40020.599794002854;29346;29938;30215.395692086477;30436.391272174875;31550.36899262048 06:10:41 INFO - PROCESS | 7701 | |2;jquery.html;434.4916447756125;436.55471419152457;438.91660584488966;442.08709015882204;449.76162633804074;19222;19973;20832.166713331488;20835.895820520876;21066;19697.60604787907;20641.483962900937;20751.273705420313;20771.792282077175;20834.374968750923;5796.855078623036;6030.728617212236;6059.757609695629;6060.424259695344;6066.211392518966;5510.779568817243;5853.239078919756;5860.355360910296;5867;5870.412958704138;5809.041508151171;5817.912731309034;5824.679642619654;5828.125781132821;5830.329512106098;5641.492265696086;5781.421857814206;5792.333881603628;5793.565482588822;5817.7382017809305;5164.92252616211;5180.171172612364;5337.412884582693;5371.731413429313;5377.51602355786;13901.165930044128;14813.18527480988;14832.555023349316;14862.256887155707;20625;2316.764322428864;2334.8949297281665;2470.6788117544784;2547.7579629935126;2767.958480622792;10080.949595251977;10551.419671918042;10571.418571978538;10870.456477176109;10894.945525272402;1959.5688948431323;1976.545394559245;1987.2945104487987;2031.8272946799539;2061.701053347271;77895;81307.5934620329;83984.16015839885;89794.55102724509;90159.99999999935;11428.771424571461;11830.467628956718;11902.523899044114;11947.223430476992;12006.699832504082;16662.08358540292;16706.49880503587;16826.915865420593;16844.326226950783;16848.831511684726;8219.712310069119;8238.794030149174;8630.913690863137;8707.303415726727;8879.866801997976;8371.288440482505;8422.452540584842;8441.57792110392;8511.744647660456;8541.743747687578;5059.72171530562;5079.5428411443145;5084.669496482717;5141.408737995103;5152.613553983391;2012.1649515451218;2053.8254248389053;2072.191845180381;2114.6193685136514;2153.6231159547015;484.7115966000224;495.1458733684366;508.0245927818597;508.1209507551882;917.7338571814099;12509.624711258677;12599.244045357307;12681.682957926125;12751;12888.742225155444;500.31956539106784;500.7170948414207;500.9949900500948;515.2477383020756;517.0486305198377;6569.211694596679;6890.758823441155;6915.101036865175;6935.375816176568;6970.825729356807;191191;265471;518240;528365;529122;93488;93645;98617;99124.04379780982;99580;512.469593970239;517.2344929504354;521.6843809495276;522.4305506997391;522.814400887687;10221.591136354462;12007.399630018639;12073.456694448947;12210.26738395699;12254.142210045211;38998.2200355997;42821.35767963421;43085.492614512106;45977.31034034559;47335.52664473449;58775.70612147083;59779.70110149421;60793.69603151956;61332.18727980509;61799.69100154471;12447.875521244672;12956.805647915477;13097.869021309665;13340.066195366619;13475.797863031867;13771.862281377058;13798.379072941541;14336.856631433553;14696.485623003144;14776.48282310114;12778.105532612628;12825.358732063547;12873.613791586267;12905.161164524652;12934.417951192407;12510.499580016698;12638.43127059303;12771.10602257833;12905.225686458842;13032.087753857139;12757.872421275668;12885.935570322088;12909;13057.673558161123;13171.07802453819;12942.547010854574;13210.405531750903;13213.867861321263;13233.602991910258;13238.27189504548;12625.68435789076;12769.297688627215;12773.872261277269;12841.678958026125;12844.165129266568 06:10:41 INFO - PROCESS | 7701 | |3;mootools.html;1421.6659085115002;1555.0825013242186;1604.4464659692405;1790.7313902914561;1912.082200543739;9153.267738580906;9518.952405237973;9545.57044932978;9834.704958851227;9844.114029737322;9591.904080959188;9605.327627066108;9707.708768736931;9712.757181070478;9728.270379721514;2157.0832396231617;2455.0793452455327;2459.3359792855963;2494.289127598635;2499.9000039998377;2528.203615861007;2561.0268098122688;2561.987190064047;2562.846229226243;2564.781993530552;2490.1657944588583;2490.7882829959476;2523.949521009579;2527.41869370045;2536.8731563421848;2090.811826935583;2389;2444.4866578018637;2459.1884678056376;2485.428351479161;2459.2007597530874;2464.544059349026;2482.677251957234;2487.092211342865;2490.6015037593897;9573.28200384974;9713.66002189927;9736.123748862636;9737.610495580167;9742.853857192147;5691.743871525791;5822.184894114827;5822.883542329129;5828.883422331572;5829.183914252008;3585.175409655794;3590.120420496969;3609.855605775766;3624.7643903146213;3764.698824094066;1134.0643968725835;1146.7878442488166;1152.5217034930495;1177.4701384376979;1184.3308530680224;13537.864621353858;13662.521811736542;13667.248301343423;13687;13741.106828056245;4830.637702172351;4918.213085906238;4922.975385123052;4989.80040798364;4994.200927851526;10583.206259530565;10635.734106647242;10635.893641063645;10636.149108071335;10648.094911932418;5754.251947246831;5766.250387449689;5769.249997500298;5771.336296325892;5777.248957635565;4463.866084017484;4505.760403078835;4928.704277743347;5280.498352656491;5307.734613269398;4024.959750402517;4111;4116.279651061052;4157.127003329274;4176.14389050244;1248.5879659712273;1270.1616932824477;1276.553206377779;1283.9807402888964;1290;1078.9514471848786;1087.22263581538;1090.0734375780523;1097.939613321275;1100.471773548701;6488.513361497907;6512.251091124486;6568.441682456949;6583.210014798255;6712.630805305755;498.2799854210703;508.87786931137003;522.3966318901674;1053.3469249065474;1162.4829597375506;4454.621357184611;4618.076384723069;4618.076384723069;4619.145458090264;4669.486356500782;11194.720131996603;11463.885361146282;11485.138614603771;11493.138014648935;11537.077033837273;11277.32336059839;11303.321800691985;11379.829302560469;11390.145739069603;11401.144914131308;8610.095939926343;8948.552572371356;8986.820263594691;9181.816363672555;9187.816243675223;6761.019652150509;6990.440764738911;6996.370326670624;7072.08062951813;7093.3970612498515;11289.943550282196;11370.658880233606;11496.425178741198;11590.246633969102;11712.355820429959;11293.322400655987;11666.416679165837;11679.948804607626;11689.707757306136;11808.468618912342;7552.584607846621;8356.498610083414;8561.828763424572;8638.35212359063;8818.118188181386;9514.762130946781;9517.286203534624;9589.184919281939;9631.807363852824;9642.807143857224;8369.079401265733;8524.318054555497;8593.484390936565;8711.128887111237;8742.60658270392;8214.671413143407;8220.301274391744;8492.193241642035;8518.78703032429;8546.700865469678;7283;7341.6329183541675;7371.594562299125;7372.631368431665;7375.926240737738;5367.919481207863;5452.745868450199;5526.778928842962;5669.858253543694;5786.189933409242;5712.34308054579;5722.055860782924;5733.397993210653;5806.129080637938;5820.1560773688425 06:10:41 INFO - PROCESS | 7701 | |4;prototype.html;358.2905846424081;361.75400727505286;365.3825035689686;366.1286138989204;366.74877708769486;5441.183822426638;5470.234167216588;5491.231227628125;5541.33503979522;5541.473560011803;5381.165919282517;5429.53848922842;5455.536279416245;5473.124300111983;5476.890462190764;4127.153933443652;4233.962679143614;4234.470691163605;4256.1913236485125;4265.701400901922;4194.203101410738;4248.808803603845;4255.425517555137;4256.978715106436;4289.764062976551;4237.004303988576;4238.597333253351;4248.660107191417;4267.871963841089;4268.573142685737;4167.270727622684;4218.282891908383;4222.704410691253;4229.407882896397;4257.19113368459;3720.683741881943;3727.6272372762505;3738.140227747606;3738.2523495301048;3769.604191559874;5143.765496280903;5174.120399532088;5179.974100129513;5200.959808038408;5219.817306394258;4708.293755936637;4820.63845211607;4824.396950381202;4853.296272040534;4859.805607775685;5589.552835773128;5624.521915637176;5636.436356364372;5638.718064096779;5643.576731745095;4077.429159917614;4119.8970025749295;4131.442255295557;4150.169966006781;4152.854650087263;5663.1505274208785;5866.272183434723;5873.706314684291;5890.911636325416;5909.497692696126;4170.124273902454;4179.059711564873;4196.853110141192;4212.988882668137;4215.220184265921;4239.639630631369;4258.361245813153;4268.210381079511;4281.657467402601;4283.764392958417;4668.626509879202;4781.665283430127;4826;4826.8069277228515;4868.659193856467;5644;5648.887022259614;5658.377578466366;5671.404502527175;5678.4605462480995;1445.7710945696285;1466.4061055272632;1472.1976522795103;1472.3080152328603;1482.1033274868548;919.8068405634891;948.6205517792938;952.5903861339552;952.7661678126842;962.7015625156224;4894.535019173244;4923.359963204761;4933.925991110136;4945.282933974553;5021.271915572222;5112.284280200774;5143.434222235551;5156.329677141947;5159.819406320761;5205.724597473643;4568.74871882043;4913.631477639191;4925.7783399747095;4927.926081108786;4950.381202349707;2744.698083210845;2749.6837863645937;2770.9747393464145;2796.4826507096254;2818.224988128281;5418.756155972991;5442.91835622466;5449.836504904859;5459.262999495097;5466.699331536804;5292.841214763564;5326.520613144836;5513.724313784295;5693.259876216065;5859.480423417971;6029.698515074228;6051.788187413419;6079.665618390943;6088.634681919099;6091.51267898567;5825.883482330245;5827.562932779973;5836.503897168788;5837.503812176013;5849.94150058494;5448.918266225931;5659.603827732184;5759.329794359589;5767.826965191051;5780.161876527795;6050.788222412194;6060.606060606046;6074.696265186634;6087.147799308012;6117.20476338091;4187.01605122802;4210.705250632549;4243.469566304212;4274.722143060691;4304.332828411601;5753.626014309057;5792.364474164161;5800.56495762811;5803.47768700819;5822.214001109796;5675.262215911905;5678.517326027334;5678.914816277676;5692.914606280826;5713.428657134419;5409.215663728816;5675.375708671961;5692.715364231689;5713.285839270091;5741.598088133791;5572.582056345709;5624.634398764068;5644.153376993484;5647.435256474319;5681.9431805681415;5598.524125449219;5622.24099746529;5730.713464326684;5756.539476841926;5757.827265182052;5609.691466969356;5614.63504872182;5621.5221706155435;5646.362554859045;5668.137590516762 06:10:41 INFO - PROCESS | 7701 | |5;yui.html;821.2936874288112;838.2372041442288;861.7759382560535;880.8810810540575;897.3763234551985;15504.069755814646;15558.45545405911;15750.212489375528;15784.605384865385;15833.445829395974;15683.372665093382;15697.45058922938;15796.684066318667;15821.288042038108;15841.366345346172;712.1489819665502;842.8440738463404;858.7552547523957;859.0979471554858;865.7186414415308;843.3885433061043;844.4173520270994;844.932405407569;844.9817969346922;846.4413487098516;909.7862002429424;915.249495413761;917.47703808829;918.1186061381082;918.591226904028;736.8563130189615;753.2542782645197;755.3277582951177;880.3265501891059;900.8333458310201;648.7696867612024;650.4893658478072;651.4007113455632;653.4119292636617;667.3160010988776;15304.540863774104;15330.386784528717;15337.693246135015;15347.155906425141;15355.923220383938;15201;15396.615084622863;15502.55962042702;15618.125824900972;15718.21408929549;12833.614991550268;12870.163439376503;12930.741385172243;13028.869711302861;13112.541061062817;4687.250039993584;4760.143174228638;4777.307290442901;4783.115123702126;4850;85608.57195713982;87180.56409717911;87426;87753;87944;11239.438028098562;11309.773804523864;11616.303021818718;11735;12042.217255878515;20431.28490502855;20599.485012874797;20615.8969205153;20639.8968005159;20645.690314645293;8756.211940925346;8807.955960220157;8848.070952550019;8867.157620026088;9168.220701240469;5151.098557752378;5200.63595548308;5219.321488206585;5289.57683385336;5418.864528386822;3743.756655817363;3833.6166383361997;3887.3197190492115;3889.552701439314;3889.86385476507;683.1563019670702;685.7976896815452;691.6438034412282;692.5498426023125;698.4901022253783;716.1616111657855;800.231777493601;849.6601359456143;862.219691179471;866.7789713622985;11093.16801239894;11175.21773475849;11304.208705390543;11396.259243149168;11596.246243994114;750.1823012915838;758.6093162021564;784.474402150549;789.6930579890291;798.2815466080458;5128.974355128201;5198.740062996835;5347.796745732257;5527.226188333637;5576.219329293821;81317.59341203255;81507;81658.59170704108;128849;129432;87799.56100219458;98446;100637;102444;103740;79005.60497197592;84134;87798;89195;90059.54970225107;10200.897991019994;10478.790424191626;10500.947495262475;10573.735656608646;10577.100946419641;50787.23819142642;51155;51643.225351619;53227.4677253238;54038.189427159414;64069.038964416504;64671.67664161649;68208;69596.6520167396;71961.64019179871;13632.795508067189;13703.725925481634;15319.157446340558;15637.296321665324;15654.373825047327;15468.845311547191;16079.035257884565;16160.272787724345;16312.18439078065;16457.753133702765;10571.894281057092;15083.924580377467;15790.21048947571;15926.442574509836;15938;14899.553013409615;15455.459058932884;15476.847364103915;15495.380184792482;15691.764623530884;15272.875508316729;15566.221688915735;15618.141002244985;15773.29020194071;16204.270807813913;12627.431765570387;12741.10812243134;12801.231926084092;12954.546590869275;13004.943748694463;12942.805857912328;13089.477650418194;13119.803202951773;13285.601431957057;13530.255835929118 06:10:41 INFO - PROCESS | 7701 | __end_tp_report 06:10:41 INFO - PROCESS | 7701 | __start_cc_report 06:10:41 INFO - PROCESS | 7701 | _x_x_mozilla_cycle_collect,879 06:10:41 INFO - PROCESS | 7701 | __end_cc_report 06:10:41 INFO - PROCESS | 7701 | __startTimestamp1469193041220__endTimestamp 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | ------- Summary: start ------- 06:10:41 INFO - PROCESS | 7701 | Number of tests: 6 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#0] dojo.html Cycles:165 Average:5447.23 Median:5647.38 stddev:592.90 (10.5%) stddev-sans-first:570.46 06:10:41 INFO - PROCESS | 7701 | Values: 3307.8 3331.5 3342.7 3365.0 3382.8 5400.5 5469.8 5505.1 5537.9 5540.7 5414.1 5475.1 5489.3 5497.1 5531.2 4911.3 4933.2 4964.6 4992.2 5026.7 4938.5 5039.5 5042.9 5046.6 5048.8 4934.2 4954.5 4972.9 4977.2 5003.9 5068.7 5099.1 5100.1 5102.5 5127.6 4862.7 4897.6 4924.0 5007.0 5026.0 5317.5 5336.6 5356.8 5359.4 5377.8 5851.5 5860.4 5876.4 5887.8 5890.7 5770.6 5811.7 5842.2 5866.5 5950.3 5524.2 5532.7 5559.1 5571.7 5571.8 5800.7 6048.0 6053.9 6059.4 6064.5 5637.1 5654.3 5676.6 5745.7 5769.9 5811.5 5811.8 5814.2 5849.9 5850.8 5623.2 5774.5 5777.1 5788.2 5800.5 5815.9 5879.0 5885.4 5889.7 5932.2 4525.7 4530.1 4544.2 4546.1 4570.6 3942.8 3977.5 4025.1 4060.2 4091.8 5605.6 5615.2 5621.5 5634.8 5647.4 5897.0 5906.6 5907.4 5929.7 5957.8 5298.8 5435.4 5472.1 5603.0 5605.7 4993.7 4994.2 4995.5 5004.6 5011.1 6086.1 6091.9 6093.0 6094.7 6100.8 5672.7 5752.2 5767.6 5832.0 5866.3 6095.2 6105.1 6106.8 6108.4 6110.2 5710.5 5772.5 5779.0 5783.0 5788.8 5672.2 5770.7 5844.0 5845.5 5862.1 5739.5 5740.2 5751.6 5754.5 5759.9 5480.9 5733.8 5737.4 5746.1 5752.8 5572.6 5608.2 5623.0 5663.8 5692.3 5785.8 5792.3 5831.0 5839.7 5840.0 5538.6 5614.0 5655.7 5673.3 5680.7 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#1] ext.html Cycles:180 Average:65700.79 Median:226505.60 stddev:133771.50 (59.1%) stddev-sans-first:134057.50 06:10:41 INFO - PROCESS | 7701 | Values: 609.4 646.1 648.4 665.5 671.0 32611.3 45773.1 46719.8 46880.8 46884.3 48705.8 49220.5 49228.0 49389.8 49418.3 8248.2 8989.8 9165.9 10633.9 10928.4 10900.9 11009.3 11010.8 11015.2 11016.6 11121.0 11154.7 11169.6 11176.1 11177.7 8353.0 10892.3 11116.4 11146.9 11535.8 10645.5 10721.6 10730.9 11047.4 11053.7 45595.5 46077.5 46091.5 46180.0 46244.0 3723.8 3845.9 3964.7 4253.2 4329.1 34923.3 35075.3 35370.8 35896.1 36972.3 4754.2 4754.5 4774.0 4861.0 4893.1 412716.0 412836.0 413432.0 414903.0 415377.0 40295.2 41280.4 70192.0 71088.0 71125.6 41774.8 41824.6 41941.6 41978.8 42011.4 15885.2 17480.0 17587.1 17587.6 17628.6 14060.0 14445.7 14462.2 14681.3 14699.9 9308.2 9316.9 9347.2 9398.3 9403.5 3567.3 3628.0 3649.5 3668.7 3683.6 1029.5 1092.6 1127.2 1129.6 1171.1 31042.0 32521.7 33074.2 33240.1 33731.3 1179.1 1209.5 1226.5 1264.8 1313.2 17203.8 18122.5 18149.1 18225.0 18258.4 625519.1 627758.0 629795.0 630832.0 632547.0 65235.3 65762.0 65800.3 65890.3 65943.0 1386.3 1451.4 1469.2 1498.0 1527.2 34458.0 35526.1 35871.6 36535.3 36630.5 54772.7 55492.0 55558.0 55656.2 55691.7 436103.0 436996.0 437834.0 439513.0 439714.0 31460.0 32453.8 32554.8 32653.0 32676.8 51603.0 52730.5 53458.2 53768.5 54005.0 44895.0 45066.3 45158.8 45208.0 45757.0 43787.8 44097.8 44371.6 45570.3 45829.5 44166.6 44834.6 45161.5 45206.1 45235.3 37331.4 39165.6 39519.4 39954.0 40020.6 29346.0 29938.0 30215.4 30436.4 31550.4 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#2] jquery.html Cycles:180 Average:26961.54 Median:134119.48 stddev:72170.26 (53.8%) stddev-sans-first:72345.23 06:10:41 INFO - PROCESS | 7701 | Values: 434.5 436.6 438.9 442.1 449.8 19222.0 19973.0 20832.2 20835.9 21066.0 19697.6 20641.5 20751.3 20771.8 20834.4 5796.9 6030.7 6059.8 6060.4 6066.2 5510.8 5853.2 5860.4 5867.0 5870.4 5809.0 5817.9 5824.7 5828.1 5830.3 5641.5 5781.4 5792.3 5793.6 5817.7 5164.9 5180.2 5337.4 5371.7 5377.5 13901.2 14813.2 14832.6 14862.3 20625.0 2316.8 2334.9 2470.7 2547.8 2768.0 10080.9 10551.4 10571.4 10870.5 10894.9 1959.6 1976.5 1987.3 2031.8 2061.7 77895.0 81307.6 83984.2 89794.6 90160.0 11428.8 11830.5 11902.5 11947.2 12006.7 16662.1 16706.5 16826.9 16844.3 16848.8 8219.7 8238.8 8630.9 8707.3 8879.9 8371.3 8422.5 8441.6 8511.7 8541.7 5059.7 5079.5 5084.7 5141.4 5152.6 2012.2 2053.8 2072.2 2114.6 2153.6 484.7 495.1 508.0 508.1 917.7 12509.6 12599.2 12681.7 12751.0 12888.7 500.3 500.7 501.0 515.2 517.0 6569.2 6890.8 6915.1 6935.4 6970.8 191191.0 265471.0 518240.0 528365.0 529122.0 93488.0 93645.0 98617.0 99124.0 99580.0 512.5 517.2 521.7 522.4 522.8 10221.6 12007.4 12073.5 12210.3 12254.1 38998.2 42821.4 43085.5 45977.3 47335.5 58775.7 59779.7 60793.7 61332.2 61799.7 12447.9 12956.8 13097.9 13340.1 13475.8 13771.9 13798.4 14336.9 14696.5 14776.5 12778.1 12825.4 12873.6 12905.2 12934.4 12510.5 12638.4 12771.1 12905.2 13032.1 12757.9 12885.9 12909.0 13057.7 13171.1 12942.5 13210.4 13213.9 13233.6 13238.3 12625.7 12769.3 12773.9 12841.7 12844.2 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#3] mootools.html Cycles:180 Average:6314.04 Median:4618.08 stddev:3634.12 (78.7%) stddev-sans-first:3625.71 06:10:41 INFO - PROCESS | 7701 | Values: 1421.7 1555.1 1604.4 1790.7 1912.1 9153.3 9519.0 9545.6 9834.7 9844.1 9591.9 9605.3 9707.7 9712.8 9728.3 2157.1 2455.1 2459.3 2494.3 2499.9 2528.2 2561.0 2562.0 2562.8 2564.8 2490.2 2490.8 2523.9 2527.4 2536.9 2090.8 2389.0 2444.5 2459.2 2485.4 2459.2 2464.5 2482.7 2487.1 2490.6 9573.3 9713.7 9736.1 9737.6 9742.9 5691.7 5822.2 5822.9 5828.9 5829.2 3585.2 3590.1 3609.9 3624.8 3764.7 1134.1 1146.8 1152.5 1177.5 1184.3 13537.9 13662.5 13667.2 13687.0 13741.1 4830.6 4918.2 4923.0 4989.8 4994.2 10583.2 10635.7 10635.9 10636.1 10648.1 5754.3 5766.3 5769.2 5771.3 5777.2 4463.9 4505.8 4928.7 5280.5 5307.7 4025.0 4111.0 4116.3 4157.1 4176.1 1248.6 1270.2 1276.6 1284.0 1290.0 1079.0 1087.2 1090.1 1097.9 1100.5 6488.5 6512.3 6568.4 6583.2 6712.6 498.3 508.9 522.4 1053.3 1162.5 4454.6 4618.1 4618.1 4619.1 4669.5 11194.7 11463.9 11485.1 11493.1 11537.1 11277.3 11303.3 11379.8 11390.1 11401.1 8610.1 8948.6 8986.8 9181.8 9187.8 6761.0 6990.4 6996.4 7072.1 7093.4 11289.9 11370.7 11496.4 11590.2 11712.4 11293.3 11666.4 11679.9 11689.7 11808.5 7552.6 8356.5 8561.8 8638.4 8818.1 9514.8 9517.3 9589.2 9631.8 9642.8 8369.1 8524.3 8593.5 8711.1 8742.6 8214.7 8220.3 8492.2 8518.8 8546.7 7283.0 7341.6 7371.6 7372.6 7375.9 5367.9 5452.7 5526.8 5669.9 5786.2 5712.3 5722.1 5733.4 5806.1 5820.2 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#4] prototype.html Cycles:180 Average:4711.73 Median:5309.68 stddev:1376.54 (25.9%) stddev-sans-first:1341.06 06:10:41 INFO - PROCESS | 7701 | Values: 358.3 361.8 365.4 366.1 366.7 5441.2 5470.2 5491.2 5541.3 5541.5 5381.2 5429.5 5455.5 5473.1 5476.9 4127.2 4234.0 4234.5 4256.2 4265.7 4194.2 4248.8 4255.4 4257.0 4289.8 4237.0 4238.6 4248.7 4267.9 4268.6 4167.3 4218.3 4222.7 4229.4 4257.2 3720.7 3727.6 3738.1 3738.3 3769.6 5143.8 5174.1 5180.0 5201.0 5219.8 4708.3 4820.6 4824.4 4853.3 4859.8 5589.6 5624.5 5636.4 5638.7 5643.6 4077.4 4119.9 4131.4 4150.2 4152.9 5663.2 5866.3 5873.7 5890.9 5909.5 4170.1 4179.1 4196.9 4213.0 4215.2 4239.6 4258.4 4268.2 4281.7 4283.8 4668.6 4781.7 4826.0 4826.8 4868.7 5644.0 5648.9 5658.4 5671.4 5678.5 1445.8 1466.4 1472.2 1472.3 1482.1 919.8 948.6 952.6 952.8 962.7 4894.5 4923.4 4933.9 4945.3 5021.3 5112.3 5143.4 5156.3 5159.8 5205.7 4568.7 4913.6 4925.8 4927.9 4950.4 2744.7 2749.7 2771.0 2796.5 2818.2 5418.8 5442.9 5449.8 5459.3 5466.7 5292.8 5326.5 5513.7 5693.3 5859.5 6029.7 6051.8 6079.7 6088.6 6091.5 5825.9 5827.6 5836.5 5837.5 5849.9 5448.9 5659.6 5759.3 5767.8 5780.2 6050.8 6060.6 6074.7 6087.1 6117.2 4187.0 4210.7 4243.5 4274.7 4304.3 5753.6 5792.4 5800.6 5803.5 5822.2 5675.3 5678.5 5678.9 5692.9 5713.4 5409.2 5675.4 5692.7 5713.3 5741.6 5572.6 5624.6 5644.2 5647.4 5681.9 5598.5 5622.2 5730.7 5756.5 5757.8 5609.7 5614.6 5621.5 5646.4 5668.1 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - PROCESS | 7701 | [#5] yui.html Cycles:180 Average:21094.92 Median:4723.70 stddev:29121.90 (616.5%) stddev-sans-first:29163.80 06:10:41 INFO - PROCESS | 7701 | Values: 821.3 838.2 861.8 880.9 897.4 15504.1 15558.5 15750.2 15784.6 15833.4 15683.4 15697.5 15796.7 15821.3 15841.4 712.1 842.8 858.8 859.1 865.7 843.4 844.4 844.9 845.0 846.4 909.8 915.2 917.5 918.1 918.6 736.9 753.3 755.3 880.3 900.8 648.8 650.5 651.4 653.4 667.3 15304.5 15330.4 15337.7 15347.2 15355.9 15201.0 15396.6 15502.6 15618.1 15718.2 12833.6 12870.2 12930.7 13028.9 13112.5 4687.3 4760.1 4777.3 4783.1 4850.0 85608.6 87180.6 87426.0 87753.0 87944.0 11239.4 11309.8 11616.3 11735.0 12042.2 20431.3 20599.5 20615.9 20639.9 20645.7 8756.2 8808.0 8848.1 8867.2 9168.2 5151.1 5200.6 5219.3 5289.6 5418.9 3743.8 3833.6 3887.3 3889.6 3889.9 683.2 685.8 691.6 692.5 698.5 716.2 800.2 849.7 862.2 866.8 11093.2 11175.2 11304.2 11396.3 11596.2 750.2 758.6 784.5 789.7 798.3 5129.0 5198.7 5347.8 5527.2 5576.2 81317.6 81507.0 81658.6 128849.0 129432.0 87799.6 98446.0 100637.0 102444.0 103740.0 79005.6 84134.0 87798.0 89195.0 90059.5 10200.9 10478.8 10500.9 10573.7 10577.1 50787.2 51155.0 51643.2 53227.5 54038.2 64069.0 64671.7 68208.0 69596.7 71961.6 13632.8 13703.7 15319.2 15637.3 15654.4 15468.8 16079.0 16160.3 16312.2 16457.8 10571.9 15083.9 15790.2 15926.4 15938.0 14899.6 15455.5 15476.8 15495.4 15691.8 15272.9 15566.2 15618.1 15773.3 16204.3 12627.4 12741.1 12801.2 12954.5 13004.9 12942.8 13089.5 13119.8 13285.6 13530.3 06:10:41 INFO - PROCESS | 7701 | -------- Summary: end -------- 06:10:41 INFO - PROCESS | 7701 | 06:10:41 INFO - TEST-INFO | 7701: exit 0 06:10:41 INFO - TEST-OK | dromaeo_css | took 1112304ms 06:10:41 INFO - TEST-START | kraken 06:10:41 INFO - operating with platform_type : linux_ 06:10:41 INFO - Initialising browser for kraken test... 06:10:41 INFO - TEST-INFO | started process 7890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPFLXS/profile http://localhost:47237/getInfo.html) 06:10:45 INFO - PROCESS | 7890 | __metrics Screen width/height:1600/1200 06:10:45 INFO - PROCESS | 7890 | colorDepth:24 06:10:45 INFO - PROCESS | 7890 | Browser inner width/height: 1024/697 06:10:45 INFO - PROCESS | 7890 | __metrics 06:10:46 INFO - PROCESS | 7890 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:10:46 ERROR - PROCESS | 7890 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:10:47 INFO - TEST-INFO | 7890: exit 0 06:10:47 INFO - Browser initialized. 06:10:47 INFO - Running cycle 1/1 for kraken test... 06:10:47 INFO - TEST-INFO | started process 7982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGPFLXS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:59 INFO - PROCESS | 7982 | RSS: Main: 145838080 06:10:59 INFO - PROCESS | 7982 | 06:11:02 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47237/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:02 INFO - PROCESS | 7982 | RSS: Main: 194940928 06:11:02 INFO - PROCESS | 7982 | 06:11:05 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47237/tests/kraken/driver.html?testName=audio-dft) 06:11:06 INFO - PROCESS | 7982 | RSS: Main: 191680512 06:11:06 INFO - PROCESS | 7982 | 06:11:08 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47237/tests/kraken/driver.html?testName=audio-fft) 06:11:09 INFO - PROCESS | 7982 | RSS: Main: 279285760 06:11:09 INFO - PROCESS | 7982 | 06:11:11 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47237/tests/kraken/driver.html?testName=audio-oscillator) 06:11:12 INFO - PROCESS | 7982 | RSS: Main: 187432960 06:11:12 INFO - PROCESS | 7982 | 06:11:14 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:14 INFO - PROCESS | 7982 | RSS: Main: 188002304 06:11:14 INFO - PROCESS | 7982 | 06:11:17 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47237/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:18 INFO - PROCESS | 7982 | RSS: Main: 222769152 06:11:18 INFO - PROCESS | 7982 | 06:11:21 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47237/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:22 INFO - PROCESS | 7982 | RSS: Main: 222363648 06:11:22 INFO - PROCESS | 7982 | 06:11:25 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47237/tests/kraken/driver.html?testName=json-parse-financial) 06:11:25 INFO - PROCESS | 7982 | RSS: Main: 222445568 06:11:25 INFO - PROCESS | 7982 | 06:11:27 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:27 INFO - PROCESS | 7982 | RSS: Main: 201084928 06:11:27 INFO - PROCESS | 7982 | 06:11:29 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:30 INFO - PROCESS | 7982 | RSS: Main: 201125888 06:11:30 INFO - PROCESS | 7982 | 06:11:32 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:32 INFO - PROCESS | 7982 | RSS: Main: 207028224 06:11:32 INFO - PROCESS | 7982 | 06:11:35 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:36 INFO - PROCESS | 7982 | RSS: Main: 213569536 06:11:36 INFO - PROCESS | 7982 | 06:11:38 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:39 INFO - PROCESS | 7982 | RSS: Main: 213311488 06:11:39 INFO - PROCESS | 7982 | 06:11:40 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:47237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47237/tests/kraken/driver.html?testName=ai-astar) 06:11:41 INFO - PROCESS | 7982 | RSS: Main: 256614400 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | __start_tp_report 06:11:41 INFO - PROCESS | 7982 | _x_x_mozilla_page_load 06:11:41 INFO - PROCESS | 7982 | _x_x_mozilla_page_load_details 06:11:41 INFO - PROCESS | 7982 | |i|pagename|runs| 06:11:41 INFO - PROCESS | 7982 | |0;ai-astar;112;106;110;111;112;112;111;113;112;110 06:11:41 INFO - PROCESS | 7982 | |1;audio-beat-detection;156;124;134;174;125;148;158;128;181;124 06:11:41 INFO - PROCESS | 7982 | |2;audio-dft;163;160;160;162;161;160;161;161;160;159 06:11:41 INFO - PROCESS | 7982 | |3;audio-fft;75;75;76;119;78;76;75;75;106;75 06:11:41 INFO - PROCESS | 7982 | |4;audio-oscillator;84;85;119;84;84;85;119;85;86;128 06:11:41 INFO - PROCESS | 7982 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;116;116 06:11:41 INFO - PROCESS | 7982 | |6;imaging-darkroom;146;145;146;148;148;146;145;147;146;146 06:11:41 INFO - PROCESS | 7982 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;94;94 06:11:41 INFO - PROCESS | 7982 | |8;json-parse-financial;57;49;50;50;50;51;50;50;50;50 06:11:41 INFO - PROCESS | 7982 | |9;json-stringify-tinderbox;62;61;61;61;61;61;61;61;62;60 06:11:41 INFO - PROCESS | 7982 | |10;stanford-crypto-aes;78;76;76;76;76;76;81;76;119;82 06:11:41 INFO - PROCESS | 7982 | |11;stanford-crypto-ccm;123;119;118;125;120;117;117;122;122;136 06:11:41 INFO - PROCESS | 7982 | |12;stanford-crypto-pbkdf2;155;153;158;152;151;150;150;152;151;153 06:11:41 INFO - PROCESS | 7982 | |13;stanford-crypto-sha256-iterative;63;61;62;60;61;61;67;60;59;59 06:11:41 INFO - PROCESS | 7982 | __end_tp_report 06:11:41 INFO - PROCESS | 7982 | __start_cc_report 06:11:41 INFO - PROCESS | 7982 | _x_x_mozilla_cycle_collect,1581 06:11:41 INFO - PROCESS | 7982 | __end_cc_report 06:11:41 INFO - PROCESS | 7982 | __startTimestamp1469193101139__endTimestamp 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | ------- Summary: start ------- 06:11:41 INFO - PROCESS | 7982 | Number of tests: 14 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:1.97 (1.8%) stddev-sans-first:2.05 06:11:41 INFO - PROCESS | 7982 | Values: 112.0 106.0 110.0 111.0 112.0 112.0 111.0 113.0 112.0 110.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:152.00 stddev:21.42 (14.1%) stddev-sans-first:22.36 06:11:41 INFO - PROCESS | 7982 | Values: 156.0 124.0 134.0 174.0 125.0 148.0 158.0 128.0 181.0 124.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:0.88 06:11:41 INFO - PROCESS | 7982 | Values: 163.0 160.0 160.0 162.0 161.0 160.0 161.0 161.0 160.0 159.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:15.87 (21.2%) stddev-sans-first:16.57 06:11:41 INFO - PROCESS | 7982 | Values: 75.0 75.0 76.0 119.0 78.0 76.0 75.0 75.0 106.0 75.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:84.50 stddev:18.19 (21.5%) stddev-sans-first:18.77 06:11:41 INFO - PROCESS | 7982 | Values: 84.0 85.0 119.0 84.0 84.0 85.0 119.0 85.0 86.0 128.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 06:11:41 INFO - PROCESS | 7982 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 06:11:41 INFO - PROCESS | 7982 | Values: 146.0 145.0 146.0 148.0 148.0 146.0 145.0 147.0 146.0 146.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:11:41 INFO - PROCESS | 7982 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#8] json-parse-financial Cycles:10 Average:50.70 Median:50.00 stddev:2.26 (4.5%) stddev-sans-first:0.50 06:11:41 INFO - PROCESS | 7982 | Values: 57.0 49.0 50.0 50.0 50.0 51.0 50.0 50.0 50.0 50.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 06:11:41 INFO - PROCESS | 7982 | Values: 62.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 60.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:76.00 stddev:13.33 (17.5%) stddev-sans-first:14.08 06:11:41 INFO - PROCESS | 7982 | Values: 78.0 76.0 76.0 76.0 76.0 76.0 81.0 76.0 119.0 82.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:122.00 stddev:5.63 (4.6%) stddev-sans-first:5.95 06:11:41 INFO - PROCESS | 7982 | Values: 123.0 119.0 118.0 125.0 120.0 117.0 117.0 122.0 122.0 136.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.50 Median:152.50 stddev:2.46 (1.6%) stddev-sans-first:2.44 06:11:41 INFO - PROCESS | 7982 | Values: 155.0 153.0 158.0 152.0 151.0 150.0 150.0 152.0 151.0 153.0 06:11:41 INFO - PROCESS | 7982 | 06:11:41 INFO - PROCESS | 7982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:2.36 (3.9%) stddev-sans-first:2.42 06:11:41 INFO - PROCESS | 7982 | Values: 63.0 61.0 62.0 60.0 61.0 61.0 67.0 60.0 59.0 59.0 06:11:41 INFO - PROCESS | 7982 | -------- Summary: end -------- 06:11:41 INFO - PROCESS | 7982 | 06:11:42 INFO - TEST-INFO | 7982: exit 0 06:11:42 INFO - TEST-OK | kraken | took 60153ms 06:11:42 INFO - SUITE-END | took 1172s 06:11:42 INFO - Completed test suite (00:19:32) 06:11:42 INFO - javascript benchmark 06:11:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.7519186061045, 3331.533585298059, 3342.715869151122, 3365.0409633254526, 3382.7632065755392, 5400.540954018908, 5469.808556700516, 5505.0916598761205, 5537.861553461161, 5540.722963851801, 5414.106672399059, 5475.0966090595, 5489.258950041753, 5497.092979658361, 5531.225628412026, 4911.312416261726, 4933.210686290195, 4964.57801086909, 4992.2262049382225, 5026.723530205837, 4938.530839570235, 5039.470855560168, 5042.873928151789, 5046.596272298226, 5048.798048078091, 4934.1611925972675, 4954.479779623141, 4972.875678108058, 4977.228529577921, 5003.874903127415, 5068.746562671889, 5099.13314736492, 5100.056489549445, 5102.515261050213, 5127.615428842833, 4862.6839255448285, 4897.559219670211, 4923.950760492421, 5007.048660754445, 5025.974870125662, 5317.46825317469, 5336.573074154058, 5356.758945847446, 5359.437259087778, 5377.8117765878005, 5851.531877449794, 5860.355360910296, 5876.41235876409, 5887.764489420418, 5890.676012819294, 5770.6249093808765, 5811.6803575803315, 5842.2405087338375, 5866.501347385477, 5950.315713692938, 5524.1989911462615, 5532.723363831792, 5559.110542313251, 5571.749271282762, 5571.804986825442, 5800.709964501758, 6048.032314829607, 6053.909191362133, 6059.36376680451, 6064.4541991221, 5637.126245431965, 5654.264945557051, 5676.602637815396, 5745.712714364265, 5769.942300577024, 5811.535077193815, 5811.767529298781, 5814.156947242626, 5849.853753656193, 5850.765969361178, 5623.240862483594, 5774.48029677331, 5777.075667893117, 5788.18965344852, 5800.53595712342, 5815.883682326415, 5878.970605146947, 5885.382034886361, 5889.734961926723, 5932.169496270526, 4525.728456292567, 4530.139273538017, 4544.1593305237975, 4546.090781843644, 4570.565796249351, 3942.802859856996, 3977.5226972763453, 4025.094353770437, 4060.2488539620263, 4091.774952377648, 5605.607607467519, 5615.241942337814, 5621.494065534122, 5634.774609015675, 5647.37878833328, 5897.026990546512, 5906.5570082244, 5907.409259074058, 5929.703514824241, 5957.79147729836, 5298.81454149103, 5435.374931882805, 5472.097103977799, 5602.991461536963, 5605.66366018032, 4993.675411098267, 4994.225894986283, 4995.500449955048, 5004.574611158092, 5011.072951503984, 6086.147939288503, 6091.878162436727, 6093.025115981422, 6094.695265236809, 6100.847478812976, 5672.744726487235, 5752.165935939349, 5767.625104368202, 5831.970840145772, 5866.266716660418, 6095.1771510845465, 6105.084237364431, 6106.816795496142, 6108.419700128481, 6110.236220472441, 5710.486056254957, 5772.451617096369, 5779.0, 5783.045797443375, 5788.82633520995, 5672.2058911751565, 5770.682612456355, 5843.970780146072, 5845.503132233808, 5862.149988251765, 5739.483446489836, 5740.167675686918, 5751.568632352507, 5754.539636829128, 5759.884802304015, 5480.91778623313, 5733.799317023884, 5737.397573254915, 5746.080627099644, 5752.798652047159, 5572.554195664418, 5608.242887210337, 5623.015972204929, 5663.801766938137, 5692.260006199168, 5785.797497087582, 5792.304923409218, 5830.970845145747, 5839.678817664899, 5840.036393995113, 5538.6122971391615, 5613.989481893298, 5655.660660360391, 5673.290838645169, 5680.744366503434], "value": 5409.740002663408, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3906093906094, 646.1245013007377, 648.3710800523492, 665.4609766089467, 671.0, 32611.347773044527, 45773.08453830925, 46719.76640116803, 46880.76559617197, 46884.296735549, 48705.75647121768, 49220.50779492204, 49228.0, 49389.75305123469, 49418.25872611914, 8248.175182481733, 8989.820203595924, 9165.908340916605, 10633.946830265877, 10928.398938058404, 10900.945495272512, 11009.339439633608, 11010.779784404307, 11015.228933974626, 11016.614418495354, 11120.99911008009, 11154.665360039171, 11169.609063682772, 11176.050035746972, 11177.66467005987, 8352.958235208815, 10892.346459212473, 11116.44417779116, 11146.888531114666, 11535.826962595567, 10645.52095155712, 10721.571137154504, 10730.892691073068, 11047.392393418359, 11053.668389948314, 45595.544044559465, 46077.53922460766, 46091.53908460906, 46180.0, 46244.0, 3723.7579557328686, 3845.942310865339, 3964.738084749346, 4253.237840940265, 4329.134173165379, 34923.30153396918, 35075.298494030234, 35370.823145884104, 35896.10259743501, 36972.26055478902, 4754.168020596382, 4754.548317909827, 4774.045190961821, 4861.0, 4893.143699852547, 412716.0, 412836.0, 413432.0, 414903.0, 415377.0, 40295.19409611791, 41280.38079428811, 70192.0, 71088.0, 71125.64437177782, 41774.791126044176, 41824.58175418268, 41941.58058419438, 41978.79010604927, 42011.36982945258, 15885.205739712968, 17480.0, 17587.12064396775, 17587.648247034987, 17628.559286017695, 14060.0, 14445.711085778436, 14462.20457874827, 14681.265936703336, 14699.853001470063, 9308.208802251884, 9316.8602470963, 9347.158755712018, 9398.295127865438, 9403.529823508798, 3567.250877315793, 3628.0, 3649.5255616770182, 3668.669819716238, 3683.594804571495, 1029.4749677664445, 1092.5848177692426, 1127.1658972360394, 1129.5989923577176, 1171.0865524890598, 31042.0, 32521.674783252336, 33074.17314567107, 33240.069376456384, 33731.32537349239, 1179.0626451970531, 1209.5282839692527, 1226.47874653272, 1264.8102784582386, 1313.159577870164, 17203.752855378978, 18122.546936326697, 18149.0997430693, 18225.0, 18258.360957366694, 625519.1068312587, 627758.0, 629795.0, 630832.0, 632547.0, 65235.347646522925, 65762.0, 65800.34199658038, 65890.34109658842, 65943.0, 1386.3207028555935, 1451.4049239811627, 1469.2433396800657, 1497.977530337046, 1527.1676936069646, 34458.0, 35526.111847204025, 35871.64128358787, 36535.26929461449, 36630.45054324134, 54772.72613636906, 55492.0, 55558.0, 55656.16515752348, 55691.721541392035, 436103.0, 436996.0, 437834.0, 439513.0, 439714.0, 31460.0, 32453.837730811196, 32554.83722581372, 32653.0, 32676.83661581772, 51602.96794064173, 52730.472695272554, 53458.1981270289, 53768.46231537791, 54005.0, 44895.0, 45066.3240051406, 45158.77420612876, 45208.0, 45757.0, 43787.78106109449, 44097.82630431678, 44371.556284436745, 45570.31644525268, 45829.54170458253, 44166.55833441753, 44834.55165448434, 45161.548384515736, 45206.0958780816, 45235.321470178635, 37331.44002840014, 39165.608343916196, 39519.407208891316, 39954.0, 40020.599794002854, 29346.0, 29938.0, 30215.395692086477, 30436.391272174875, 31550.36899262048], "value": 21020.76261240307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.4916447756125, 436.55471419152457, 438.91660584488966, 442.08709015882204, 449.76162633804074, 19222.0, 19973.0, 20832.166713331488, 20835.895820520876, 21066.0, 19697.60604787907, 20641.483962900937, 20751.273705420313, 20771.792282077175, 20834.374968750923, 5796.855078623036, 6030.728617212236, 6059.757609695629, 6060.424259695344, 6066.211392518966, 5510.779568817243, 5853.239078919756, 5860.355360910296, 5867.0, 5870.412958704138, 5809.041508151171, 5817.912731309034, 5824.679642619654, 5828.125781132821, 5830.329512106098, 5641.492265696086, 5781.421857814206, 5792.333881603628, 5793.565482588822, 5817.7382017809305, 5164.92252616211, 5180.171172612364, 5337.412884582693, 5371.731413429313, 5377.51602355786, 13901.165930044128, 14813.18527480988, 14832.555023349316, 14862.256887155707, 20625.0, 2316.764322428864, 2334.8949297281665, 2470.6788117544784, 2547.7579629935126, 2767.958480622792, 10080.949595251977, 10551.419671918042, 10571.418571978538, 10870.456477176109, 10894.945525272402, 1959.5688948431323, 1976.545394559245, 1987.2945104487987, 2031.8272946799539, 2061.701053347271, 77895.0, 81307.5934620329, 83984.16015839885, 89794.55102724509, 90159.99999999935, 11428.771424571461, 11830.467628956718, 11902.523899044114, 11947.223430476992, 12006.699832504082, 16662.08358540292, 16706.49880503587, 16826.915865420593, 16844.326226950783, 16848.831511684726, 8219.712310069119, 8238.794030149174, 8630.913690863137, 8707.303415726727, 8879.866801997976, 8371.288440482505, 8422.452540584842, 8441.57792110392, 8511.744647660456, 8541.743747687578, 5059.72171530562, 5079.5428411443145, 5084.669496482717, 5141.408737995103, 5152.613553983391, 2012.1649515451218, 2053.8254248389053, 2072.191845180381, 2114.6193685136514, 2153.6231159547015, 484.7115966000224, 495.1458733684366, 508.0245927818597, 508.1209507551882, 917.7338571814099, 12509.624711258677, 12599.244045357307, 12681.682957926125, 12751.0, 12888.742225155444, 500.31956539106784, 500.7170948414207, 500.9949900500948, 515.2477383020756, 517.0486305198377, 6569.211694596679, 6890.758823441155, 6915.101036865175, 6935.375816176568, 6970.825729356807, 191191.0, 265471.0, 518240.0, 528365.0, 529122.0, 93488.0, 93645.0, 98617.0, 99124.04379780982, 99580.0, 512.469593970239, 517.2344929504354, 521.6843809495276, 522.4305506997391, 522.814400887687, 10221.591136354462, 12007.399630018639, 12073.456694448947, 12210.26738395699, 12254.142210045211, 38998.2200355997, 42821.35767963421, 43085.492614512106, 45977.31034034559, 47335.52664473449, 58775.70612147083, 59779.70110149421, 60793.69603151956, 61332.18727980509, 61799.69100154471, 12447.875521244672, 12956.805647915477, 13097.869021309665, 13340.066195366619, 13475.797863031867, 13771.862281377058, 13798.379072941541, 14336.856631433553, 14696.485623003144, 14776.48282310114, 12778.105532612628, 12825.358732063547, 12873.613791586267, 12905.161164524652, 12934.417951192407, 12510.499580016698, 12638.43127059303, 12771.10602257833, 12905.225686458842, 13032.087753857139, 12757.872421275668, 12885.935570322088, 12909.0, 13057.673558161123, 13171.07802453819, 12942.547010854574, 13210.405531750903, 13213.867861321263, 13233.602991910258, 13238.27189504548, 12625.68435789076, 12769.297688627215, 12773.872261277269, 12841.678958026125, 12844.165129266568], "value": 8871.178783812122, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.6659085115002, 1555.0825013242186, 1604.4464659692405, 1790.7313902914561, 1912.082200543739, 9153.267738580906, 9518.952405237973, 9545.57044932978, 9834.704958851227, 9844.114029737322, 9591.904080959188, 9605.327627066108, 9707.708768736931, 9712.757181070478, 9728.270379721514, 2157.0832396231617, 2455.0793452455327, 2459.3359792855963, 2494.289127598635, 2499.9000039998377, 2528.203615861007, 2561.0268098122688, 2561.987190064047, 2562.846229226243, 2564.781993530552, 2490.1657944588583, 2490.7882829959476, 2523.949521009579, 2527.41869370045, 2536.8731563421848, 2090.811826935583, 2389.0, 2444.4866578018637, 2459.1884678056376, 2485.428351479161, 2459.2007597530874, 2464.544059349026, 2482.677251957234, 2487.092211342865, 2490.6015037593897, 9573.28200384974, 9713.66002189927, 9736.123748862636, 9737.610495580167, 9742.853857192147, 5691.743871525791, 5822.184894114827, 5822.883542329129, 5828.883422331572, 5829.183914252008, 3585.175409655794, 3590.120420496969, 3609.855605775766, 3624.7643903146213, 3764.698824094066, 1134.0643968725835, 1146.7878442488166, 1152.5217034930495, 1177.4701384376979, 1184.3308530680224, 13537.864621353858, 13662.521811736542, 13667.248301343423, 13687.0, 13741.106828056245, 4830.637702172351, 4918.213085906238, 4922.975385123052, 4989.80040798364, 4994.200927851526, 10583.206259530565, 10635.734106647242, 10635.893641063645, 10636.149108071335, 10648.094911932418, 5754.251947246831, 5766.250387449689, 5769.249997500298, 5771.336296325892, 5777.248957635565, 4463.866084017484, 4505.760403078835, 4928.704277743347, 5280.498352656491, 5307.734613269398, 4024.959750402517, 4111.0, 4116.279651061052, 4157.127003329274, 4176.14389050244, 1248.5879659712273, 1270.1616932824477, 1276.553206377779, 1283.9807402888964, 1290.0, 1078.9514471848786, 1087.22263581538, 1090.0734375780523, 1097.939613321275, 1100.471773548701, 6488.513361497907, 6512.251091124486, 6568.441682456949, 6583.210014798255, 6712.630805305755, 498.2799854210703, 508.87786931137003, 522.3966318901674, 1053.3469249065474, 1162.4829597375506, 4454.621357184611, 4618.076384723069, 4618.076384723069, 4619.145458090264, 4669.486356500782, 11194.720131996603, 11463.885361146282, 11485.138614603771, 11493.138014648935, 11537.077033837273, 11277.32336059839, 11303.321800691985, 11379.829302560469, 11390.145739069603, 11401.144914131308, 8610.095939926343, 8948.552572371356, 8986.820263594691, 9181.816363672555, 9187.816243675223, 6761.019652150509, 6990.440764738911, 6996.370326670624, 7072.08062951813, 7093.3970612498515, 11289.943550282196, 11370.658880233606, 11496.425178741198, 11590.246633969102, 11712.355820429959, 11293.322400655987, 11666.416679165837, 11679.948804607626, 11689.707757306136, 11808.468618912342, 7552.584607846621, 8356.498610083414, 8561.828763424572, 8638.35212359063, 8818.118188181386, 9514.762130946781, 9517.286203534624, 9589.184919281939, 9631.807363852824, 9642.807143857224, 8369.079401265733, 8524.318054555497, 8593.484390936565, 8711.128887111237, 8742.60658270392, 8214.671413143407, 8220.301274391744, 8492.193241642035, 8518.78703032429, 8546.700865469678, 7283.0, 7341.6329183541675, 7371.594562299125, 7372.631368431665, 7375.926240737738, 5367.919481207863, 5452.745868450199, 5526.778928842962, 5669.858253543694, 5786.189933409242, 5712.34308054579, 5722.055860782924, 5733.397993210653, 5806.129080637938, 5820.1560773688425], "value": 4983.411973247662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.2905846424081, 361.75400727505286, 365.3825035689686, 366.1286138989204, 366.74877708769486, 5441.183822426638, 5470.234167216588, 5491.231227628125, 5541.33503979522, 5541.473560011803, 5381.165919282517, 5429.53848922842, 5455.536279416245, 5473.124300111983, 5476.890462190764, 4127.153933443652, 4233.962679143614, 4234.470691163605, 4256.1913236485125, 4265.701400901922, 4194.203101410738, 4248.808803603845, 4255.425517555137, 4256.978715106436, 4289.764062976551, 4237.004303988576, 4238.597333253351, 4248.660107191417, 4267.871963841089, 4268.573142685737, 4167.270727622684, 4218.282891908383, 4222.704410691253, 4229.407882896397, 4257.19113368459, 3720.683741881943, 3727.6272372762505, 3738.140227747606, 3738.2523495301048, 3769.604191559874, 5143.765496280903, 5174.120399532088, 5179.974100129513, 5200.959808038408, 5219.817306394258, 4708.293755936637, 4820.63845211607, 4824.396950381202, 4853.296272040534, 4859.805607775685, 5589.552835773128, 5624.521915637176, 5636.436356364372, 5638.718064096779, 5643.576731745095, 4077.429159917614, 4119.8970025749295, 4131.442255295557, 4150.169966006781, 4152.854650087263, 5663.1505274208785, 5866.272183434723, 5873.706314684291, 5890.911636325416, 5909.497692696126, 4170.124273902454, 4179.059711564873, 4196.853110141192, 4212.988882668137, 4215.220184265921, 4239.639630631369, 4258.361245813153, 4268.210381079511, 4281.657467402601, 4283.764392958417, 4668.626509879202, 4781.665283430127, 4826.0, 4826.8069277228515, 4868.659193856467, 5644.0, 5648.887022259614, 5658.377578466366, 5671.404502527175, 5678.4605462480995, 1445.7710945696285, 1466.4061055272632, 1472.1976522795103, 1472.3080152328603, 1482.1033274868548, 919.8068405634891, 948.6205517792938, 952.5903861339552, 952.7661678126842, 962.7015625156224, 4894.535019173244, 4923.359963204761, 4933.925991110136, 4945.282933974553, 5021.271915572222, 5112.284280200774, 5143.434222235551, 5156.329677141947, 5159.819406320761, 5205.724597473643, 4568.74871882043, 4913.631477639191, 4925.7783399747095, 4927.926081108786, 4950.381202349707, 2744.698083210845, 2749.6837863645937, 2770.9747393464145, 2796.4826507096254, 2818.224988128281, 5418.756155972991, 5442.91835622466, 5449.836504904859, 5459.262999495097, 5466.699331536804, 5292.841214763564, 5326.520613144836, 5513.724313784295, 5693.259876216065, 5859.480423417971, 6029.698515074228, 6051.788187413419, 6079.665618390943, 6088.634681919099, 6091.51267898567, 5825.883482330245, 5827.562932779973, 5836.503897168788, 5837.503812176013, 5849.94150058494, 5448.918266225931, 5659.603827732184, 5759.329794359589, 5767.826965191051, 5780.161876527795, 6050.788222412194, 6060.606060606046, 6074.696265186634, 6087.147799308012, 6117.20476338091, 4187.01605122802, 4210.705250632549, 4243.469566304212, 4274.722143060691, 4304.332828411601, 5753.626014309057, 5792.364474164161, 5800.56495762811, 5803.47768700819, 5822.214001109796, 5675.262215911905, 5678.517326027334, 5678.914816277676, 5692.914606280826, 5713.428657134419, 5409.215663728816, 5675.375708671961, 5692.715364231689, 5713.285839270091, 5741.598088133791, 5572.582056345709, 5624.634398764068, 5644.153376993484, 5647.435256474319, 5681.9431805681415, 5598.524125449219, 5622.24099746529, 5730.713464326684, 5756.539476841926, 5757.827265182052, 5609.691466969356, 5614.63504872182, 5621.5221706155435, 5646.362554859045, 5668.137590516762], "value": 4280.755434788444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.2936874288112, 838.2372041442288, 861.7759382560535, 880.8810810540575, 897.3763234551985, 15504.069755814646, 15558.45545405911, 15750.212489375528, 15784.605384865385, 15833.445829395974, 15683.372665093382, 15697.45058922938, 15796.684066318667, 15821.288042038108, 15841.366345346172, 712.1489819665502, 842.8440738463404, 858.7552547523957, 859.0979471554858, 865.7186414415308, 843.3885433061043, 844.4173520270994, 844.932405407569, 844.9817969346922, 846.4413487098516, 909.7862002429424, 915.249495413761, 917.47703808829, 918.1186061381082, 918.591226904028, 736.8563130189615, 753.2542782645197, 755.3277582951177, 880.3265501891059, 900.8333458310201, 648.7696867612024, 650.4893658478072, 651.4007113455632, 653.4119292636617, 667.3160010988776, 15304.540863774104, 15330.386784528717, 15337.693246135015, 15347.155906425141, 15355.923220383938, 15201.0, 15396.615084622863, 15502.55962042702, 15618.125824900972, 15718.21408929549, 12833.614991550268, 12870.163439376503, 12930.741385172243, 13028.869711302861, 13112.541061062817, 4687.250039993584, 4760.143174228638, 4777.307290442901, 4783.115123702126, 4850.0, 85608.57195713982, 87180.56409717911, 87426.0, 87753.0, 87944.0, 11239.438028098562, 11309.773804523864, 11616.303021818718, 11735.0, 12042.217255878515, 20431.28490502855, 20599.485012874797, 20615.8969205153, 20639.8968005159, 20645.690314645293, 8756.211940925346, 8807.955960220157, 8848.070952550019, 8867.157620026088, 9168.220701240469, 5151.098557752378, 5200.63595548308, 5219.321488206585, 5289.57683385336, 5418.864528386822, 3743.756655817363, 3833.6166383361997, 3887.3197190492115, 3889.552701439314, 3889.86385476507, 683.1563019670702, 685.7976896815452, 691.6438034412282, 692.5498426023125, 698.4901022253783, 716.1616111657855, 800.231777493601, 849.6601359456143, 862.219691179471, 866.7789713622985, 11093.16801239894, 11175.21773475849, 11304.208705390543, 11396.259243149168, 11596.246243994114, 750.1823012915838, 758.6093162021564, 784.474402150549, 789.6930579890291, 798.2815466080458, 5128.974355128201, 5198.740062996835, 5347.796745732257, 5527.226188333637, 5576.219329293821, 81317.59341203255, 81507.0, 81658.59170704108, 128849.0, 129432.0, 87799.56100219458, 98446.0, 100637.0, 102444.0, 103740.0, 79005.60497197592, 84134.0, 87798.0, 89195.0, 90059.54970225107, 10200.897991019994, 10478.790424191626, 10500.947495262475, 10573.735656608646, 10577.100946419641, 50787.23819142642, 51155.0, 51643.225351619, 53227.4677253238, 54038.189427159414, 64069.038964416504, 64671.67664161649, 68208.0, 69596.6520167396, 71961.64019179871, 13632.795508067189, 13703.725925481634, 15319.157446340558, 15637.296321665324, 15654.373825047327, 15468.845311547191, 16079.035257884565, 16160.272787724345, 16312.18439078065, 16457.753133702765, 10571.894281057092, 15083.924580377467, 15790.21048947571, 15926.442574509836, 15938.0, 14899.553013409615, 15455.459058932884, 15476.847364103915, 15495.380184792482, 15691.764623530884, 15272.875508316729, 15566.221688915735, 15618.141002244985, 15773.29020194071, 16204.270807813913, 12627.431765570387, 12741.10812243134, 12801.231926084092, 12954.546590869275, 13004.943748694463, 12942.805857912328, 13089.477650418194, 13119.803202951773, 13285.601431957057, 13530.255835929118], "value": 8085.584938433411, "unit": "score"}], "name": "dromaeo_css", "value": 7471.9630768119205, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 111.0, 112.0, 112.0, 111.0, 113.0, 112.0, 110.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 134.0, 174.0, 125.0, 148.0, 158.0, 128.0, 181.0, 124.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 160.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 119.0, 78.0, 76.0, 75.0, 75.0, 106.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 119.0, 84.0, 84.0, 85.0, 119.0, 85.0, 86.0, 128.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 148.0, 148.0, 146.0, 145.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 49.0, 50.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0, 50.0], "value": 50.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 60.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 76.0, 76.0, 76.0, 81.0, 76.0, 119.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 118.0, 125.0, 120.0, 117.0, 117.0, 122.0, 122.0, 136.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 158.0, 152.0, 151.0, 150.0, 150.0, 152.0, 151.0, 153.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 62.0, 60.0, 61.0, 61.0, 67.0, 60.0, 59.0, 59.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1482.2, "alertThreshold": 2.0}]} 06:11:42 INFO - Return code: 0 06:11:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:11:42 ERROR - # TBPL SUCCESS # 06:11:42 INFO - Running post-action listener: _resource_record_post_action 06:11:42 INFO - ##### 06:11:42 INFO - ##### Finished run-tests step (success) 06:11:42 INFO - ##### 06:11:42 INFO - Running post-run listener: _resource_record_post_run 06:11:42 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 517853184; Read time: 0; Write time: 627576 06:11:42 INFO - TinderboxPrint: CPU usage
13.1% 06:11:42 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:11:42 INFO - TinderboxPrint: I/O write bytes / time
517,853,184 / 627,576 06:11:42 INFO - TinderboxPrint: CPU idle
8,251.6 (86.9%) 06:11:42 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 06:11:42 INFO - TinderboxPrint: Swap in / out
0 / 0 06:11:42 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 270352384; Read time: 0; Write time: 415760 06:11:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 247500800; Read time: 0; Write time: 211816 06:11:43 INFO - Running post-run listener: _upload_blobber_files 06:11:43 INFO - Blob upload gear active. 06:11:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:43 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 06:11:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:11:43 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:44 INFO - (blobuploader) - INFO - Done attempting. 06:11:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:45 INFO - (blobuploader) - INFO - Done attempting. 06:11:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:11:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:00 INFO - (blobuploader) - INFO - Done attempting. 06:12:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:00 INFO - Return code: 0 06:12:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cefdc44333ddf28c21865d4f83b9f194d50196aeb0e286097ce83ad55d4ea8ddd2cb3b6b66b2ab568b51824be9f1d41a42cc37b6d8acec7619628704e6b87861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b98c945ee090e3c9f075b96420d06a2bb0fddaf7c666c0a3feb713828aa36176f0c9d257b9787873484e0644aeda3d7372636f4ad96f45c6a1d17a12abfd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d1451115d9e2d4202a78e908c2d781bf1ea1bfb2430b390375d8c220b9eabef65f18763fd39a34b502b3692f96d06b8d1d1f176264855456b4acd5032d10d3"} 06:12:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:00 INFO - Contents: 06:12:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cefdc44333ddf28c21865d4f83b9f194d50196aeb0e286097ce83ad55d4ea8ddd2cb3b6b66b2ab568b51824be9f1d41a42cc37b6d8acec7619628704e6b87861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b98c945ee090e3c9f075b96420d06a2bb0fddaf7c666c0a3feb713828aa36176f0c9d257b9787873484e0644aeda3d7372636f4ad96f45c6a1d17a12abfd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d1451115d9e2d4202a78e908c2d781bf1ea1bfb2430b390375d8c220b9eabef65f18763fd39a34b502b3692f96d06b8d1d1f176264855456b4acd5032d10d3"} 06:12:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:00 INFO - Copying logs to upload dir... 06:12:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.013417 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-22 06:12:00.434138) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 06:12:00.437383) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cefdc44333ddf28c21865d4f83b9f194d50196aeb0e286097ce83ad55d4ea8ddd2cb3b6b66b2ab568b51824be9f1d41a42cc37b6d8acec7619628704e6b87861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b98c945ee090e3c9f075b96420d06a2bb0fddaf7c666c0a3feb713828aa36176f0c9d257b9787873484e0644aeda3d7372636f4ad96f45c6a1d17a12abfd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d1451115d9e2d4202a78e908c2d781bf1ea1bfb2430b390375d8c220b9eabef65f18763fd39a34b502b3692f96d06b8d1d1f176264855456b4acd5032d10d3"} build_url:https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/PDaskp9lQ9qPCokH4kUb1Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cefdc44333ddf28c21865d4f83b9f194d50196aeb0e286097ce83ad55d4ea8ddd2cb3b6b66b2ab568b51824be9f1d41a42cc37b6d8acec7619628704e6b87861", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b55b98c945ee090e3c9f075b96420d06a2bb0fddaf7c666c0a3feb713828aa36176f0c9d257b9787873484e0644aeda3d7372636f4ad96f45c6a1d17a12abfd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/89d1451115d9e2d4202a78e908c2d781bf1ea1bfb2430b390375d8c220b9eabef65f18763fd39a34b502b3692f96d06b8d1d1f176264855456b4acd5032d10d3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 06:12:00.462487) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 06:12:00.462789) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469188050.991297-1268615446 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 06:12:00.545708) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 06:12:00.546031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 06:12:00.546310) ========= ========= Total master_lag: 0.19 =========