builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1468663261.39 results: success (0) buildid: 20160716002752 builduid: a0f809ef6d8149f3ad36b687424016bf revision: 65aee59b180854a503b0642e708bd7081785b31a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.385848) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.386306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.386594) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.404650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.404960) ========= 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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-16 03:01:01-- 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% 226M=0s 2016-07-16 03:01:01 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144704 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.566680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.567095) ========= 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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018500 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.620300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:01.620698) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 65aee59b180854a503b0642e708bd7081785b31a --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 65aee59b180854a503b0642e708bd7081785b31a --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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-16 03:01:01,758 truncating revision to first 12 chars 2016-07-16 03:01:01,758 Setting DEBUG logging. 2016-07-16 03:01:01,758 attempt 1/10 2016-07-16 03:01:01,758 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/65aee59b1808?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-16 03:01:02,044 unpacking tar archive at: mozilla-aurora-65aee59b1808/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613509 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:02.246798) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:02.247101) ========= script_repo_revision: 65aee59b180854a503b0642e708bd7081785b31a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:02.250635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:02.250918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-16 03:01:02.260852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-16 03:01:02.261253) ========= /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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:02 INFO - MultiFileLogger online at 20160716 03:01:02 in /builds/slave/test 03:01:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:01:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:02 INFO - {'append_to_log': False, 03:01:02 INFO - 'base_work_dir': '/builds/slave/test', 03:01:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:01:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:02 INFO - 'branch': 'Mozilla-Aurora', 03:01:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:02 INFO - 'config_files': ('talos/linux_config.py',), 03:01:02 INFO - 'default_actions': ('clobber', 03:01:02 INFO - 'read-buildbot-config', 03:01:02 INFO - 'download-and-extract', 03:01:02 INFO - 'populate-webroot', 03:01:02 INFO - 'create-virtualenv', 03:01:02 INFO - 'install', 03:01:02 INFO - 'run-tests'), 03:01:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:02 INFO - 'download_minidump_stackwalk': True, 03:01:02 INFO - 'download_symbols': 'ondemand', 03:01:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:02 INFO - 'installer_path': 'installer.exe', 03:01:02 INFO - 'log_level': 'info', 03:01:02 INFO - 'log_name': 'talos', 03:01:02 INFO - 'log_to_console': True, 03:01:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:02 INFO - 'opt_config_files': (), 03:01:02 INFO - 'pip_index': False, 03:01:02 INFO - 'sps_profile': False, 03:01:02 INFO - 'sps_profile_interval': 0, 03:01:02 INFO - 'suite': 'dromaeojs', 03:01:02 INFO - 'system_bits': '32', 03:01:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:02 INFO - 'title': 'talos-linux64-ix-056', 03:01:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:02 INFO - 'use_talos_json': True, 03:01:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:02 INFO - 'work_dir': 'build'} 03:01:02 INFO - ##### 03:01:02 INFO - ##### Running clobber step. 03:01:02 INFO - ##### 03:01:02 INFO - Running pre-action listener: _resource_record_pre_action 03:01:02 INFO - Running main action method: clobber 03:01:02 INFO - rmtree: /builds/slave/test/build 03:01:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:03 INFO - Running post-action listener: _resource_record_post_action 03:01:03 INFO - ##### 03:01:03 INFO - ##### Finished clobber step (success) 03:01:03 INFO - ##### 03:01:03 INFO - ##### 03:01:03 INFO - ##### Running read-buildbot-config step. 03:01:03 INFO - ##### 03:01:03 INFO - Running pre-action listener: _resource_record_pre_action 03:01:03 INFO - Running main action method: read_buildbot_config 03:01:03 INFO - Using buildbot properties: 03:01:03 INFO - { 03:01:03 INFO - "project": "", 03:01:03 INFO - "product": "firefox", 03:01:03 INFO - "script_repo_revision": "production", 03:01:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:01:03 INFO - "repository": "", 03:01:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:01:03 INFO - "buildid": "20160716002752", 03:01:03 INFO - "pgo_build": "True", 03:01:03 INFO - "basedir": "/builds/slave/test", 03:01:03 INFO - "buildnumber": 370, 03:01:03 INFO - "slavename": "talos-linux64-ix-056", 03:01:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:01:03 INFO - "platform": "ubuntu64_hw", 03:01:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:01:03 INFO - "branch": "mozilla-aurora", 03:01:03 INFO - "repo_path": "releases/mozilla-aurora", 03:01:03 INFO - "revision": "65aee59b180854a503b0642e708bd7081785b31a", 03:01:03 INFO - "stage_platform": "linux64-pgo", 03:01:03 INFO - "builduid": "a0f809ef6d8149f3ad36b687424016bf", 03:01:03 INFO - "slavebuilddir": "test" 03:01:03 INFO - } 03:01:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:01:03 INFO - Running post-action listener: _resource_record_post_action 03:01:03 INFO - ##### 03:01:03 INFO - ##### Finished read-buildbot-config step (success) 03:01:03 INFO - ##### 03:01:03 INFO - ##### 03:01:03 INFO - ##### Running download-and-extract step. 03:01:03 INFO - ##### 03:01:03 INFO - Running pre-action listener: _resource_record_pre_action 03:01:03 INFO - Running main action method: download_and_extract 03:01:03 INFO - mkdir: /builds/slave/test/build/tests 03:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:03 INFO - https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:01:08 INFO - Downloaded 1361 bytes. 03:01:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:01:08 INFO - Using the following test package requirements: 03:01:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:01:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:01:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:01:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'jsshell-linux-x86_64.zip'], 03:01:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:01:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:01:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:01:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:01:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:01:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:01:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:01:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:01: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')]} 03:01:08 INFO - https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:01:21 INFO - Downloaded 24489693 bytes. 03:01:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:01:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:01:22 INFO - Return code: 0 03:01:22 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:01:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:22 INFO - https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:01:24 INFO - Downloaded 24489693 bytes. 03:01:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:01:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:01:25 INFO - Return code: 0 03:01:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:25 INFO - https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:01:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:01:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:01:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:01:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:01:27 INFO - Downloaded 10833369 bytes. 03:01:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:01:27 INFO - Return code: 0 03:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:27 INFO - https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:01:28 INFO - Downloaded 63636546 bytes. 03:01:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:01:28 INFO - mkdir: /builds/slave/test/properties 03:01:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:28 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:28 INFO - Contents: 03:01:28 INFO - build_url:https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:01:29 INFO - Running post-action listener: _resource_record_post_action 03:01:29 INFO - Running post-action listener: set_extra_try_arguments 03:01:29 INFO - ##### 03:01:29 INFO - ##### Finished download-and-extract step (success) 03:01:29 INFO - ##### 03:01:29 INFO - ##### 03:01:29 INFO - ##### Running populate-webroot step. 03:01:29 INFO - ##### 03:01:29 INFO - Running pre-action listener: _resource_record_pre_action 03:01:29 INFO - Running main action method: populate_webroot 03:01:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:29 INFO - '--tppagecycles', 03:01:29 INFO - '7'], 03:01:29 INFO - 'tests': ['tsvgm']}}, 03:01:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:01:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:01:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:01:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['damp', 'tps']}, 03:01:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'tests': ['damp', 'tps']}, 03:01:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['dromaeo_dom']}, 03:01:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'other-e10s': {'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['a11yr', 03:01:29 INFO - 'ts_paint', 03:01:29 INFO - 'tpaint', 03:01:29 INFO - 'sessionrestore', 03:01:29 INFO - 'sessionrestore_no_auto_restore', 03:01:29 INFO - 'tabpaint']}, 03:01:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['tsvgx', 03:01:29 INFO - 'tsvgr_opacity', 03:01:29 INFO - 'tart', 03:01:29 INFO - 'tscrollx', 03:01:29 INFO - 'cart']}, 03:01:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:01:29 INFO - 'tsvgr_opacity', 03:01:29 INFO - 'tart', 03:01:29 INFO - 'tscrollx', 03:01:29 INFO - 'cart']}, 03:01:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'talos_options': ['--disable-e10s'], 03:01:29 INFO - 'tests': ['tp5o']}, 03:01:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'tests': ['tp5o']}, 03:01:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'talos_options': ['--disable-e10s', 03:01:29 INFO - '--xperf_path', 03:01:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:29 INFO - 'tests': ['tp5n']}, 03:01:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:29 INFO - 'talos_options': ['--xperf_path', 03:01:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:29 INFO - 'tests': ['tp5n']}}, 03:01:29 INFO - 'talos.zip': {'path': '', 03:01:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:29 INFO - Running post-action listener: _resource_record_post_action 03:01:29 INFO - ##### 03:01:29 INFO - ##### Finished populate-webroot step (success) 03:01:29 INFO - ##### 03:01:29 INFO - ##### 03:01:29 INFO - ##### Running create-virtualenv step. 03:01:29 INFO - ##### 03:01:29 INFO - Running pre-action listener: _resource_record_pre_action 03:01:29 INFO - Running main action method: create_virtualenv 03:01:29 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:01:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:29 INFO - Using real prefix '/usr' 03:01:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:30 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:32 INFO - Installing pip.................done. 03:01:32 INFO - Return code: 0 03:01:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:32 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:01:32 INFO - Using env: {'DISPLAY': ':0', 03:01:32 INFO - 'HOME': '/home/cltbld', 03:01:32 INFO - 'LANG': 'en_US.UTF-8', 03:01:32 INFO - 'LANGUAGE': 'en_US:en', 03:01:32 INFO - 'LOGNAME': 'cltbld', 03:01:32 INFO - 'MAIL': '/var/mail/cltbld', 03:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:32 INFO - 'MOZ_NO_REMOTE': '1', 03:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:32 INFO - 'NO_EM_RESTART': '1', 03:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:32 INFO - 'PWD': '/builds/slave/test', 03:01:32 INFO - 'SHELL': '/bin/bash', 03:01:32 INFO - 'SHLVL': '1', 03:01:32 INFO - 'TERM': 'linux', 03:01:32 INFO - 'TMOUT': '86400', 03:01:32 INFO - 'USER': 'cltbld', 03:01:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:32 INFO - '_': '/tools/buildbot/bin/python'} 03:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:01:32 INFO - Cleaning up... 03:01:32 INFO - Return code: 0 03:01:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:32 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:01:32 INFO - Using env: {'DISPLAY': ':0', 03:01:32 INFO - 'HOME': '/home/cltbld', 03:01:32 INFO - 'LANG': 'en_US.UTF-8', 03:01:32 INFO - 'LANGUAGE': 'en_US:en', 03:01:32 INFO - 'LOGNAME': 'cltbld', 03:01:32 INFO - 'MAIL': '/var/mail/cltbld', 03:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:32 INFO - 'MOZ_NO_REMOTE': '1', 03:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:32 INFO - 'NO_EM_RESTART': '1', 03:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:32 INFO - 'PWD': '/builds/slave/test', 03:01:32 INFO - 'SHELL': '/bin/bash', 03:01:32 INFO - 'SHLVL': '1', 03:01:32 INFO - 'TERM': 'linux', 03:01:32 INFO - 'TMOUT': '86400', 03:01:32 INFO - 'USER': 'cltbld', 03:01:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:32 INFO - '_': '/tools/buildbot/bin/python'} 03:01:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:33 INFO - Downloading/unpacking psutil>=3.1.1 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:35 INFO - Installing collected packages: psutil 03:01:35 INFO - Running setup.py install for psutil 03:01:35 INFO - building 'psutil._psutil_linux' extension 03:01:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:01:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:01:35 INFO - building 'psutil._psutil_posix' extension 03:01:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:01:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:01:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:35 INFO - Successfully installed psutil 03:01:35 INFO - Cleaning up... 03:01:35 INFO - Return code: 0 03:01:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:01: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 mozsystemmonitor==0.3 03:01:35 INFO - Using env: {'DISPLAY': ':0', 03:01:35 INFO - 'HOME': '/home/cltbld', 03:01:35 INFO - 'LANG': 'en_US.UTF-8', 03:01:35 INFO - 'LANGUAGE': 'en_US:en', 03:01:35 INFO - 'LOGNAME': 'cltbld', 03:01:35 INFO - 'MAIL': '/var/mail/cltbld', 03:01:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:35 INFO - 'MOZ_NO_REMOTE': '1', 03:01:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:35 INFO - 'NO_EM_RESTART': '1', 03:01:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:35 INFO - 'PWD': '/builds/slave/test', 03:01:35 INFO - 'SHELL': '/bin/bash', 03:01:35 INFO - 'SHLVL': '1', 03:01:35 INFO - 'TERM': 'linux', 03:01:35 INFO - 'TMOUT': '86400', 03:01:35 INFO - 'USER': 'cltbld', 03:01:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:35 INFO - '_': '/tools/buildbot/bin/python'} 03:01:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:01:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:01:37 INFO - Installing collected packages: mozsystemmonitor 03:01:37 INFO - Running setup.py install for mozsystemmonitor 03:01:37 INFO - Successfully installed mozsystemmonitor 03:01:37 INFO - Cleaning up... 03:01:38 INFO - Return code: 0 03:01:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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', '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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:01: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 jsonschema==2.5.1 03:01:38 INFO - Using env: {'DISPLAY': ':0', 03:01:38 INFO - 'HOME': '/home/cltbld', 03:01:38 INFO - 'LANG': 'en_US.UTF-8', 03:01:38 INFO - 'LANGUAGE': 'en_US:en', 03:01:38 INFO - 'LOGNAME': 'cltbld', 03:01:38 INFO - 'MAIL': '/var/mail/cltbld', 03:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:38 INFO - 'MOZ_NO_REMOTE': '1', 03:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:38 INFO - 'NO_EM_RESTART': '1', 03:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:38 INFO - 'PWD': '/builds/slave/test', 03:01:38 INFO - 'SHELL': '/bin/bash', 03:01:38 INFO - 'SHLVL': '1', 03:01:38 INFO - 'TERM': 'linux', 03:01:38 INFO - 'TMOUT': '86400', 03:01:38 INFO - 'USER': 'cltbld', 03:01:38 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:38 INFO - '_': '/tools/buildbot/bin/python'} 03:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:39 INFO - Downloading/unpacking jsonschema==2.5.1 03:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:01:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:01:41 INFO - warning: no files found matching '*.txt' 03:01:41 INFO - no previously-included directories found matching 'build' 03:01:41 INFO - no previously-included directories found matching 'dist' 03:01:41 INFO - no previously-included directories found matching '.git*' 03:01:41 INFO - Installing collected packages: jsonschema, functools32 03:01:41 INFO - Running setup.py install for functools32 03:01:41 INFO - warning: no files found matching '*.txt' 03:01:41 INFO - no previously-included directories found matching 'build' 03:01:41 INFO - no previously-included directories found matching 'dist' 03:01:41 INFO - no previously-included directories found matching '.git*' 03:01:41 INFO - Successfully installed jsonschema functools32 03:01:41 INFO - Cleaning up... 03:01:41 INFO - Return code: 0 03:01:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:01:41 INFO - Using env: {'DISPLAY': ':0', 03:01:41 INFO - 'HOME': '/home/cltbld', 03:01:41 INFO - 'LANG': 'en_US.UTF-8', 03:01:41 INFO - 'LANGUAGE': 'en_US:en', 03:01:41 INFO - 'LOGNAME': 'cltbld', 03:01:41 INFO - 'MAIL': '/var/mail/cltbld', 03:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:41 INFO - 'MOZ_NO_REMOTE': '1', 03:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:41 INFO - 'NO_EM_RESTART': '1', 03:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:41 INFO - 'PWD': '/builds/slave/test', 03:01:41 INFO - 'SHELL': '/bin/bash', 03:01:41 INFO - 'SHLVL': '1', 03:01:41 INFO - 'TERM': 'linux', 03:01:41 INFO - 'TMOUT': '86400', 03:01:41 INFO - 'USER': 'cltbld', 03:01:41 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:41 INFO - '_': '/tools/buildbot/bin/python'} 03:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:01:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:01:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:44 INFO - Downloading docopt-0.6.1.tar.gz 03:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:01:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:01:44 INFO - Running setup.py install for blobuploader 03:01:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:01:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:01:44 INFO - Running setup.py install for requests 03:01:45 INFO - Running setup.py install for docopt 03:01:45 INFO - Successfully installed blobuploader requests docopt 03:01:45 INFO - Cleaning up... 03:01:45 INFO - Return code: 0 03:01:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:45 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:01:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:45 INFO - Using env: {'DISPLAY': ':0', 03:01:45 INFO - 'HOME': '/home/cltbld', 03:01:45 INFO - 'LANG': 'en_US.UTF-8', 03:01:45 INFO - 'LANGUAGE': 'en_US:en', 03:01:45 INFO - 'LOGNAME': 'cltbld', 03:01:45 INFO - 'MAIL': '/var/mail/cltbld', 03:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:45 INFO - 'MOZ_NO_REMOTE': '1', 03:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:45 INFO - 'NO_EM_RESTART': '1', 03:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:45 INFO - 'PWD': '/builds/slave/test', 03:01:45 INFO - 'SHELL': '/bin/bash', 03:01:45 INFO - 'SHLVL': '1', 03:01:45 INFO - 'TERM': 'linux', 03:01:45 INFO - 'TMOUT': '86400', 03:01:45 INFO - 'USER': 'cltbld', 03:01:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:45 INFO - '_': '/tools/buildbot/bin/python'} 03:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:45 INFO - Running setup.py (path:/tmp/pip-ueA27Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:45 INFO - Running setup.py (path:/tmp/pip-qFucN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:45 INFO - Running setup.py (path:/tmp/pip-uLf9G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:45 INFO - Running setup.py (path:/tmp/pip-Jd3p7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:45 INFO - Running setup.py (path:/tmp/pip-49SMEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:45 INFO - Running setup.py (path:/tmp/pip-usB8ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:46 INFO - Running setup.py (path:/tmp/pip-qFSF6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:46 INFO - Running setup.py (path:/tmp/pip-pzPMMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:46 INFO - Running setup.py (path:/tmp/pip-LbLSFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:46 INFO - Running setup.py (path:/tmp/pip-QvaKLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:46 INFO - Running setup.py (path:/tmp/pip-3bmZua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:46 INFO - Running setup.py (path:/tmp/pip-JEUySj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:46 INFO - Running setup.py (path:/tmp/pip-I0qvBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:46 INFO - Running setup.py (path:/tmp/pip-fkS_Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:46 INFO - Running setup.py (path:/tmp/pip-14KhpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:46 INFO - Running setup.py (path:/tmp/pip-37BvIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:46 INFO - Running setup.py (path:/tmp/pip-qwLiWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:01:46 INFO - Running setup.py install for manifestparser 03:01:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:01:46 INFO - Running setup.py install for mozcrash 03:01:47 INFO - Running setup.py install for mozdebug 03:01:47 INFO - Running setup.py install for mozdevice 03:01:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for mozfile 03:01:47 INFO - Running setup.py install for mozhttpd 03:01:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for mozinfo 03:01:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for mozInstall 03:01:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for mozleak 03:01:47 INFO - Running setup.py install for mozlog 03:01:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for moznetwork 03:01:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:01:47 INFO - Running setup.py install for mozprocess 03:01:48 INFO - Running setup.py install for mozprofile 03:01:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:01:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:01:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:01:48 INFO - Running setup.py install for mozrunner 03:01:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:01:48 INFO - Running setup.py install for mozscreenshot 03:01:48 INFO - Running setup.py install for moztest 03:01:48 INFO - Running setup.py install for mozversion 03:01:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:01:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:01:48 INFO - Cleaning up... 03:01:48 INFO - Return code: 0 03:01:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:48 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:01:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:48 INFO - Using env: {'DISPLAY': ':0', 03:01:48 INFO - 'HOME': '/home/cltbld', 03:01:48 INFO - 'LANG': 'en_US.UTF-8', 03:01:48 INFO - 'LANGUAGE': 'en_US:en', 03:01:48 INFO - 'LOGNAME': 'cltbld', 03:01:48 INFO - 'MAIL': '/var/mail/cltbld', 03:01:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:48 INFO - 'MOZ_NO_REMOTE': '1', 03:01:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:48 INFO - 'NO_EM_RESTART': '1', 03:01:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:48 INFO - 'PWD': '/builds/slave/test', 03:01:48 INFO - 'SHELL': '/bin/bash', 03:01:48 INFO - 'SHLVL': '1', 03:01:48 INFO - 'TERM': 'linux', 03:01:48 INFO - 'TMOUT': '86400', 03:01:48 INFO - 'USER': 'cltbld', 03:01:48 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:48 INFO - '_': '/tools/buildbot/bin/python'} 03:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:01:48 INFO - Running setup.py (path:/tmp/pip-vCKoSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:01:48 INFO - Running setup.py (path:/tmp/pip-nqGnpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:01:49 INFO - Running setup.py (path:/tmp/pip-diaDP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:01:49 INFO - Running setup.py (path:/tmp/pip-MrZbwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:01:49 INFO - Running setup.py (path:/tmp/pip-N16pZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:01:49 INFO - Running setup.py (path:/tmp/pip-eFMoMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:01:49 INFO - Running setup.py (path:/tmp/pip-pc50KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:01:49 INFO - Running setup.py (path:/tmp/pip-eZpKeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:01:49 INFO - Running setup.py (path:/tmp/pip-9EXvbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:01:49 INFO - Running setup.py (path:/tmp/pip-3a9YWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:01:49 INFO - Running setup.py (path:/tmp/pip-HIrqFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:01:49 INFO - Running setup.py (path:/tmp/pip-xK5wjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:01:49 INFO - Running setup.py (path:/tmp/pip-9kHsF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:01:49 INFO - Running setup.py (path:/tmp/pip-YHg0oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:49 INFO - Running setup.py (path:/tmp/pip-xB8Xjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:01:49 INFO - Running setup.py (path:/tmp/pip-iinfyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:01:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:01:50 INFO - Running setup.py (path:/tmp/pip-g2ec22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:01:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:52 INFO - Downloading blessings-1.6.tar.gz 03:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:01:52 INFO - Installing collected packages: blessings 03:01:52 INFO - Running setup.py install for blessings 03:01:52 INFO - Successfully installed blessings 03:01:52 INFO - Cleaning up... 03:01:52 INFO - Return code: 0 03:01:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:01:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:52 INFO - Reading from file tmpfile_stdout 03:01:52 INFO - Current package versions: 03:01:52 INFO - argparse == 1.2.1 03:01:52 INFO - blessings == 1.6 03:01:52 INFO - blobuploader == 1.2.4 03:01:52 INFO - docopt == 0.6.1 03:01:52 INFO - functools32 == 3.2.3-2 03:01:52 INFO - jsonschema == 2.5.1 03:01:52 INFO - manifestparser == 1.1 03:01:52 INFO - mozInstall == 1.12 03:01:52 INFO - mozcrash == 0.17 03:01:52 INFO - mozdebug == 0.1 03:01:52 INFO - mozdevice == 0.48 03:01:52 INFO - mozfile == 1.2 03:01:52 INFO - mozhttpd == 0.7 03:01:52 INFO - mozinfo == 0.9 03:01:52 INFO - mozleak == 0.1 03:01:52 INFO - mozlog == 3.2 03:01:52 INFO - moznetwork == 0.27 03:01:52 INFO - mozprocess == 0.23 03:01:52 INFO - mozprofile == 0.28 03:01:52 INFO - mozrunner == 6.12 03:01:52 INFO - mozscreenshot == 0.1 03:01:52 INFO - mozsystemmonitor == 0.3 03:01:52 INFO - moztest == 0.7 03:01:52 INFO - mozversion == 1.4 03:01:52 INFO - psutil == 3.1.1 03:01:52 INFO - requests == 1.2.3 03:01:52 INFO - wsgiref == 0.1.2 03:01:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:01:52 INFO - Using env: {'DISPLAY': ':0', 03:01:52 INFO - 'HOME': '/home/cltbld', 03:01:52 INFO - 'LANG': 'en_US.UTF-8', 03:01:52 INFO - 'LANGUAGE': 'en_US:en', 03:01:52 INFO - 'LOGNAME': 'cltbld', 03:01:52 INFO - 'MAIL': '/var/mail/cltbld', 03:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:52 INFO - 'MOZ_NO_REMOTE': '1', 03:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:52 INFO - 'NO_EM_RESTART': '1', 03:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:52 INFO - 'PWD': '/builds/slave/test', 03:01:52 INFO - 'SHELL': '/bin/bash', 03:01:52 INFO - 'SHLVL': '1', 03:01:52 INFO - 'TERM': 'linux', 03:01:52 INFO - 'TMOUT': '86400', 03:01:52 INFO - 'USER': 'cltbld', 03:01:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:52 INFO - '_': '/tools/buildbot/bin/python'} 03:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:01:52 INFO - Cleaning up... 03:01:52 INFO - Return code: 0 03:01:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:01:52 INFO - Using env: {'DISPLAY': ':0', 03:01:52 INFO - 'HOME': '/home/cltbld', 03:01:52 INFO - 'LANG': 'en_US.UTF-8', 03:01:52 INFO - 'LANGUAGE': 'en_US:en', 03:01:52 INFO - 'LOGNAME': 'cltbld', 03:01:52 INFO - 'MAIL': '/var/mail/cltbld', 03:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:52 INFO - 'MOZ_NO_REMOTE': '1', 03:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:52 INFO - 'NO_EM_RESTART': '1', 03:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:52 INFO - 'PWD': '/builds/slave/test', 03:01:52 INFO - 'SHELL': '/bin/bash', 03:01:52 INFO - 'SHLVL': '1', 03:01:52 INFO - 'TERM': 'linux', 03:01:52 INFO - 'TMOUT': '86400', 03:01:52 INFO - 'USER': 'cltbld', 03:01:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:52 INFO - '_': '/tools/buildbot/bin/python'} 03:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:01:52 INFO - Cleaning up... 03:01:52 INFO - Return code: 0 03:01:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:52 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 0x7fba54f06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28fc020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, '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': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:01:52 INFO - Using env: {'DISPLAY': ':0', 03:01:52 INFO - 'HOME': '/home/cltbld', 03:01:52 INFO - 'LANG': 'en_US.UTF-8', 03:01:52 INFO - 'LANGUAGE': 'en_US:en', 03:01:52 INFO - 'LOGNAME': 'cltbld', 03:01:52 INFO - 'MAIL': '/var/mail/cltbld', 03:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:52 INFO - 'MOZ_NO_REMOTE': '1', 03:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:52 INFO - 'NO_EM_RESTART': '1', 03:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:52 INFO - 'PWD': '/builds/slave/test', 03:01:52 INFO - 'SHELL': '/bin/bash', 03:01:52 INFO - 'SHLVL': '1', 03:01:52 INFO - 'TERM': 'linux', 03:01:52 INFO - 'TMOUT': '86400', 03:01:52 INFO - 'USER': 'cltbld', 03:01:52 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:52 INFO - '_': '/tools/buildbot/bin/python'} 03:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:53 INFO - Downloading/unpacking flake8 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:01:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:01:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:01:55 INFO - no previously-included directories found matching 'docs/_build' 03:01:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:01:55 INFO - Running setup.py install for pep8 03:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:01:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:01:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:01:55 INFO - no previously-included directories found matching 'docs/_build' 03:01:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:01:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:01:55 INFO - Cleaning up... 03:01:56 INFO - Return code: 0 03:01:56 INFO - Running post-action listener: _resource_record_post_action 03:01:56 INFO - Running post-action listener: _start_resource_monitoring 03:01:56 INFO - Starting resource monitoring. 03:01:56 INFO - ##### 03:01:56 INFO - ##### Finished create-virtualenv step (success) 03:01:56 INFO - ##### 03:01:56 INFO - ##### 03:01:56 INFO - ##### Running install step. 03:01:56 INFO - ##### 03:01:56 INFO - Running pre-action listener: _resource_record_pre_action 03:01:56 INFO - Running main action method: install 03:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:01:56 INFO - Reading from file tmpfile_stdout 03:01:56 INFO - Detecting whether we're running mozinstall >=1.0... 03:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:01:56 INFO - Reading from file tmpfile_stdout 03:01:56 INFO - Output received: 03:01:56 INFO - Usage: mozinstall [options] installer 03:01:56 INFO - Options: 03:01:56 INFO - -h, --help show this help message and exit 03:01:56 INFO - -d DEST, --destination=DEST 03:01:56 INFO - Directory to install application into. [default: 03:01:56 INFO - "/builds/slave/test"] 03:01:56 INFO - --app=APP Application being installed. [default: firefox] 03:01:56 INFO - mkdir: /builds/slave/test/build/application 03:01:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:01:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:02:12 INFO - Reading from file tmpfile_stdout 03:02:12 INFO - Output received: 03:02:12 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:12 INFO - Running post-action listener: _resource_record_post_action 03:02:12 INFO - ##### 03:02:12 INFO - ##### Finished install step (success) 03:02:12 INFO - ##### 03:02:12 INFO - ##### 03:02:12 INFO - ##### Running run-tests step. 03:02:12 INFO - ##### 03:02:12 INFO - Running pre-action listener: _resource_record_pre_action 03:02:12 INFO - Running main action method: run_tests 03:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:12 INFO - Python 2.7.3 03:02:12 INFO - Return code: 0 03:02:12 INFO - grabbing minidump binary from tooltool 03:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:12 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 0x298e2e0>, '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 0x28fa140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28fa5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:02:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:02:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:02:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:12 INFO - Return code: 0 03:02:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:02:13 INFO - Return code: 0 03:02:13 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/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:02:13 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/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:02:13 INFO - Using env: {'DISPLAY': ':0', 03:02:13 INFO - 'HOME': '/home/cltbld', 03:02:13 INFO - 'LANG': 'en_US.UTF-8', 03:02:13 INFO - 'LANGUAGE': 'en_US:en', 03:02:13 INFO - 'LOGNAME': 'cltbld', 03:02:13 INFO - 'MAIL': '/var/mail/cltbld', 03:02:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:13 INFO - 'MOZ_NO_REMOTE': '1', 03:02:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:13 INFO - 'NO_EM_RESTART': '1', 03:02:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:13 INFO - 'PWD': '/builds/slave/test', 03:02:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:13 INFO - 'SHELL': '/bin/bash', 03:02:13 INFO - 'SHLVL': '1', 03:02:13 INFO - 'TERM': 'linux', 03:02:13 INFO - 'TMOUT': '86400', 03:02:13 INFO - 'USER': 'cltbld', 03:02:13 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293', 03:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:13 INFO - '_': '/tools/buildbot/bin/python'} 03:02:13 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/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:02:13 INFO - mozversion application_buildid: 20160716002752 03:02:13 INFO - mozversion application_changeset: 65aee59b180854a503b0642e708bd7081785b31a 03:02:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:02:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:13 INFO - mozversion application_name: Firefox 03:02:13 INFO - mozversion application_remotingname: firefox-dev 03:02:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:13 INFO - mozversion application_vendor: Mozilla 03:02:13 INFO - mozversion application_version: 49.0a2 03:02:13 INFO - mozversion platform_buildid: 20160716002752 03:02:13 INFO - mozversion platform_changeset: 65aee59b180854a503b0642e708bd7081785b31a 03:02:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:02:13 INFO - mozversion platform_version: 49.0a2 03:02:13 INFO - using testdate: 1468663333 03:02:13 INFO - actual date: 1468663333 03:02:13 INFO - starting webserver on 'localhost:59723' 03:02:13 INFO - SUITE-START | Running 2 tests 03:02:13 INFO - TEST-START | dromaeo_css 03:02:13 INFO - operating with platform_type : linux_ 03:02:13 INFO - Initialising browser for dromaeo_css test... 03:02:13 INFO - TEST-INFO | started process 28612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7qWrK/profile http://localhost:59723/getInfo.html) 03:02:17 INFO - PROCESS | 28612 | __metrics Screen width/height:1600/1200 03:02:17 INFO - PROCESS | 28612 | colorDepth:24 03:02:17 INFO - PROCESS | 28612 | Browser inner width/height: 1024/697 03:02:17 INFO - PROCESS | 28612 | __metrics 03:02:19 INFO - PROCESS | 28612 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:02:19 ERROR - PROCESS | 28612 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:02:20 INFO - TEST-INFO | 28612: exit 0 03:02:20 INFO - Browser initialized. 03:02:20 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:20 INFO - TEST-INFO | started process 28705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7qWrK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:31 INFO - PROCESS | 28705 | RSS: Main: 145072128 03:02:31 INFO - PROCESS | 28705 | 03:03:23 INFO - PROCESS | 28705 | 1468663403315 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:05:31 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59723/tests/dromaeo/cssquery-ext.html) 03:05:32 INFO - PROCESS | 28705 | RSS: Main: 252440576 03:05:32 INFO - PROCESS | 28705 | 03:08:34 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-ext.html (next: http://localhost:59723/tests/dromaeo/cssquery-jquery.html) 03:08:35 INFO - PROCESS | 28705 | RSS: Main: 231444480 03:08:35 INFO - PROCESS | 28705 | 03:11:37 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59723/tests/dromaeo/cssquery-mootools.html) 03:11:38 INFO - PROCESS | 28705 | RSS: Main: 217415680 03:11:38 INFO - PROCESS | 28705 | 03:14:39 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59723/tests/dromaeo/cssquery-prototype.html) 03:14:40 INFO - PROCESS | 28705 | RSS: Main: 218726400 03:14:40 INFO - PROCESS | 28705 | 03:17:43 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59723/tests/dromaeo/cssquery-yui.html) 03:17:43 INFO - PROCESS | 28705 | RSS: Main: 218955776 03:17:43 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:59723/tests/dromaeo/cssquery-yui.html (next: http://localhost:59723/tests/dromaeo/cssquery-dojo.html) 03:20:46 INFO - PROCESS | 28705 | RSS: Main: 260788224 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | __start_tp_report 03:20:46 INFO - PROCESS | 28705 | _x_x_mozilla_page_load 03:20:46 INFO - PROCESS | 28705 | _x_x_mozilla_page_load_details 03:20:46 INFO - PROCESS | 28705 | |i|pagename|runs| 03:20:46 INFO - PROCESS | 28705 | |0;dojo.html;3357.664233576642;3362.899113026607;3363.8822641207553;3389.271306669066;3405.9148521286966;5539.390667026629;5580.804671836487;5624;5625.521830644395;5626.437356264381;5562.554995600352;5604.103343465046;5616.0629764336545;5621.409751976045;5636;4960.032793605248;5003.324551185598;5094.694318340893;5096.974515127428;5140.434552199274;5047.47001564836;5098.209777484496;5101.260317253996;5108.8978220435565;5109.923351149736;5016.47327030662;5025.994801039788;5026.497350264981;5057.216131499624;5106.693598384109;5183.326167598226;5192.247124166994;5203.349581302337;5204.089284375257;5238.711870847121;4914;4993.350864387643;5049.192129259301;5084.110280700863;5097.388313402378;5451.236826844245;5461.69960652164;5471.753771080271;5518.255035570187;5524.088525393306;6014.097885317194;6023.397660233985;6033.276006879202;6037.4566289033755;6040.063790112539;5918.082697181943;5972.790952316648;5979.790707325266;6008.098785182257;6061.242344706911;5588.6646801192055;5597.992361374951;5638.689872056994;5644.322681278273;5653.604247702621;5866.1494083357675;6106.452062707889;6125.448709616156;6127.387261273926;6135.091826699848;5756.395578464285;5787.189793428924;5817.214676018683;5896.292444906639;5904.645721256738;5948.940510594925;5952.970235148797;5957.523398128139;5986.461218490357;5992.880142397127;5712.857178570569;5885.911711324334;5924.496417804535;5936.614120082181;5941.287045554561;5938.61399009063;6011.879762404727;6019.729112189962;6025.9397406026255;6054;4617.0996655651825;4635.814567417333;4636.536346365404;4640.535946405333;4661.95338046622;4035.435039094529;4052.8378864845076;4105.220008198433;4141.958580414157;4156.937645935313;5763.596548241583;5784.768609255582;5788.247527821356;5790.247267855152;5808.854778630483;6014.849628759316;6045.818625441244;6050.878982420327;6068.302145253352;6069.423404776539;5540;5614.775408983676;5645.23789288449;5688.288963879515;5692.743826527816;5173.663711858792;5175.094358487249;5183.2743415921805;5188.273641690166;5188.507091826271;6230.158928544589;6233.688315584202;6240.906386404207;6246;6251.28110267316;5813.651180929158;5925.962956482685;5926.555508336805;5987;6035.456808887046;6214.472537053182;6249.718762655601;6254.562180647311;6265.937340626535;6279.058141278845;5908.711703025682;5914.142449344735;5921.703914804329;5926.318473375617;5954.136650185786;5791.449812267828;5864.501517371071;5881;5914.728333408338;5967.075103358986;5774.422557744192;5776.249087618583;5807.651540907559;5808.30300363959;5821.330546987151;5637.774489020393;5754.194412782297;5792.4497172768515;5817.156512305776;5824.417558244311;5652.830415087554;5692.48767610917;5709.54323654115;5764.250647415809;5765.682887441231;5846.532277417881;5855.736491857791;5892.1161825726485;5898.764049437975;5900.144479050427;5512.3385193777;5635.239242702182;5741.712914354349;5748.48263656273;5750.223719797774 03:20:46 INFO - PROCESS | 28705 | |1;ext.html;593.9821805345838;644.1883227133812;646.3891622416817;655.7049327802489;660.270401206667;32777.836110819444;35763.46354804677;44980;45888.31167532481;46042.769786151104;45533.31700024502;45809.77095114528;45956.77021614896;46011.30983035249;46054.539454605445;8931.240844528207;9073.092690730908;9079.591418386188;9089.091090890925;9093.136152065576;8322.875156872651;10627.84058239127;10876.564937402494;10883.891161088406;10905.727356816104;10788.08301294391;10852.186086043539;10878.510467029002;11161.553537858517;11183.552657893715;8291.170882911661;10791.5683372665;10936.56253749853;11020.559177632886;11038.006579407851;10537.104346130589;10909.127269818475;10929.180311476592;10930.945345273223;10933.234673572853;44400.111997759865;45220.32169517427;45303;45347.319790203175;45352;3680.723945704056;3825.2158307547165;4420.138073075719;4518.502964673883;4527.253003254459;34064.148396290046;34080.31839363224;34320.82839585786;34513.48229776556;36049;4579.358889755437;4662.930056049162;4668.11305851887;4770.952290477086;4841.782119804618;378750;382671;385045;385708;386250;39471.210575788326;69451.65274173698;70650;70682.64658676674;70770.64614676894;39484.407733884014;41494;41510;41527.37708934368;41531.792341038104;16259.756103658454;16267.430639927547;16334.264958076916;16339.591510212102;16421.91789041047;13098.345082745825;13876.306184690726;14122.788158177636;14222.928885355714;14316.997810153398;9324.440533568008;9404.576794044284;9405.76485587852;9418.764530886645;9470.384425012353;3544.929101417957;3582.2656355447593;3618.78770611848;3619.0771353305267;3640.6359364063383;1036.300497164411;1049.9997504753458;1128.3737525673166;1130.711668524521;1179.1804695736553;32943.34113317768;34333.313333733684;34363;34736;34972.12569685778;1160.9941950290363;1194.3848917807336;1214.2957084890743;1227.0551675210038;1237.665830225834;17993.820061799477;18107.637847242982;18344;18399.632007360047;18478.907605462155;675290;676381;679613;681008;682394;63552.68223658945;65016.34983650103;65207.67396162989;65336.34663653398;65397.34602654008;1341.8926485881107;1447.8262608487048;1462.8829693624484;1500.7373709600995;1504.4809540708657;33313.500297496044;34735.30529389449;35307.646923531465;35550.28899421945;35705.362050871394;54782.45217547933;60752.69623651853;62759.37240627535;62779;67613.66193169003;559806;560529;565710;566562;567157;40137.799311004426;48429.5157048425;50114.24828627647;50728.746356267984;51273.23090153576;50949.49050509447;51863.481365185864;52012.47987520076;52872;53212.46787532075;43530.12939741251;43658;43694;43942.13562338215;44849.55150448584;42866.57133428626;44111.77944110259;44132.779336103114;44987;45267.77366113148;43330.35004474998;43762;44062;44502.332465012405;44592.77703611461;38473.807630961666;38631.227375452894;38819;39223.80388098041;39596;29003.854980724962;29820;30056;30482.84758576193;30617.387652247275 03:20:46 INFO - PROCESS | 28705 | |2;jquery.html;423.6187431311819;434.40107436694274;437.0858958030834;438.2243429130438;445.98439054633076;19024.71462928057;19412.51468713283;20454.07956641951;20454.89772551139;20552.280670176548;18713.157907894143;19495.902520487412;20091;20141.899290503527;20203.292884749037;5696.25948626679;5861.560382971273;5911.940880591182;5914.053751399777;5924.407559244084;5624.71876406178;5755.079187330028;5791.0734282514595;5841.182234487175;5846.532277417797;5712.285964254468;5801.593888427812;5802.245708057968;5810.854728631776;5822.912656310159;5643.68959707216;5745;5792.507636850831;5796.217510636052;5798.42015798421;5198.610104242197;5217.530422261977;5220.530152286313;5225.712585807779;5231.686098834044;22057.779422205735;22887;23311.7668823313;23312.3006309811;23369.766302336928;2673.131232349494;2680.7453291937236;2752.862356882148;2774.694783573805;3104.9534256986162;14474.131552106906;14588.562343129723;14769.852301477062;14985.400583976629;15434.768478472832;1824.954376140594;2096.3920463065847;2151.741790985076;2166.4150679316654;2194.967075493869;86635.56682216612;94797;95670.52164739202;96986.09041728759;99832.50083749607;18074.457766267034;18796.812031879505;18978.335758248395;19019.334323298895;19274.903625481784;33235.83382083123;33384.49923251153;33549;33681.49477757836;33684;10356;10688.305260158066;10799.866014068566;10815.83776243357;10930.180236482296;8838.381313308135;8857.867131993025;8869.290456763443;8903.465792052497;9093.681721139728;9085.77285567866;9179.357444978921;9254.305927055364;9351.18414016782;9540.761480962892;3485.4074807282823;3520.4543295789194;3545.1137215696076;3591.9102022449647;3738.513993180869;877.5349064995562;955.5699935029264;1019.3883669798062;1083.967480975572;1124.4771181400524;18141.7278740819;19173.712394313818;19462.902685486482;19485.707714384294;20079.799202008086;1060.1095080132725;1075.9408232547128;1105.578782466396;1114.5318966034285;1125.9493322800495;10821.783564328669;11023;11079.279846809932;11105.555777768799;11163.72090697739;514476;516919;536684;538417;544376;68765.31234687589;82528;83085.58457207796;99521;103316;1012.4583347908981;1014.5028935821394;1026.2098184397971;1044.796264728386;1045.4041196517912;17466.777325587595;17613.911930440267;17716;17736.201870915582;17962.730559041887;40295.59704403036;40703.18593628052;40802.591974081064;42113.36829947615;42167.57832421759;58886;58932.705336473045;59176.408235917086;59381;59498.40501594928;8604.182602652738;8813.779655508664;8884.911150888409;8935.955320223617;9217;9937.453440060866;12942;13571.864281357455;13795.517156899461;13824.308784560531;11560.24858384236;11798;11849.111316651113;11988.76022479528;12017.339046352534;11740.002099821611;11839.526418943491;11885.762284754084;11947.641570752892;11966.700832479257;11877.46551405206;12089.637310880687;12139.696507587381;12408.937955310166;12609.558665446666;7880.527168369917;8359.540225287425;8821.514816685143;8973.506457144658;9100.771395861473;11403.372814494951;12163.81754273669;12481.750364992831;12677.17598356104;12725.539457612995 03:20:46 INFO - PROCESS | 28705 | |3;mootools.html;1384.5292600515822;1561.6017915431564;1594.8564629183375;1766.9310067409217;1925.1048262557917;9286.628534858606;9716.61133554657;9726.805463890718;10084.142847857922;10120.898791012087;9809.852852207205;9989;9989.250806189528;9992.100710936014;10008.29941904067;2482.826202165854;2502.124256510216;2502.3744063984004;2503.4242124311418;2509.7239303676674;2488.340589743719;2523.3313172009434;2531.6961964564184;2533.898644054236;2537.644729737838;2453.6932883389577;2474.7030356357263;2522.6342180383836;2532.0884481586613;2535.264773215765;2403.843750156243;2445.730969593343;2454.509098180371;2458.5820410530255;2468.691413573303;2404.903803847844;2426.0902161689364;2426.9757302426924;2429.161939130997;2460.458699086198;9136;9409.482478463682;9708.95145524275;9767.462789546573;9768.267379946461;5664.348599911022;5812.128180772876;5824.271966004249;5824.504917082053;5824.592278540504;3751.4560388743753;3786.3941769317053;3854.69162467002;3876.592957739453;3889.649931506178;1177.0759953436511;1179.9646010619695;1187.7980743273665;1191.4102519252938;1220.1337050694017;13671.79492307626;13760.380782864795;13785.241811700353;13808.792868106986;13813.378397972016;4820.830626218216;4996.075725990703;5029.245613158056;5043.167877300204;5060.5951523878;10768.030877221088;10817.891821081688;10820;10829.729256768485;10834.837477437844;5568.582356323292;5639.125935480007;5657.377688454267;5657.434256574392;5669.744861481243;4410.845620403335;4804.894874178958;5217.139172036572;5258.894822103536;5304.38999515053;4168.374743788396;4188.539260681323;4210.136921930997;4219.915601687949;4226.556211597738;1232.4515590562114;1234.5555599983998;1235.4934476864441;1235.7466719322517;1248.126311581878;891.9554022298859;970.3692599810039;1042.4058286776617;1067.6156583629886;1075.4622688655672;6468.320826313264;6605.471562275006;6647.135872336662;6654.73381064752;6681.866362672817;531.8032328038651;537.4169026606098;537.7875739083119;544.0533471759189;693.9140245515752;4565.726056436624;4640.211164102111;4686.437627484724;4764.571188593043;4770.76146192689;11459.656210313704;11728.94135529317;11824.408779560987;11846.703832404259;11850.644480665595;11683.649490515298;11688.415579221006;11724.58963936258;11787.410629468492;11804.70488237801;8778.385513014027;9083;9095.590698418455;9224.262059035127;9263.397879137834;6524.771632992823;6718.193816742022;6763.154605674291;6817.897731533932;6899.75850845218;10961.890381096087;11344.262622929484;11439.256448331165;11456.713582160513;11549.826752598885;9579.712608621752;11444.656660300205;11556.075513958695;11625.244359116969;11637.127215458706;7610.315071643357;8711.651533938571;8752.69365572202;8956.462612243025;8965.820683586162;9055.68305109318;9505.572249248939;9530.237580993642;9573.952130239582;9607.855882161914;8446.957765211135;8528.445651032664;8658.870116948377;8659.307255419677;8692.348073894356;8572.3999320047;8596;8630.180132887366;8633.30933525329;8652.048274689652;7656.846863062819;7680.731174408869;7684.615769211406;7698.191689872707;7720.498167619086;5498.560115190695;5774.451427114417;5803.129530570448;5840.2991641003355;5884.764609415575;5825.097109947796;5847.06446968483;5881.2942446906645;5897.67562784051;6019.277686677627 03:20:46 INFO - PROCESS | 28705 | |4;prototype.html;345.83572802918616;349.6852832450794;355.12461781708083;361.75400727505286;364.6317219608197;5317.388500322464;5373.731313434322;5443.401225865152;5477.726113694314;5490.341159060913;5444.475546846879;5447.536959358449;5478.863028424292;5478.890422191554;5482.616216864821;4314.633256173229;4329.328954012133;4336.522982471925;4338.783060846961;4347.804348804311;4091.365838295069;4197.937030944523;4324.286492728696;4324.524302326741;4332.84835030774;4263.360495925605;4267.231898258312;4285.9571404286025;4293.334533147367;4305.332673435622;4235.682323825726;4258.08451182994;4284.464441944757;4295.8066886989845;4312.986448184674;3697.9445308320396;3834.5398552173638;3842.53889533255;3870.651641352292;3875.689944804437;5132.794688212467;5164.302819119408;5184;5187.636865419422;5188.610854185913;4858.392700912386;4860.809101770089;4904.852854414374;4930.827421040246;4946.678465899741;5437.619366644337;5638.915416268759;5644.604877658566;5716.685582292972;5736.1682556029145;4137.317342638461;4147.191297696951;4159.750414975111;4167.4790651168605;4173.707840451169;5893.410658934115;5941.643501389887;5968.9255933931445;5977.701114944235;5997.520198384119;4125.133721918371;4178.937315940263;4219.43037689914;4265.25124698872;4268.676710219842;4223.619874211336;4264.594863487963;4264.72058382484;4264.978675106605;4272.807723652443;4776.901312698099;4874.4150701916;4886.731229782325;4912.361393018885;4919.278252611629;5565.749541270652;5704.3154821421695;5721.342045664718;5767.250257466587;5809.622374545641;1391.8538553451945;1412.8092707484564;1447.5223176351778;1453.382312517176;1454.6508837879044;938.6486850439742;947.8436058050482;948.4025064209504;958.9280803939732;976.1556253840376;4939.431965324034;4947.505249475023;4952.554270115635;4975.253711943165;5054.671446355975;5043.427851795611;5111.642185047085;5183.3261675981885;5258.421573626898;5270.5256526912;4784.569388754959;4901.534354236342;4997.825076122318;5007.499250075036;5028.572571331405;2752.6421565196397;2770.8639457822196;2779.66644002721;2782.5826126080847;2788.707185745508;5263.394709608444;5314.362276526842;5318.867028324245;5320.600954928318;5331.493508116722;4940.407151141886;5221.660592061504;5245.554127899171;5252.290940722954;5273.914759865445;5161.354830646169;5259.316288882421;5306.8407947761625;5326.7869285228935;5333.413294552139;5136.563392111712;5156.845294641167;5195;5197.740112994411;5258.631895767259;5097.7706003229205;5467.945320546903;5785.508231800176;5841.766329346779;5842.853928651648;6130.50955923534;6141.232345956755;6142.14010038586;6146.401935496714;6151.292601350723;4116.341385378325;4245.490541135084;4245.747504486122;4249.808758605932;4255.723377980421;5637.718114094361;5696.430356964271;5920.3783602722815;5926.288845338587;5952.761889524544;5714.571407144564;5723.656580605177;5730.455606717355;5738.1679656450415;5740.712964351682;5709.857253568694;5715.971125197504;5718.1708652246025;5727.799527016535;5741.770329186786;5491.2312276282155;5513.5037846594;5600.803971860965;5604.859878502907;5624.184493248538;5725.856853578527;5738.942610573841;5763.155790147112;5766.625169363978;5774.682392468455;5521.475459831309;5586.581006424453;5607.43925607436;5652.7173641318595;5673.262475878109 03:20:46 INFO - PROCESS | 28705 | |5;yui.html;766.4098644044086;833.3291700181352;856.3013147503367;902.3548163063409;926.4904302633552;16123;17330.913345433288;17360.479185624437;17388.73916891246;17390.30438782447;15645.139517326543;15883.523494295161;15885.84114158858;15921.681566368665;15954.84045159548;706.5266271598042;728.129884787679;731.9926800732004;845.3744229270327;858.5835869603237;734.772220611612;836.3309352517991;867.6876324523166;869.3393021303791;873.7247766953421;911.4667919267237;916.3906002508324;919.3610440743686;919.6413398774483;919.8574220995756;755.5957562703982;907.9909200908005;908.5366463103799;909.7725568607848;910.0399078971682;636.7516668499289;665.3246954341347;669.5246375073655;670.0752960913908;670.2392784189931;16198.676026479523;16208.594785130348;16234.837651623451;16250.106244156566;16304.592385190346;14937.253137343198;15805.288762005623;15896.84103158965;15907.443239486562;15949.362025518965;14139.64650883736;14308.356123974447;14341.641458963504;14342.92828535861;14556.272186390637;4593.311003349491;4649.883752906205;4701.200795864711;4744.83393081244;4786.7845946932475;76091.47817043628;76430.6178469104;76642;76673.61663191704;79042.60478697627;12152.088593355356;12297.754044919231;12515.56195533152;12527.686807829878;12614.747705045847;22978;23026.309210723706;23089.307320780405;23184.768152318262;23219.535609288057;8585.356098292528;8660.826783464421;8861.202491775772;8959.41763785352;9062.229710474552;4689.554492323224;4708.128996135726;4752.215884379108;5104.795808167632;5107.8723031923755;3739.8878033659034;3847.788371639531;3853.788041657736;3856.5179352580926;3863.6522712955407;708.4297140801704;708.5040471669852;713.393615426883;715.3347386930205;734.8346622010005;660.9173853268342;677.383580941341;737.4358615659025;746.8917007033949;748.4386709967524;10039.397636141708;10063.64777232808;10156.23828212887;10230.28388012832;10256.12822910061;686.739039165114;703.3529153179087;710.2719712294939;718.7161071376777;733.2374330696016;4456.64346852251;4650.093231819763;4650.162970665245;4676.532346765296;4716.457607375127;113529;114881;115893.4205328968;116579.41710291564;119305;95080;97111;97993;98504;101455;86713;87705;88378.55810721034;89511.99999999869;89637;9464.290178236522;9574.32979691415;9629.374090684083;9638.325317227727;9642;46923.76538117424;47164.292535611305;51080.999999998516;51661.483385165666;54477.72761136169;73282;73987.63006184934;75770.62114689391;76591.61704191443;76795;13268.867311326763;14477.638059048608;14518.637034074232;14706.705865882837;14792.704145916807;13221.735565288447;15998.200089995686;16250.674986499967;16597.41909033178;16808.915955420143;11696.941515292368;13316;14380.209088499814;14443.3500492476;15784;14064.718705626035;14781.408743650134;14798.653037639366;15287.312070956612;15463.84536154669;15156.393744250106;15264.771028434805;15305.46430874914;15470.922645386701;15507.379704811681;11776.882231177578;11985.760284794429;12508.499660013498;12549.93725031369;12616.36918154107;12511.186772859735;12757.936210318889;12761.93619031899;13033.348332583522;13074.411651475897 03:20:46 INFO - PROCESS | 28705 | __end_tp_report 03:20:46 INFO - PROCESS | 28705 | __start_cc_report 03:20:46 INFO - PROCESS | 28705 | _x_x_mozilla_cycle_collect,871 03:20:46 INFO - PROCESS | 28705 | __end_cc_report 03:20:46 INFO - PROCESS | 28705 | __startTimestamp1468664446538__endTimestamp 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | ------- Summary: start ------- 03:20:46 INFO - PROCESS | 28705 | Number of tests: 6 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#0] dojo.html Cycles:165 Average:5556.72 Median:5763.60 stddev:609.82 (10.6%) stddev-sans-first:586.78 03:20:46 INFO - PROCESS | 28705 | Values: 3357.7 3362.9 3363.9 3389.3 3405.9 5539.4 5580.8 5624.0 5625.5 5626.4 5562.6 5604.1 5616.1 5621.4 5636.0 4960.0 5003.3 5094.7 5097.0 5140.4 5047.5 5098.2 5101.3 5108.9 5109.9 5016.5 5026.0 5026.5 5057.2 5106.7 5183.3 5192.2 5203.3 5204.1 5238.7 4914.0 4993.4 5049.2 5084.1 5097.4 5451.2 5461.7 5471.8 5518.3 5524.1 6014.1 6023.4 6033.3 6037.5 6040.1 5918.1 5972.8 5979.8 6008.1 6061.2 5588.7 5598.0 5638.7 5644.3 5653.6 5866.1 6106.5 6125.4 6127.4 6135.1 5756.4 5787.2 5817.2 5896.3 5904.6 5948.9 5953.0 5957.5 5986.5 5992.9 5712.9 5885.9 5924.5 5936.6 5941.3 5938.6 6011.9 6019.7 6025.9 6054.0 4617.1 4635.8 4636.5 4640.5 4662.0 4035.4 4052.8 4105.2 4142.0 4156.9 5763.6 5784.8 5788.2 5790.2 5808.9 6014.8 6045.8 6050.9 6068.3 6069.4 5540.0 5614.8 5645.2 5688.3 5692.7 5173.7 5175.1 5183.3 5188.3 5188.5 6230.2 6233.7 6240.9 6246.0 6251.3 5813.7 5926.0 5926.6 5987.0 6035.5 6214.5 6249.7 6254.6 6265.9 6279.1 5908.7 5914.1 5921.7 5926.3 5954.1 5791.4 5864.5 5881.0 5914.7 5967.1 5774.4 5776.2 5807.7 5808.3 5821.3 5637.8 5754.2 5792.4 5817.2 5824.4 5652.8 5692.5 5709.5 5764.3 5765.7 5846.5 5855.7 5892.1 5898.8 5900.1 5512.3 5635.2 5741.7 5748.5 5750.2 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#1] ext.html Cycles:180 Average:70065.95 Median:41502.00 stddev:148338.25 (357.4%) stddev-sans-first:148662.68 03:20:46 INFO - PROCESS | 28705 | Values: 594.0 644.2 646.4 655.7 660.3 32777.8 35763.5 44980.0 45888.3 46042.8 45533.3 45809.8 45956.8 46011.3 46054.5 8931.2 9073.1 9079.6 9089.1 9093.1 8322.9 10627.8 10876.6 10883.9 10905.7 10788.1 10852.2 10878.5 11161.6 11183.6 8291.2 10791.6 10936.6 11020.6 11038.0 10537.1 10909.1 10929.2 10930.9 10933.2 44400.1 45220.3 45303.0 45347.3 45352.0 3680.7 3825.2 4420.1 4518.5 4527.3 34064.1 34080.3 34320.8 34513.5 36049.0 4579.4 4662.9 4668.1 4771.0 4841.8 378750.0 382671.0 385045.0 385708.0 386250.0 39471.2 69451.7 70650.0 70682.6 70770.6 39484.4 41494.0 41510.0 41527.4 41531.8 16259.8 16267.4 16334.3 16339.6 16421.9 13098.3 13876.3 14122.8 14222.9 14317.0 9324.4 9404.6 9405.8 9418.8 9470.4 3544.9 3582.3 3618.8 3619.1 3640.6 1036.3 1050.0 1128.4 1130.7 1179.2 32943.3 34333.3 34363.0 34736.0 34972.1 1161.0 1194.4 1214.3 1227.1 1237.7 17993.8 18107.6 18344.0 18399.6 18478.9 675290.0 676381.0 679613.0 681008.0 682394.0 63552.7 65016.3 65207.7 65336.3 65397.3 1341.9 1447.8 1462.9 1500.7 1504.5 33313.5 34735.3 35307.6 35550.3 35705.4 54782.5 60752.7 62759.4 62779.0 67613.7 559806.0 560529.0 565710.0 566562.0 567157.0 40137.8 48429.5 50114.2 50728.7 51273.2 50949.5 51863.5 52012.5 52872.0 53212.5 43530.1 43658.0 43694.0 43942.1 44849.6 42866.6 44111.8 44132.8 44987.0 45267.8 43330.4 43762.0 44062.0 44502.3 44592.8 38473.8 38631.2 38819.0 39223.8 39596.0 29003.9 29820.0 30056.0 30482.8 30617.4 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#2] jquery.html Cycles:180 Average:31627.58 Median:2763.78 stddev:87233.29 (3156.3%) stddev-sans-first:87446.54 03:20:46 INFO - PROCESS | 28705 | Values: 423.6 434.4 437.1 438.2 446.0 19024.7 19412.5 20454.1 20454.9 20552.3 18713.2 19495.9 20091.0 20141.9 20203.3 5696.3 5861.6 5911.9 5914.1 5924.4 5624.7 5755.1 5791.1 5841.2 5846.5 5712.3 5801.6 5802.2 5810.9 5822.9 5643.7 5745.0 5792.5 5796.2 5798.4 5198.6 5217.5 5220.5 5225.7 5231.7 22057.8 22887.0 23311.8 23312.3 23369.8 2673.1 2680.7 2752.9 2774.7 3105.0 14474.1 14588.6 14769.9 14985.4 15434.8 1825.0 2096.4 2151.7 2166.4 2195.0 86635.6 94797.0 95670.5 96986.1 99832.5 18074.5 18796.8 18978.3 19019.3 19274.9 33235.8 33384.5 33549.0 33681.5 33684.0 10356.0 10688.3 10799.9 10815.8 10930.2 8838.4 8857.9 8869.3 8903.5 9093.7 9085.8 9179.4 9254.3 9351.2 9540.8 3485.4 3520.5 3545.1 3591.9 3738.5 877.5 955.6 1019.4 1084.0 1124.5 18141.7 19173.7 19462.9 19485.7 20079.8 1060.1 1075.9 1105.6 1114.5 1125.9 10821.8 11023.0 11079.3 11105.6 11163.7 514476.0 516919.0 536684.0 538417.0 544376.0 68765.3 82528.0 83085.6 99521.0 103316.0 1012.5 1014.5 1026.2 1044.8 1045.4 17466.8 17613.9 17716.0 17736.2 17962.7 40295.6 40703.2 40802.6 42113.4 42167.6 58886.0 58932.7 59176.4 59381.0 59498.4 8604.2 8813.8 8884.9 8936.0 9217.0 9937.5 12942.0 13571.9 13795.5 13824.3 11560.2 11798.0 11849.1 11988.8 12017.3 11740.0 11839.5 11885.8 11947.6 11966.7 11877.5 12089.6 12139.7 12408.9 12609.6 7880.5 8359.5 8821.5 8973.5 9100.8 11403.4 12163.8 12481.8 12677.2 12725.5 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#3] mootools.html Cycles:180 Average:6364.81 Median:4787.83 stddev:3671.89 (76.7%) stddev-sans-first:3663.11 03:20:46 INFO - PROCESS | 28705 | Values: 1384.5 1561.6 1594.9 1766.9 1925.1 9286.6 9716.6 9726.8 10084.1 10120.9 9809.9 9989.0 9989.3 9992.1 10008.3 2482.8 2502.1 2502.4 2503.4 2509.7 2488.3 2523.3 2531.7 2533.9 2537.6 2453.7 2474.7 2522.6 2532.1 2535.3 2403.8 2445.7 2454.5 2458.6 2468.7 2404.9 2426.1 2427.0 2429.2 2460.5 9136.0 9409.5 9709.0 9767.5 9768.3 5664.3 5812.1 5824.3 5824.5 5824.6 3751.5 3786.4 3854.7 3876.6 3889.6 1177.1 1180.0 1187.8 1191.4 1220.1 13671.8 13760.4 13785.2 13808.8 13813.4 4820.8 4996.1 5029.2 5043.2 5060.6 10768.0 10817.9 10820.0 10829.7 10834.8 5568.6 5639.1 5657.4 5657.4 5669.7 4410.8 4804.9 5217.1 5258.9 5304.4 4168.4 4188.5 4210.1 4219.9 4226.6 1232.5 1234.6 1235.5 1235.7 1248.1 892.0 970.4 1042.4 1067.6 1075.5 6468.3 6605.5 6647.1 6654.7 6681.9 531.8 537.4 537.8 544.1 693.9 4565.7 4640.2 4686.4 4764.6 4770.8 11459.7 11728.9 11824.4 11846.7 11850.6 11683.6 11688.4 11724.6 11787.4 11804.7 8778.4 9083.0 9095.6 9224.3 9263.4 6524.8 6718.2 6763.2 6817.9 6899.8 10961.9 11344.3 11439.3 11456.7 11549.8 9579.7 11444.7 11556.1 11625.2 11637.1 7610.3 8711.7 8752.7 8956.5 8965.8 9055.7 9505.6 9530.2 9574.0 9607.9 8447.0 8528.4 8658.9 8659.3 8692.3 8572.4 8596.0 8630.2 8633.3 8652.0 7656.8 7680.7 7684.6 7698.2 7720.5 5498.6 5774.5 5803.1 5840.3 5884.8 5825.1 5847.1 5881.3 5897.7 6019.3 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#4] prototype.html Cycles:180 Average:4680.19 Median:5185.82 stddev:1350.25 (26.0%) stddev-sans-first:1314.26 03:20:46 INFO - PROCESS | 28705 | Values: 345.8 349.7 355.1 361.8 364.6 5317.4 5373.7 5443.4 5477.7 5490.3 5444.5 5447.5 5478.9 5478.9 5482.6 4314.6 4329.3 4336.5 4338.8 4347.8 4091.4 4197.9 4324.3 4324.5 4332.8 4263.4 4267.2 4286.0 4293.3 4305.3 4235.7 4258.1 4284.5 4295.8 4313.0 3697.9 3834.5 3842.5 3870.7 3875.7 5132.8 5164.3 5184.0 5187.6 5188.6 4858.4 4860.8 4904.9 4930.8 4946.7 5437.6 5638.9 5644.6 5716.7 5736.2 4137.3 4147.2 4159.8 4167.5 4173.7 5893.4 5941.6 5968.9 5977.7 5997.5 4125.1 4178.9 4219.4 4265.3 4268.7 4223.6 4264.6 4264.7 4265.0 4272.8 4776.9 4874.4 4886.7 4912.4 4919.3 5565.7 5704.3 5721.3 5767.3 5809.6 1391.9 1412.8 1447.5 1453.4 1454.7 938.6 947.8 948.4 958.9 976.2 4939.4 4947.5 4952.6 4975.3 5054.7 5043.4 5111.6 5183.3 5258.4 5270.5 4784.6 4901.5 4997.8 5007.5 5028.6 2752.6 2770.9 2779.7 2782.6 2788.7 5263.4 5314.4 5318.9 5320.6 5331.5 4940.4 5221.7 5245.6 5252.3 5273.9 5161.4 5259.3 5306.8 5326.8 5333.4 5136.6 5156.8 5195.0 5197.7 5258.6 5097.8 5467.9 5785.5 5841.8 5842.9 6130.5 6141.2 6142.1 6146.4 6151.3 4116.3 4245.5 4245.7 4249.8 4255.7 5637.7 5696.4 5920.4 5926.3 5952.8 5714.6 5723.7 5730.5 5738.2 5740.7 5709.9 5716.0 5718.2 5727.8 5741.8 5491.2 5513.5 5600.8 5604.9 5624.2 5725.9 5738.9 5763.2 5766.6 5774.7 5521.5 5586.6 5607.4 5652.7 5673.3 03:20:46 INFO - PROCESS | 28705 | 03:20:46 INFO - PROCESS | 28705 | [#5] yui.html Cycles:180 Average:21466.71 Median:4663.35 stddev:29977.59 (642.8%) stddev-sans-first:30021.39 03:20:46 INFO - PROCESS | 28705 | Values: 766.4 833.3 856.3 902.4 926.5 16123.0 17330.9 17360.5 17388.7 17390.3 15645.1 15883.5 15885.8 15921.7 15954.8 706.5 728.1 732.0 845.4 858.6 734.8 836.3 867.7 869.3 873.7 911.5 916.4 919.4 919.6 919.9 755.6 908.0 908.5 909.8 910.0 636.8 665.3 669.5 670.1 670.2 16198.7 16208.6 16234.8 16250.1 16304.6 14937.3 15805.3 15896.8 15907.4 15949.4 14139.6 14308.4 14341.6 14342.9 14556.3 4593.3 4649.9 4701.2 4744.8 4786.8 76091.5 76430.6 76642.0 76673.6 79042.6 12152.1 12297.8 12515.6 12527.7 12614.7 22978.0 23026.3 23089.3 23184.8 23219.5 8585.4 8660.8 8861.2 8959.4 9062.2 4689.6 4708.1 4752.2 5104.8 5107.9 3739.9 3847.8 3853.8 3856.5 3863.7 708.4 708.5 713.4 715.3 734.8 660.9 677.4 737.4 746.9 748.4 10039.4 10063.6 10156.2 10230.3 10256.1 686.7 703.4 710.3 718.7 733.2 4456.6 4650.1 4650.2 4676.5 4716.5 113529.0 114881.0 115893.4 116579.4 119305.0 95080.0 97111.0 97993.0 98504.0 101455.0 86713.0 87705.0 88378.6 89512.0 89637.0 9464.3 9574.3 9629.4 9638.3 9642.0 46923.8 47164.3 51081.0 51661.5 54477.7 73282.0 73987.6 75770.6 76591.6 76795.0 13268.9 14477.6 14518.6 14706.7 14792.7 13221.7 15998.2 16250.7 16597.4 16808.9 11696.9 13316.0 14380.2 14443.4 15784.0 14064.7 14781.4 14798.7 15287.3 15463.8 15156.4 15264.8 15305.5 15470.9 15507.4 11776.9 11985.8 12508.5 12549.9 12616.4 12511.2 12757.9 12761.9 13033.3 13074.4 03:20:46 INFO - PROCESS | 28705 | -------- Summary: end -------- 03:20:46 INFO - PROCESS | 28705 | 03:20:47 INFO - TEST-INFO | 28705: exit 0 03:20:47 INFO - TEST-OK | dromaeo_css | took 1113847ms 03:20:47 INFO - TEST-START | kraken 03:20:47 INFO - operating with platform_type : linux_ 03:20:47 INFO - Initialising browser for kraken test... 03:20:47 INFO - TEST-INFO | started process 28896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qHbD8/profile http://localhost:59723/getInfo.html) 03:20:51 INFO - PROCESS | 28896 | __metrics Screen width/height:1600/1200 03:20:51 INFO - PROCESS | 28896 | colorDepth:24 03:20:51 INFO - PROCESS | 28896 | Browser inner width/height: 1024/697 03:20:51 INFO - PROCESS | 28896 | __metrics 03:20:52 INFO - PROCESS | 28896 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:20:52 ERROR - PROCESS | 28896 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:20:53 INFO - TEST-INFO | 28896: exit 0 03:20:53 INFO - Browser initialized. 03:20:53 INFO - Running cycle 1/1 for kraken test... 03:20:53 INFO - TEST-INFO | started process 28992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_qHbD8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:05 INFO - PROCESS | 28992 | RSS: Main: 145272832 03:21:05 INFO - PROCESS | 28992 | 03:21:07 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:08 INFO - PROCESS | 28992 | RSS: Main: 194990080 03:21:08 INFO - PROCESS | 28992 | 03:21:11 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-dft) 03:21:11 INFO - PROCESS | 28992 | RSS: Main: 192622592 03:21:11 INFO - PROCESS | 28992 | 03:21:14 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-fft) 03:21:15 INFO - PROCESS | 28992 | RSS: Main: 279187456 03:21:15 INFO - PROCESS | 28992 | 03:21:17 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59723/tests/kraken/driver.html?testName=audio-oscillator) 03:21:18 INFO - PROCESS | 28992 | RSS: Main: 187805696 03:21:18 INFO - PROCESS | 28992 | 03:21:20 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:20 INFO - PROCESS | 28992 | RSS: Main: 188964864 03:21:20 INFO - PROCESS | 28992 | 03:21:23 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:24 INFO - PROCESS | 28992 | RSS: Main: 223076352 03:21:24 INFO - PROCESS | 28992 | 03:21:27 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59723/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:28 INFO - PROCESS | 28992 | RSS: Main: 221593600 03:21:28 INFO - PROCESS | 28992 | 03:21:31 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59723/tests/kraken/driver.html?testName=json-parse-financial) 03:21:31 INFO - PROCESS | 28992 | RSS: Main: 221388800 03:21:31 INFO - PROCESS | 28992 | 03:21:33 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59723/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:33 INFO - PROCESS | 28992 | RSS: Main: 200028160 03:21:33 INFO - PROCESS | 28992 | 03:21:35 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:36 INFO - PROCESS | 28992 | RSS: Main: 201961472 03:21:36 INFO - PROCESS | 28992 | 03:21:38 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:38 INFO - PROCESS | 28992 | RSS: Main: 208834560 03:21:38 INFO - PROCESS | 28992 | 03:21:41 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:21:41 INFO - PROCESS | 28992 | RSS: Main: 213622784 03:21:41 INFO - PROCESS | 28992 | 03:21:44 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:21:45 INFO - PROCESS | 28992 | RSS: Main: 211464192 03:21:45 INFO - PROCESS | 28992 | 03:21:46 INFO - PROCESS | 28992 | Cycle 1(1): loaded http://localhost:59723/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59723/tests/kraken/driver.html?testName=ai-astar) 03:21:47 INFO - PROCESS | 28992 | RSS: Main: 253816832 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | __start_tp_report 03:21:47 INFO - PROCESS | 28992 | _x_x_mozilla_page_load 03:21:47 INFO - PROCESS | 28992 | _x_x_mozilla_page_load_details 03:21:47 INFO - PROCESS | 28992 | |i|pagename|runs| 03:21:47 INFO - PROCESS | 28992 | |0;ai-astar;111;105;110;113;111;113;111;111;111;111 03:21:47 INFO - PROCESS | 28992 | |1;audio-beat-detection;161;125;124;176;130;131;151;128;161;126 03:21:47 INFO - PROCESS | 28992 | |2;audio-dft;162;162;162;161;162;163;163;161;162;161 03:21:47 INFO - PROCESS | 28992 | |3;audio-fft;75;75;75;118;76;77;75;75;98;75 03:21:47 INFO - PROCESS | 28992 | |4;audio-oscillator;92;84;119;84;85;84;113;85;85;133 03:21:47 INFO - PROCESS | 28992 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;116;117;117 03:21:47 INFO - PROCESS | 28992 | |6;imaging-darkroom;146;147;146;146;147;146;146;146;146;146 03:21:47 INFO - PROCESS | 28992 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 03:21:47 INFO - PROCESS | 28992 | |8;json-parse-financial;50;51;58;52;52;52;51;52;51;52 03:21:47 INFO - PROCESS | 28992 | |9;json-stringify-tinderbox;60;58;60;60;59;58;59;59;59;59 03:21:47 INFO - PROCESS | 28992 | |10;stanford-crypto-aes;77;76;82;78;77;77;77;78;121;78 03:21:47 INFO - PROCESS | 28992 | |11;stanford-crypto-ccm;124;117;118;116;117;124;123;125;122;119 03:21:47 INFO - PROCESS | 28992 | |12;stanford-crypto-pbkdf2;158;157;158;154;156;156;155;155;155;155 03:21:47 INFO - PROCESS | 28992 | |13;stanford-crypto-sha256-iterative;63;63;63;63;64;61;65;61;61;60 03:21:47 INFO - PROCESS | 28992 | __end_tp_report 03:21:47 INFO - PROCESS | 28992 | __start_cc_report 03:21:47 INFO - PROCESS | 28992 | _x_x_mozilla_cycle_collect,1631 03:21:47 INFO - PROCESS | 28992 | __end_cc_report 03:21:47 INFO - PROCESS | 28992 | __startTimestamp1468664507043__endTimestamp 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | ------- Summary: start ------- 03:21:47 INFO - PROCESS | 28992 | Number of tests: 14 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.21 (2.0%) stddev-sans-first:2.35 03:21:47 INFO - PROCESS | 28992 | Values: 111.0 105.0 110.0 113.0 111.0 113.0 111.0 111.0 111.0 111.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:141.00 stddev:19.10 (13.5%) stddev-sans-first:18.88 03:21:47 INFO - PROCESS | 28992 | Values: 161.0 125.0 124.0 176.0 130.0 131.0 151.0 128.0 161.0 126.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:21:47 INFO - PROCESS | 28992 | Values: 162.0 162.0 162.0 161.0 162.0 163.0 163.0 161.0 162.0 161.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:14.56 (19.4%) stddev-sans-first:15.22 03:21:47 INFO - PROCESS | 28992 | Values: 75.0 75.0 75.0 118.0 76.0 77.0 75.0 75.0 98.0 75.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:84.50 stddev:18.25 (21.6%) stddev-sans-first:19.28 03:21:47 INFO - PROCESS | 28992 | Values: 92.0 84.0 119.0 84.0 85.0 84.0 113.0 85.0 85.0 133.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:21:47 INFO - PROCESS | 28992 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:21:47 INFO - PROCESS | 28992 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:21:47 INFO - PROCESS | 28992 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.18 (4.2%) stddev-sans-first:2.18 03:21:47 INFO - PROCESS | 28992 | Values: 50.0 51.0 58.0 52.0 52.0 52.0 51.0 52.0 51.0 52.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 03:21:47 INFO - PROCESS | 28992 | Values: 60.0 58.0 60.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:77.50 stddev:13.76 (17.8%) stddev-sans-first:14.47 03:21:47 INFO - PROCESS | 28992 | Values: 77.0 76.0 82.0 78.0 77.0 77.0 77.0 78.0 121.0 78.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#11] stanford-crypto-ccm Cycles:10 Average:120.50 Median:122.50 stddev:3.44 (2.8%) stddev-sans-first:3.41 03:21:47 INFO - PROCESS | 28992 | Values: 124.0 117.0 118.0 116.0 117.0 124.0 123.0 125.0 122.0 119.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:1.37 (0.9%) stddev-sans-first:1.22 03:21:47 INFO - PROCESS | 28992 | Values: 158.0 157.0 158.0 154.0 156.0 156.0 155.0 155.0 155.0 155.0 03:21:47 INFO - PROCESS | 28992 | 03:21:47 INFO - PROCESS | 28992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.58 (2.5%) stddev-sans-first:1.66 03:21:47 INFO - PROCESS | 28992 | Values: 63.0 63.0 63.0 63.0 64.0 61.0 65.0 61.0 61.0 60.0 03:21:47 INFO - PROCESS | 28992 | -------- Summary: end -------- 03:21:47 INFO - PROCESS | 28992 | 03:21:48 INFO - TEST-INFO | 28992: exit 0 03:21:48 INFO - TEST-OK | kraken | took 60745ms 03:21:48 INFO - SUITE-END | took 1174s 03:21:48 INFO - Completed test suite (00:19:34) 03:21:48 INFO - javascript benchmark 03:21:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.664233576642, 3362.899113026607, 3363.8822641207553, 3389.271306669066, 3405.9148521286966, 5539.390667026629, 5580.804671836487, 5624.0, 5625.521830644395, 5626.437356264381, 5562.554995600352, 5604.103343465046, 5616.0629764336545, 5621.409751976045, 5636.0, 4960.032793605248, 5003.324551185598, 5094.694318340893, 5096.974515127428, 5140.434552199274, 5047.47001564836, 5098.209777484496, 5101.260317253996, 5108.8978220435565, 5109.923351149736, 5016.47327030662, 5025.994801039788, 5026.497350264981, 5057.216131499624, 5106.693598384109, 5183.326167598226, 5192.247124166994, 5203.349581302337, 5204.089284375257, 5238.711870847121, 4914.0, 4993.350864387643, 5049.192129259301, 5084.110280700863, 5097.388313402378, 5451.236826844245, 5461.69960652164, 5471.753771080271, 5518.255035570187, 5524.088525393306, 6014.097885317194, 6023.397660233985, 6033.276006879202, 6037.4566289033755, 6040.063790112539, 5918.082697181943, 5972.790952316648, 5979.790707325266, 6008.098785182257, 6061.242344706911, 5588.6646801192055, 5597.992361374951, 5638.689872056994, 5644.322681278273, 5653.604247702621, 5866.1494083357675, 6106.452062707889, 6125.448709616156, 6127.387261273926, 6135.091826699848, 5756.395578464285, 5787.189793428924, 5817.214676018683, 5896.292444906639, 5904.645721256738, 5948.940510594925, 5952.970235148797, 5957.523398128139, 5986.461218490357, 5992.880142397127, 5712.857178570569, 5885.911711324334, 5924.496417804535, 5936.614120082181, 5941.287045554561, 5938.61399009063, 6011.879762404727, 6019.729112189962, 6025.9397406026255, 6054.0, 4617.0996655651825, 4635.814567417333, 4636.536346365404, 4640.535946405333, 4661.95338046622, 4035.435039094529, 4052.8378864845076, 4105.220008198433, 4141.958580414157, 4156.937645935313, 5763.596548241583, 5784.768609255582, 5788.247527821356, 5790.247267855152, 5808.854778630483, 6014.849628759316, 6045.818625441244, 6050.878982420327, 6068.302145253352, 6069.423404776539, 5540.0, 5614.775408983676, 5645.23789288449, 5688.288963879515, 5692.743826527816, 5173.663711858792, 5175.094358487249, 5183.2743415921805, 5188.273641690166, 5188.507091826271, 6230.158928544589, 6233.688315584202, 6240.906386404207, 6246.0, 6251.28110267316, 5813.651180929158, 5925.962956482685, 5926.555508336805, 5987.0, 6035.456808887046, 6214.472537053182, 6249.718762655601, 6254.562180647311, 6265.937340626535, 6279.058141278845, 5908.711703025682, 5914.142449344735, 5921.703914804329, 5926.318473375617, 5954.136650185786, 5791.449812267828, 5864.501517371071, 5881.0, 5914.728333408338, 5967.075103358986, 5774.422557744192, 5776.249087618583, 5807.651540907559, 5808.30300363959, 5821.330546987151, 5637.774489020393, 5754.194412782297, 5792.4497172768515, 5817.156512305776, 5824.417558244311, 5652.830415087554, 5692.48767610917, 5709.54323654115, 5764.250647415809, 5765.682887441231, 5846.532277417881, 5855.736491857791, 5892.1161825726485, 5898.764049437975, 5900.144479050427, 5512.3385193777, 5635.239242702182, 5741.712914354349, 5748.48263656273, 5750.223719797774], "value": 5517.640300003049, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9821805345838, 644.1883227133812, 646.3891622416817, 655.7049327802489, 660.270401206667, 32777.836110819444, 35763.46354804677, 44980.0, 45888.31167532481, 46042.769786151104, 45533.31700024502, 45809.77095114528, 45956.77021614896, 46011.30983035249, 46054.539454605445, 8931.240844528207, 9073.092690730908, 9079.591418386188, 9089.091090890925, 9093.136152065576, 8322.875156872651, 10627.84058239127, 10876.564937402494, 10883.891161088406, 10905.727356816104, 10788.08301294391, 10852.186086043539, 10878.510467029002, 11161.553537858517, 11183.552657893715, 8291.170882911661, 10791.5683372665, 10936.56253749853, 11020.559177632886, 11038.006579407851, 10537.104346130589, 10909.127269818475, 10929.180311476592, 10930.945345273223, 10933.234673572853, 44400.111997759865, 45220.32169517427, 45303.0, 45347.319790203175, 45352.0, 3680.723945704056, 3825.2158307547165, 4420.138073075719, 4518.502964673883, 4527.253003254459, 34064.148396290046, 34080.31839363224, 34320.82839585786, 34513.48229776556, 36049.0, 4579.358889755437, 4662.930056049162, 4668.11305851887, 4770.952290477086, 4841.782119804618, 378750.0, 382671.0, 385045.0, 385708.0, 386250.0, 39471.210575788326, 69451.65274173698, 70650.0, 70682.64658676674, 70770.64614676894, 39484.407733884014, 41494.0, 41510.0, 41527.37708934368, 41531.792341038104, 16259.756103658454, 16267.430639927547, 16334.264958076916, 16339.591510212102, 16421.91789041047, 13098.345082745825, 13876.306184690726, 14122.788158177636, 14222.928885355714, 14316.997810153398, 9324.440533568008, 9404.576794044284, 9405.76485587852, 9418.764530886645, 9470.384425012353, 3544.929101417957, 3582.2656355447593, 3618.78770611848, 3619.0771353305267, 3640.6359364063383, 1036.300497164411, 1049.9997504753458, 1128.3737525673166, 1130.711668524521, 1179.1804695736553, 32943.34113317768, 34333.313333733684, 34363.0, 34736.0, 34972.12569685778, 1160.9941950290363, 1194.3848917807336, 1214.2957084890743, 1227.0551675210038, 1237.665830225834, 17993.820061799477, 18107.637847242982, 18344.0, 18399.632007360047, 18478.907605462155, 675290.0, 676381.0, 679613.0, 681008.0, 682394.0, 63552.68223658945, 65016.34983650103, 65207.67396162989, 65336.34663653398, 65397.34602654008, 1341.8926485881107, 1447.8262608487048, 1462.8829693624484, 1500.7373709600995, 1504.4809540708657, 33313.500297496044, 34735.30529389449, 35307.646923531465, 35550.28899421945, 35705.362050871394, 54782.45217547933, 60752.69623651853, 62759.37240627535, 62779.0, 67613.66193169003, 559806.0, 560529.0, 565710.0, 566562.0, 567157.0, 40137.799311004426, 48429.5157048425, 50114.24828627647, 50728.746356267984, 51273.23090153576, 50949.49050509447, 51863.481365185864, 52012.47987520076, 52872.0, 53212.46787532075, 43530.12939741251, 43658.0, 43694.0, 43942.13562338215, 44849.55150448584, 42866.57133428626, 44111.77944110259, 44132.779336103114, 44987.0, 45267.77366113148, 43330.35004474998, 43762.0, 44062.0, 44502.332465012405, 44592.77703611461, 38473.807630961666, 38631.227375452894, 38819.0, 39223.80388098041, 39596.0, 29003.854980724962, 29820.0, 30056.0, 30482.84758576193, 30617.387652247275], "value": 21190.210076676587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.6187431311819, 434.40107436694274, 437.0858958030834, 438.2243429130438, 445.98439054633076, 19024.71462928057, 19412.51468713283, 20454.07956641951, 20454.89772551139, 20552.280670176548, 18713.157907894143, 19495.902520487412, 20091.0, 20141.899290503527, 20203.292884749037, 5696.25948626679, 5861.560382971273, 5911.940880591182, 5914.053751399777, 5924.407559244084, 5624.71876406178, 5755.079187330028, 5791.0734282514595, 5841.182234487175, 5846.532277417797, 5712.285964254468, 5801.593888427812, 5802.245708057968, 5810.854728631776, 5822.912656310159, 5643.68959707216, 5745.0, 5792.507636850831, 5796.217510636052, 5798.42015798421, 5198.610104242197, 5217.530422261977, 5220.530152286313, 5225.712585807779, 5231.686098834044, 22057.779422205735, 22887.0, 23311.7668823313, 23312.3006309811, 23369.766302336928, 2673.131232349494, 2680.7453291937236, 2752.862356882148, 2774.694783573805, 3104.9534256986162, 14474.131552106906, 14588.562343129723, 14769.852301477062, 14985.400583976629, 15434.768478472832, 1824.954376140594, 2096.3920463065847, 2151.741790985076, 2166.4150679316654, 2194.967075493869, 86635.56682216612, 94797.0, 95670.52164739202, 96986.09041728759, 99832.50083749607, 18074.457766267034, 18796.812031879505, 18978.335758248395, 19019.334323298895, 19274.903625481784, 33235.83382083123, 33384.49923251153, 33549.0, 33681.49477757836, 33684.0, 10356.0, 10688.305260158066, 10799.866014068566, 10815.83776243357, 10930.180236482296, 8838.381313308135, 8857.867131993025, 8869.290456763443, 8903.465792052497, 9093.681721139728, 9085.77285567866, 9179.357444978921, 9254.305927055364, 9351.18414016782, 9540.761480962892, 3485.4074807282823, 3520.4543295789194, 3545.1137215696076, 3591.9102022449647, 3738.513993180869, 877.5349064995562, 955.5699935029264, 1019.3883669798062, 1083.967480975572, 1124.4771181400524, 18141.7278740819, 19173.712394313818, 19462.902685486482, 19485.707714384294, 20079.799202008086, 1060.1095080132725, 1075.9408232547128, 1105.578782466396, 1114.5318966034285, 1125.9493322800495, 10821.783564328669, 11023.0, 11079.279846809932, 11105.555777768799, 11163.72090697739, 514476.0, 516919.0, 536684.0, 538417.0, 544376.0, 68765.31234687589, 82528.0, 83085.58457207796, 99521.0, 103316.0, 1012.4583347908981, 1014.5028935821394, 1026.2098184397971, 1044.796264728386, 1045.4041196517912, 17466.777325587595, 17613.911930440267, 17716.0, 17736.201870915582, 17962.730559041887, 40295.59704403036, 40703.18593628052, 40802.591974081064, 42113.36829947615, 42167.57832421759, 58886.0, 58932.705336473045, 59176.408235917086, 59381.0, 59498.40501594928, 8604.182602652738, 8813.779655508664, 8884.911150888409, 8935.955320223617, 9217.0, 9937.453440060866, 12942.0, 13571.864281357455, 13795.517156899461, 13824.308784560531, 11560.24858384236, 11798.0, 11849.111316651113, 11988.76022479528, 12017.339046352534, 11740.002099821611, 11839.526418943491, 11885.762284754084, 11947.641570752892, 11966.700832479257, 11877.46551405206, 12089.637310880687, 12139.696507587381, 12408.937955310166, 12609.558665446666, 7880.527168369917, 8359.540225287425, 8821.514816685143, 8973.506457144658, 9100.771395861473, 11403.372814494951, 12163.81754273669, 12481.750364992831, 12677.17598356104, 12725.539457612995], "value": 10383.483453912326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.5292600515822, 1561.6017915431564, 1594.8564629183375, 1766.9310067409217, 1925.1048262557917, 9286.628534858606, 9716.61133554657, 9726.805463890718, 10084.142847857922, 10120.898791012087, 9809.852852207205, 9989.0, 9989.250806189528, 9992.100710936014, 10008.29941904067, 2482.826202165854, 2502.124256510216, 2502.3744063984004, 2503.4242124311418, 2509.7239303676674, 2488.340589743719, 2523.3313172009434, 2531.6961964564184, 2533.898644054236, 2537.644729737838, 2453.6932883389577, 2474.7030356357263, 2522.6342180383836, 2532.0884481586613, 2535.264773215765, 2403.843750156243, 2445.730969593343, 2454.509098180371, 2458.5820410530255, 2468.691413573303, 2404.903803847844, 2426.0902161689364, 2426.9757302426924, 2429.161939130997, 2460.458699086198, 9136.0, 9409.482478463682, 9708.95145524275, 9767.462789546573, 9768.267379946461, 5664.348599911022, 5812.128180772876, 5824.271966004249, 5824.504917082053, 5824.592278540504, 3751.4560388743753, 3786.3941769317053, 3854.69162467002, 3876.592957739453, 3889.649931506178, 1177.0759953436511, 1179.9646010619695, 1187.7980743273665, 1191.4102519252938, 1220.1337050694017, 13671.79492307626, 13760.380782864795, 13785.241811700353, 13808.792868106986, 13813.378397972016, 4820.830626218216, 4996.075725990703, 5029.245613158056, 5043.167877300204, 5060.5951523878, 10768.030877221088, 10817.891821081688, 10820.0, 10829.729256768485, 10834.837477437844, 5568.582356323292, 5639.125935480007, 5657.377688454267, 5657.434256574392, 5669.744861481243, 4410.845620403335, 4804.894874178958, 5217.139172036572, 5258.894822103536, 5304.38999515053, 4168.374743788396, 4188.539260681323, 4210.136921930997, 4219.915601687949, 4226.556211597738, 1232.4515590562114, 1234.5555599983998, 1235.4934476864441, 1235.7466719322517, 1248.126311581878, 891.9554022298859, 970.3692599810039, 1042.4058286776617, 1067.6156583629886, 1075.4622688655672, 6468.320826313264, 6605.471562275006, 6647.135872336662, 6654.73381064752, 6681.866362672817, 531.8032328038651, 537.4169026606098, 537.7875739083119, 544.0533471759189, 693.9140245515752, 4565.726056436624, 4640.211164102111, 4686.437627484724, 4764.571188593043, 4770.76146192689, 11459.656210313704, 11728.94135529317, 11824.408779560987, 11846.703832404259, 11850.644480665595, 11683.649490515298, 11688.415579221006, 11724.58963936258, 11787.410629468492, 11804.70488237801, 8778.385513014027, 9083.0, 9095.590698418455, 9224.262059035127, 9263.397879137834, 6524.771632992823, 6718.193816742022, 6763.154605674291, 6817.897731533932, 6899.75850845218, 10961.890381096087, 11344.262622929484, 11439.256448331165, 11456.713582160513, 11549.826752598885, 9579.712608621752, 11444.656660300205, 11556.075513958695, 11625.244359116969, 11637.127215458706, 7610.315071643357, 8711.651533938571, 8752.69365572202, 8956.462612243025, 8965.820683586162, 9055.68305109318, 9505.572249248939, 9530.237580993642, 9573.952130239582, 9607.855882161914, 8446.957765211135, 8528.445651032664, 8658.870116948377, 8659.307255419677, 8692.348073894356, 8572.3999320047, 8596.0, 8630.180132887366, 8633.30933525329, 8652.048274689652, 7656.846863062819, 7680.731174408869, 7684.615769211406, 7698.191689872707, 7720.498167619086, 5498.560115190695, 5774.451427114417, 5803.129530570448, 5840.2991641003355, 5884.764609415575, 5825.097109947796, 5847.06446968483, 5881.2942446906645, 5897.67562784051, 6019.277686677627], "value": 4978.464914048543, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.83572802918616, 349.6852832450794, 355.12461781708083, 361.75400727505286, 364.6317219608197, 5317.388500322464, 5373.731313434322, 5443.401225865152, 5477.726113694314, 5490.341159060913, 5444.475546846879, 5447.536959358449, 5478.863028424292, 5478.890422191554, 5482.616216864821, 4314.633256173229, 4329.328954012133, 4336.522982471925, 4338.783060846961, 4347.804348804311, 4091.365838295069, 4197.937030944523, 4324.286492728696, 4324.524302326741, 4332.84835030774, 4263.360495925605, 4267.231898258312, 4285.9571404286025, 4293.334533147367, 4305.332673435622, 4235.682323825726, 4258.08451182994, 4284.464441944757, 4295.8066886989845, 4312.986448184674, 3697.9445308320396, 3834.5398552173638, 3842.53889533255, 3870.651641352292, 3875.689944804437, 5132.794688212467, 5164.302819119408, 5184.0, 5187.636865419422, 5188.610854185913, 4858.392700912386, 4860.809101770089, 4904.852854414374, 4930.827421040246, 4946.678465899741, 5437.619366644337, 5638.915416268759, 5644.604877658566, 5716.685582292972, 5736.1682556029145, 4137.317342638461, 4147.191297696951, 4159.750414975111, 4167.4790651168605, 4173.707840451169, 5893.410658934115, 5941.643501389887, 5968.9255933931445, 5977.701114944235, 5997.520198384119, 4125.133721918371, 4178.937315940263, 4219.43037689914, 4265.25124698872, 4268.676710219842, 4223.619874211336, 4264.594863487963, 4264.72058382484, 4264.978675106605, 4272.807723652443, 4776.901312698099, 4874.4150701916, 4886.731229782325, 4912.361393018885, 4919.278252611629, 5565.749541270652, 5704.3154821421695, 5721.342045664718, 5767.250257466587, 5809.622374545641, 1391.8538553451945, 1412.8092707484564, 1447.5223176351778, 1453.382312517176, 1454.6508837879044, 938.6486850439742, 947.8436058050482, 948.4025064209504, 958.9280803939732, 976.1556253840376, 4939.431965324034, 4947.505249475023, 4952.554270115635, 4975.253711943165, 5054.671446355975, 5043.427851795611, 5111.642185047085, 5183.3261675981885, 5258.421573626898, 5270.5256526912, 4784.569388754959, 4901.534354236342, 4997.825076122318, 5007.499250075036, 5028.572571331405, 2752.6421565196397, 2770.8639457822196, 2779.66644002721, 2782.5826126080847, 2788.707185745508, 5263.394709608444, 5314.362276526842, 5318.867028324245, 5320.600954928318, 5331.493508116722, 4940.407151141886, 5221.660592061504, 5245.554127899171, 5252.290940722954, 5273.914759865445, 5161.354830646169, 5259.316288882421, 5306.8407947761625, 5326.7869285228935, 5333.413294552139, 5136.563392111712, 5156.845294641167, 5195.0, 5197.740112994411, 5258.631895767259, 5097.7706003229205, 5467.945320546903, 5785.508231800176, 5841.766329346779, 5842.853928651648, 6130.50955923534, 6141.232345956755, 6142.14010038586, 6146.401935496714, 6151.292601350723, 4116.341385378325, 4245.490541135084, 4245.747504486122, 4249.808758605932, 4255.723377980421, 5637.718114094361, 5696.430356964271, 5920.3783602722815, 5926.288845338587, 5952.761889524544, 5714.571407144564, 5723.656580605177, 5730.455606717355, 5738.1679656450415, 5740.712964351682, 5709.857253568694, 5715.971125197504, 5718.1708652246025, 5727.799527016535, 5741.770329186786, 5491.2312276282155, 5513.5037846594, 5600.803971860965, 5604.859878502907, 5624.184493248538, 5725.856853578527, 5738.942610573841, 5763.155790147112, 5766.625169363978, 5774.682392468455, 5521.475459831309, 5586.581006424453, 5607.43925607436, 5652.7173641318595, 5673.262475878109], "value": 4255.093609515598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.4098644044086, 833.3291700181352, 856.3013147503367, 902.3548163063409, 926.4904302633552, 16123.0, 17330.913345433288, 17360.479185624437, 17388.73916891246, 17390.30438782447, 15645.139517326543, 15883.523494295161, 15885.84114158858, 15921.681566368665, 15954.84045159548, 706.5266271598042, 728.129884787679, 731.9926800732004, 845.3744229270327, 858.5835869603237, 734.772220611612, 836.3309352517991, 867.6876324523166, 869.3393021303791, 873.7247766953421, 911.4667919267237, 916.3906002508324, 919.3610440743686, 919.6413398774483, 919.8574220995756, 755.5957562703982, 907.9909200908005, 908.5366463103799, 909.7725568607848, 910.0399078971682, 636.7516668499289, 665.3246954341347, 669.5246375073655, 670.0752960913908, 670.2392784189931, 16198.676026479523, 16208.594785130348, 16234.837651623451, 16250.106244156566, 16304.592385190346, 14937.253137343198, 15805.288762005623, 15896.84103158965, 15907.443239486562, 15949.362025518965, 14139.64650883736, 14308.356123974447, 14341.641458963504, 14342.92828535861, 14556.272186390637, 4593.311003349491, 4649.883752906205, 4701.200795864711, 4744.83393081244, 4786.7845946932475, 76091.47817043628, 76430.6178469104, 76642.0, 76673.61663191704, 79042.60478697627, 12152.088593355356, 12297.754044919231, 12515.56195533152, 12527.686807829878, 12614.747705045847, 22978.0, 23026.309210723706, 23089.307320780405, 23184.768152318262, 23219.535609288057, 8585.356098292528, 8660.826783464421, 8861.202491775772, 8959.41763785352, 9062.229710474552, 4689.554492323224, 4708.128996135726, 4752.215884379108, 5104.795808167632, 5107.8723031923755, 3739.8878033659034, 3847.788371639531, 3853.788041657736, 3856.5179352580926, 3863.6522712955407, 708.4297140801704, 708.5040471669852, 713.393615426883, 715.3347386930205, 734.8346622010005, 660.9173853268342, 677.383580941341, 737.4358615659025, 746.8917007033949, 748.4386709967524, 10039.397636141708, 10063.64777232808, 10156.23828212887, 10230.28388012832, 10256.12822910061, 686.739039165114, 703.3529153179087, 710.2719712294939, 718.7161071376777, 733.2374330696016, 4456.64346852251, 4650.093231819763, 4650.162970665245, 4676.532346765296, 4716.457607375127, 113529.0, 114881.0, 115893.4205328968, 116579.41710291564, 119305.0, 95080.0, 97111.0, 97993.0, 98504.0, 101455.0, 86713.0, 87705.0, 88378.55810721034, 89511.99999999869, 89637.0, 9464.290178236522, 9574.32979691415, 9629.374090684083, 9638.325317227727, 9642.0, 46923.76538117424, 47164.292535611305, 51080.999999998516, 51661.483385165666, 54477.72761136169, 73282.0, 73987.63006184934, 75770.62114689391, 76591.61704191443, 76795.0, 13268.867311326763, 14477.638059048608, 14518.637034074232, 14706.705865882837, 14792.704145916807, 13221.735565288447, 15998.200089995686, 16250.674986499967, 16597.41909033178, 16808.915955420143, 11696.941515292368, 13316.0, 14380.209088499814, 14443.3500492476, 15784.0, 14064.718705626035, 14781.408743650134, 14798.653037639366, 15287.312070956612, 15463.84536154669, 15156.393744250106, 15264.771028434805, 15305.46430874914, 15470.922645386701, 15507.379704811681, 11776.882231177578, 11985.760284794429, 12508.499660013498, 12549.93725031369, 12616.36918154107, 12511.186772859735, 12757.936210318889, 12761.93619031899, 13033.348332583522, 13074.411651475897], "value": 8021.9893434408705, "unit": "score"}], "name": "dromaeo_css", "value": 7687.06655777465, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 113.0, 111.0, 113.0, 111.0, 111.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 124.0, 176.0, 130.0, 131.0, 151.0, 128.0, 161.0, 126.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 163.0, 163.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 118.0, 76.0, 77.0, 75.0, 75.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 119.0, 84.0, 85.0, 84.0, 113.0, 85.0, 85.0, 133.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 58.0, 52.0, 52.0, 52.0, 51.0, 52.0, 51.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 60.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 82.0, 78.0, 77.0, 77.0, 77.0, 78.0, 121.0, 78.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 118.0, 116.0, 117.0, 124.0, 123.0, 125.0, 122.0, 119.0], "value": 120.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 158.0, 154.0, 156.0, 156.0, 155.0, 155.0, 155.0, 155.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 61.0, 65.0, 61.0, 61.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1482.5, "alertThreshold": 2.0}]} 03:21:48 INFO - Return code: 0 03:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:21:48 ERROR - # TBPL SUCCESS # 03:21:48 INFO - Running post-action listener: _resource_record_post_action 03:21:48 INFO - ##### 03:21:48 INFO - ##### Finished run-tests step (success) 03:21:48 INFO - ##### 03:21:48 INFO - Running post-run listener: _resource_record_post_run 03:21:48 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 294912; Write bytes: 253820928; Read time: 448; Write time: 252904 03:21:48 INFO - TinderboxPrint: CPU usage
13.1% 03:21:48 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 448 03:21:48 INFO - TinderboxPrint: I/O write bytes / time
253,820,928 / 252,904 03:21:48 INFO - TinderboxPrint: CPU idle
8,261.3 (86.9%) 03:21:48 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 03:21:48 INFO - TinderboxPrint: Swap in / out
0 / 0 03:21:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5267456; Read time: 0; Write time: 1112 03:21:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 270336; Write bytes: 248553472; Read time: 436; Write time: 251792 03:21:48 INFO - Running post-run listener: _upload_blobber_files 03:21:48 INFO - Blob upload gear active. 03:21:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:21:49 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:21:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:52 INFO - (blobuploader) - INFO - Done attempting. 03:21:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:53 INFO - (blobuploader) - INFO - Done attempting. 03:21:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:54 INFO - (blobuploader) - INFO - Done attempting. 03:21:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:54 INFO - Return code: 0 03:21:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc2895971e7a87aebe47ff644f4901eea5add7562d8335d68afbd13febcd1de2cb407ae27ed846d2575394d0f58967343cefecfde94885631ad8ce54ebe56a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/818aca52b0555a7eb99bdb3b7a533dde7890997a28d4a66952278f8d640d741cac371626bbbd00a8ad1d5062414d286a27137838a7b9fa1954250e023b5f6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14f95c6c8e5e4fda7e982ab4a5a0870dab11c4a880d958fa4e0b3d99e76e9ae4fdab2e15de91c78373f5717b6d64a06cf276aa1dc15283188812821e96b4b9e5"} 03:21:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:54 INFO - Contents: 03:21:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bc2895971e7a87aebe47ff644f4901eea5add7562d8335d68afbd13febcd1de2cb407ae27ed846d2575394d0f58967343cefecfde94885631ad8ce54ebe56a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/818aca52b0555a7eb99bdb3b7a533dde7890997a28d4a66952278f8d640d741cac371626bbbd00a8ad1d5062414d286a27137838a7b9fa1954250e023b5f6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14f95c6c8e5e4fda7e982ab4a5a0870dab11c4a880d958fa4e0b3d99e76e9ae4fdab2e15de91c78373f5717b6d64a06cf276aa1dc15283188812821e96b4b9e5"} 03:21:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:54 INFO - Copying logs to upload dir... 03:21:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.424190 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-16 03:21:54.680064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:21:54.683632) ========= 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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 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/bc2895971e7a87aebe47ff644f4901eea5add7562d8335d68afbd13febcd1de2cb407ae27ed846d2575394d0f58967343cefecfde94885631ad8ce54ebe56a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/818aca52b0555a7eb99bdb3b7a533dde7890997a28d4a66952278f8d640d741cac371626bbbd00a8ad1d5062414d286a27137838a7b9fa1954250e023b5f6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14f95c6c8e5e4fda7e982ab4a5a0870dab11c4a880d958fa4e0b3d99e76e9ae4fdab2e15de91c78373f5717b6d64a06cf276aa1dc15283188812821e96b4b9e5"} build_url:https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/VOAc9P8CR92U9JZhRCGxJw/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/bc2895971e7a87aebe47ff644f4901eea5add7562d8335d68afbd13febcd1de2cb407ae27ed846d2575394d0f58967343cefecfde94885631ad8ce54ebe56a1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/818aca52b0555a7eb99bdb3b7a533dde7890997a28d4a66952278f8d640d741cac371626bbbd00a8ad1d5062414d286a27137838a7b9fa1954250e023b5f6af9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14f95c6c8e5e4fda7e982ab4a5a0870dab11c4a880d958fa4e0b3d99e76e9ae4fdab2e15de91c78373f5717b6d64a06cf276aa1dc15283188812821e96b4b9e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-16 03:21:54.708940) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:21:54.709302) ========= 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=52faae308a556c440401f8e5000001e8-1468662673.402030-1016140293 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-16 03:21:54.792145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:21:54.792476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-16 03:21:54.792777) ========= ========= Total master_lag: 0.15 =========