builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1466770857.92 results: success (0) buildid: 20160624023357 builduid: 0e6b3271dec145a599e3530f79b6e9d2 revision: afcdd85399636b518887cc17aedbda8cc1c1f197 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:57.924932) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:57.925825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:57.926195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:57.942139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:57.942631) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:20:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-06-24 05:20:58 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.350914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:58.308263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:58.308725) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:58.359398) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:58.359988) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev afcdd85399636b518887cc17aedbda8cc1c1f197 --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 afcdd85399636b518887cc17aedbda8cc1c1f197 --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=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:20:58,690 truncating revision to first 12 chars 2016-06-24 05:20:58,690 Setting DEBUG logging. 2016-06-24 05:20:58,691 attempt 1/10 2016-06-24 05:20:58,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/afcdd8539963?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:20:59,253 unpacking tar archive at: mozilla-aurora-afcdd8539963/testing/mozharness/ program finished with exit code 0 elapsedTime=0.895613 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:59.271598) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:59.271983) ========= script_repo_revision: afcdd85399636b518887cc17aedbda8cc1c1f197 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:59.272441) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:59.272773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:20:59.283469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-24 05:20:59.283817) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:59 INFO - MultiFileLogger online at 20160624 05:20:59 in /builds/slave/test 05:20:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:20:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:59 INFO - {'append_to_log': False, 05:20:59 INFO - 'base_work_dir': '/builds/slave/test', 05:20:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:20:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:59 INFO - 'branch': 'Mozilla-Aurora', 05:20:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:59 INFO - 'config_files': ('talos/linux_config.py',), 05:20:59 INFO - 'default_actions': ('clobber', 05:20:59 INFO - 'read-buildbot-config', 05:20:59 INFO - 'download-and-extract', 05:20:59 INFO - 'populate-webroot', 05:20:59 INFO - 'create-virtualenv', 05:20:59 INFO - 'install', 05:20:59 INFO - 'run-tests'), 05:20:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:59 INFO - 'download_minidump_stackwalk': True, 05:20:59 INFO - 'download_symbols': 'ondemand', 05:20:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:59 INFO - 'installer_path': 'installer.exe', 05:20:59 INFO - 'log_level': 'info', 05:20:59 INFO - 'log_name': 'talos', 05:20:59 INFO - 'log_to_console': True, 05:20:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:59 INFO - 'opt_config_files': (), 05:20:59 INFO - 'pip_index': False, 05:20:59 INFO - 'sps_profile': False, 05:20:59 INFO - 'sps_profile_interval': 0, 05:20:59 INFO - 'suite': 'dromaeojs-e10s', 05:20:59 INFO - 'system_bits': '32', 05:20:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:59 INFO - 'title': 'talos-linux64-ix-061', 05:20:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:59 INFO - 'use_talos_json': True, 05:20:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:59 INFO - 'work_dir': 'build'} 05:20:59 INFO - ##### 05:20:59 INFO - ##### Running clobber step. 05:20:59 INFO - ##### 05:20:59 INFO - Running pre-action listener: _resource_record_pre_action 05:20:59 INFO - Running main action method: clobber 05:20:59 INFO - rmtree: /builds/slave/test/build 05:20:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:00 INFO - Running post-action listener: _resource_record_post_action 05:21:00 INFO - ##### 05:21:00 INFO - ##### Finished clobber step (success) 05:21:00 INFO - ##### 05:21:00 INFO - ##### 05:21:00 INFO - ##### Running read-buildbot-config step. 05:21:00 INFO - ##### 05:21:00 INFO - Running pre-action listener: _resource_record_pre_action 05:21:00 INFO - Running main action method: read_buildbot_config 05:21:00 INFO - Using buildbot properties: 05:21:00 INFO - { 05:21:00 INFO - "project": "", 05:21:00 INFO - "product": "firefox", 05:21:00 INFO - "script_repo_revision": "production", 05:21:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:21:00 INFO - "repository": "", 05:21:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:21:00 INFO - "buildid": "20160624023357", 05:21:00 INFO - "pgo_build": "True", 05:21:00 INFO - "basedir": "/builds/slave/test", 05:21:00 INFO - "buildnumber": 367, 05:21:00 INFO - "slavename": "talos-linux64-ix-061", 05:21:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:21:00 INFO - "platform": "ubuntu64_hw", 05:21:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:21:00 INFO - "branch": "mozilla-aurora", 05:21:00 INFO - "repo_path": "releases/mozilla-aurora", 05:21:00 INFO - "revision": "afcdd85399636b518887cc17aedbda8cc1c1f197", 05:21:00 INFO - "stage_platform": "linux64-pgo", 05:21:00 INFO - "builduid": "0e6b3271dec145a599e3530f79b6e9d2", 05:21:00 INFO - "slavebuilddir": "test" 05:21:00 INFO - } 05:21:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 05:21:00 INFO - Running post-action listener: _resource_record_post_action 05:21:00 INFO - ##### 05:21:00 INFO - ##### Finished read-buildbot-config step (success) 05:21:00 INFO - ##### 05:21:00 INFO - ##### 05:21:00 INFO - ##### Running download-and-extract step. 05:21:00 INFO - ##### 05:21:00 INFO - Running pre-action listener: _resource_record_pre_action 05:21:00 INFO - Running main action method: download_and_extract 05:21:00 INFO - mkdir: /builds/slave/test/build/tests 05:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:00 INFO - https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:21:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:21:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:21:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:21:01 INFO - Downloaded 1361 bytes. 05:21:01 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 05:21:01 INFO - Using the following test package requirements: 05:21:01 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:21:01 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:01 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:21:01 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'jsshell-linux-x86_64.zip'], 05:21:01 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:01 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 05:21:01 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:21:01 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:21:01 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:01 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 05:21:01 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:01 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:02 INFO - Downloaded 24516165 bytes. 05:21:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:03 INFO - Return code: 0 05:21:03 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21: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')]} 05:21:03 INFO - https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 05:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:05 INFO - Downloaded 24516165 bytes. 05:21:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:06 INFO - Return code: 0 05:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:06 INFO - https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:21:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:21:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 05:21:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:07 INFO - Downloaded 10833369 bytes. 05:21:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:21:07 INFO - Return code: 0 05:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:07 INFO - https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:10 INFO - Downloaded 63614198 bytes. 05:21:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:21:10 INFO - mkdir: /builds/slave/test/properties 05:21:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:10 INFO - Contents: 05:21:10 INFO - build_url:https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 05:21:10 INFO - Running post-action listener: _resource_record_post_action 05:21:10 INFO - Running post-action listener: set_extra_try_arguments 05:21:10 INFO - ##### 05:21:10 INFO - ##### Finished download-and-extract step (success) 05:21:10 INFO - ##### 05:21:10 INFO - ##### 05:21:10 INFO - ##### Running populate-webroot step. 05:21:10 INFO - ##### 05:21:10 INFO - Running pre-action listener: _resource_record_pre_action 05:21:10 INFO - Running main action method: populate_webroot 05:21:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:10 INFO - '--tppagecycles', 05:21:10 INFO - '7'], 05:21:10 INFO - 'tests': ['tsvgm']}}, 05:21:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['damp', 'tps']}, 05:21:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'tests': ['damp', 'tps']}, 05:21:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['dromaeo_dom']}, 05:21:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['a11yr', 05:21:10 INFO - 'ts_paint', 05:21:10 INFO - 'tpaint', 05:21:10 INFO - 'sessionrestore', 05:21:10 INFO - 'sessionrestore_no_auto_restore', 05:21:10 INFO - 'tabpaint']}, 05:21:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['tsvgx', 05:21:10 INFO - 'tsvgr_opacity', 05:21:10 INFO - 'tart', 05:21:10 INFO - 'tscrollx', 05:21:10 INFO - 'cart']}, 05:21:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:10 INFO - 'tsvgr_opacity', 05:21:10 INFO - 'tart', 05:21:10 INFO - 'tscrollx', 05:21:10 INFO - 'cart']}, 05:21:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'talos_options': ['--disable-e10s'], 05:21:10 INFO - 'tests': ['tp5o']}, 05:21:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'tests': ['tp5o']}, 05:21:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'talos_options': ['--disable-e10s', 05:21:10 INFO - '--xperf_path', 05:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:10 INFO - 'tests': ['tp5n']}, 05:21:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:10 INFO - 'talos_options': ['--xperf_path', 05:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:10 INFO - 'tests': ['tp5n']}}, 05:21:10 INFO - 'talos.zip': {'path': '', 05:21:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:10 INFO - Running post-action listener: _resource_record_post_action 05:21:10 INFO - ##### 05:21:10 INFO - ##### Finished populate-webroot step (success) 05:21:10 INFO - ##### 05:21:10 INFO - ##### 05:21:10 INFO - ##### Running create-virtualenv step. 05:21:10 INFO - ##### 05:21:10 INFO - Running pre-action listener: _resource_record_pre_action 05:21:10 INFO - Running main action method: create_virtualenv 05:21:10 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:10 INFO - Using real prefix '/usr' 05:21:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:13 INFO - Installing pip.................done. 05:21:13 INFO - Return code: 0 05:21:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:13 INFO - Using env: {'DISPLAY': ':0', 05:21:13 INFO - 'HOME': '/home/cltbld', 05:21:13 INFO - 'LANG': 'en_US.UTF-8', 05:21:13 INFO - 'LANGUAGE': 'en_US:en', 05:21:13 INFO - 'LOGNAME': 'cltbld', 05:21:13 INFO - 'MAIL': '/var/mail/cltbld', 05:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:13 INFO - 'MOZ_NO_REMOTE': '1', 05:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:13 INFO - 'NO_EM_RESTART': '1', 05:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:13 INFO - 'PWD': '/builds/slave/test', 05:21:13 INFO - 'SHELL': '/bin/bash', 05:21:13 INFO - 'SHLVL': '1', 05:21:13 INFO - 'TERM': 'linux', 05:21:13 INFO - 'TMOUT': '86400', 05:21:13 INFO - 'USER': 'cltbld', 05:21:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:13 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:13 INFO - Cleaning up... 05:21:13 INFO - Return code: 0 05:21:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:13 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:21:13 INFO - Using env: {'DISPLAY': ':0', 05:21:13 INFO - 'HOME': '/home/cltbld', 05:21:13 INFO - 'LANG': 'en_US.UTF-8', 05:21:13 INFO - 'LANGUAGE': 'en_US:en', 05:21:13 INFO - 'LOGNAME': 'cltbld', 05:21:13 INFO - 'MAIL': '/var/mail/cltbld', 05:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:13 INFO - 'MOZ_NO_REMOTE': '1', 05:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:13 INFO - 'NO_EM_RESTART': '1', 05:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:13 INFO - 'PWD': '/builds/slave/test', 05:21:13 INFO - 'SHELL': '/bin/bash', 05:21:13 INFO - 'SHLVL': '1', 05:21:13 INFO - 'TERM': 'linux', 05:21:13 INFO - 'TMOUT': '86400', 05:21:13 INFO - 'USER': 'cltbld', 05:21:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:13 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Downloading/unpacking psutil>=3.1.1 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:15 INFO - Installing collected packages: psutil 05:21:15 INFO - Running setup.py install for psutil 05:21:15 INFO - building 'psutil._psutil_linux' extension 05:21:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:21:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:21:16 INFO - building 'psutil._psutil_posix' extension 05:21:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:21:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:21:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:16 INFO - Successfully installed psutil 05:21:16 INFO - Cleaning up... 05:21:16 INFO - Return code: 0 05:21:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:16 INFO - Using env: {'DISPLAY': ':0', 05:21:16 INFO - 'HOME': '/home/cltbld', 05:21:16 INFO - 'LANG': 'en_US.UTF-8', 05:21:16 INFO - 'LANGUAGE': 'en_US:en', 05:21:16 INFO - 'LOGNAME': 'cltbld', 05:21:16 INFO - 'MAIL': '/var/mail/cltbld', 05:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:16 INFO - 'MOZ_NO_REMOTE': '1', 05:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:16 INFO - 'NO_EM_RESTART': '1', 05:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:16 INFO - 'PWD': '/builds/slave/test', 05:21:16 INFO - 'SHELL': '/bin/bash', 05:21:16 INFO - 'SHLVL': '1', 05:21:16 INFO - 'TERM': 'linux', 05:21:16 INFO - 'TMOUT': '86400', 05:21:16 INFO - 'USER': 'cltbld', 05:21:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:16 INFO - '_': '/tools/buildbot/bin/python'} 05:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:18 INFO - Installing collected packages: mozsystemmonitor 05:21:18 INFO - Running setup.py install for mozsystemmonitor 05:21:18 INFO - Successfully installed mozsystemmonitor 05:21:18 INFO - Cleaning up... 05:21:18 INFO - Return code: 0 05:21:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:21:18 INFO - Using env: {'DISPLAY': ':0', 05:21:18 INFO - 'HOME': '/home/cltbld', 05:21:18 INFO - 'LANG': 'en_US.UTF-8', 05:21:18 INFO - 'LANGUAGE': 'en_US:en', 05:21:18 INFO - 'LOGNAME': 'cltbld', 05:21:18 INFO - 'MAIL': '/var/mail/cltbld', 05:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:18 INFO - 'MOZ_NO_REMOTE': '1', 05:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:18 INFO - 'NO_EM_RESTART': '1', 05:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:18 INFO - 'PWD': '/builds/slave/test', 05:21:18 INFO - 'SHELL': '/bin/bash', 05:21:18 INFO - 'SHLVL': '1', 05:21:18 INFO - 'TERM': 'linux', 05:21:18 INFO - 'TMOUT': '86400', 05:21:18 INFO - 'USER': 'cltbld', 05:21:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:18 INFO - '_': '/tools/buildbot/bin/python'} 05:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:21 INFO - warning: no files found matching '*.txt' 05:21:21 INFO - no previously-included directories found matching 'build' 05:21:21 INFO - no previously-included directories found matching 'dist' 05:21:21 INFO - no previously-included directories found matching '.git*' 05:21:21 INFO - Installing collected packages: jsonschema, functools32 05:21:21 INFO - Running setup.py install for functools32 05:21:21 INFO - warning: no files found matching '*.txt' 05:21:21 INFO - no previously-included directories found matching 'build' 05:21:21 INFO - no previously-included directories found matching 'dist' 05:21:21 INFO - no previously-included directories found matching '.git*' 05:21:21 INFO - Successfully installed jsonschema functools32 05:21:21 INFO - Cleaning up... 05:21:21 INFO - Return code: 0 05:21:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:21 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:21 INFO - Using env: {'DISPLAY': ':0', 05:21:21 INFO - 'HOME': '/home/cltbld', 05:21:21 INFO - 'LANG': 'en_US.UTF-8', 05:21:21 INFO - 'LANGUAGE': 'en_US:en', 05:21:21 INFO - 'LOGNAME': 'cltbld', 05:21:21 INFO - 'MAIL': '/var/mail/cltbld', 05:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:21 INFO - 'MOZ_NO_REMOTE': '1', 05:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:21 INFO - 'NO_EM_RESTART': '1', 05:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:21 INFO - 'PWD': '/builds/slave/test', 05:21:21 INFO - 'SHELL': '/bin/bash', 05:21:21 INFO - 'SHLVL': '1', 05:21:21 INFO - 'TERM': 'linux', 05:21:21 INFO - 'TMOUT': '86400', 05:21:21 INFO - 'USER': 'cltbld', 05:21:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:21 INFO - '_': '/tools/buildbot/bin/python'} 05:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:24 INFO - Downloading docopt-0.6.1.tar.gz 05:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:24 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:24 INFO - Running setup.py install for blobuploader 05:21:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:24 INFO - Running setup.py install for requests 05:21:24 INFO - Running setup.py install for docopt 05:21:24 INFO - Successfully installed blobuploader requests docopt 05:21:24 INFO - Cleaning up... 05:21:24 INFO - Return code: 0 05:21:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:24 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:24 INFO - Using env: {'DISPLAY': ':0', 05:21:24 INFO - 'HOME': '/home/cltbld', 05:21:24 INFO - 'LANG': 'en_US.UTF-8', 05:21:24 INFO - 'LANGUAGE': 'en_US:en', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MAIL': '/var/mail/cltbld', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SHLVL': '1', 05:21:24 INFO - 'TERM': 'linux', 05:21:24 INFO - 'TMOUT': '86400', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - '_': '/tools/buildbot/bin/python'} 05:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:25 INFO - Running setup.py (path:/tmp/pip-_HaCCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:25 INFO - Running setup.py (path:/tmp/pip-Glt6CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:25 INFO - Running setup.py (path:/tmp/pip-seqkAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:25 INFO - Running setup.py (path:/tmp/pip-7WXUh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:25 INFO - Running setup.py (path:/tmp/pip-lNBxDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:25 INFO - Running setup.py (path:/tmp/pip-TjlyWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:25 INFO - Running setup.py (path:/tmp/pip-VyAsYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:25 INFO - Running setup.py (path:/tmp/pip-LP7xf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:25 INFO - Running setup.py (path:/tmp/pip-vhDt8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:25 INFO - Running setup.py (path:/tmp/pip-9BvXkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:25 INFO - Running setup.py (path:/tmp/pip-QpZwCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:25 INFO - Running setup.py (path:/tmp/pip-3DOYgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:25 INFO - Running setup.py (path:/tmp/pip-WT3hh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:25 INFO - Running setup.py (path:/tmp/pip-1BT4LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:26 INFO - Running setup.py (path:/tmp/pip-hke16m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:26 INFO - Running setup.py (path:/tmp/pip-typQND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:26 INFO - Running setup.py (path:/tmp/pip-8vSfei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:26 INFO - Running setup.py install for manifestparser 05:21:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozcrash 05:21:26 INFO - Running setup.py install for mozdebug 05:21:26 INFO - Running setup.py install for mozdevice 05:21:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozfile 05:21:26 INFO - Running setup.py install for mozhttpd 05:21:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozinfo 05:21:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:26 INFO - Running setup.py install for mozInstall 05:21:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozleak 05:21:27 INFO - Running setup.py install for mozlog 05:21:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for moznetwork 05:21:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozprocess 05:21:27 INFO - Running setup.py install for mozprofile 05:21:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozrunner 05:21:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:27 INFO - Running setup.py install for mozscreenshot 05:21:27 INFO - Running setup.py install for moztest 05:21:27 INFO - Running setup.py install for mozversion 05:21:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:28 INFO - Cleaning up... 05:21:28 INFO - Return code: 0 05:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:28 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:28 INFO - Using env: {'DISPLAY': ':0', 05:21:28 INFO - 'HOME': '/home/cltbld', 05:21:28 INFO - 'LANG': 'en_US.UTF-8', 05:21:28 INFO - 'LANGUAGE': 'en_US:en', 05:21:28 INFO - 'LOGNAME': 'cltbld', 05:21:28 INFO - 'MAIL': '/var/mail/cltbld', 05:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:28 INFO - 'MOZ_NO_REMOTE': '1', 05:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:28 INFO - 'NO_EM_RESTART': '1', 05:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:28 INFO - 'PWD': '/builds/slave/test', 05:21:28 INFO - 'SHELL': '/bin/bash', 05:21:28 INFO - 'SHLVL': '1', 05:21:28 INFO - 'TERM': 'linux', 05:21:28 INFO - 'TMOUT': '86400', 05:21:28 INFO - 'USER': 'cltbld', 05:21:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:28 INFO - '_': '/tools/buildbot/bin/python'} 05:21:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:28 INFO - Running setup.py (path:/tmp/pip-Y4bQuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:28 INFO - Running setup.py (path:/tmp/pip-r2Wy7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:28 INFO - Running setup.py (path:/tmp/pip-wLPuu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:28 INFO - Running setup.py (path:/tmp/pip-btVHU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:28 INFO - Running setup.py (path:/tmp/pip-RsTJXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:28 INFO - Running setup.py (path:/tmp/pip-N7rt7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:28 INFO - Running setup.py (path:/tmp/pip-zko9OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:28 INFO - Running setup.py (path:/tmp/pip-ZCYJec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:28 INFO - Running setup.py (path:/tmp/pip-th7goj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:28 INFO - Running setup.py (path:/tmp/pip-aSv1Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:28 INFO - Running setup.py (path:/tmp/pip-LCKRhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:29 INFO - Running setup.py (path:/tmp/pip-wlQBuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:29 INFO - Running setup.py (path:/tmp/pip-nerrtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:29 INFO - Running setup.py (path:/tmp/pip-E9xNgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:29 INFO - Running setup.py (path:/tmp/pip-GQVKG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:29 INFO - Running setup.py (path:/tmp/pip-2paUp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:29 INFO - Running setup.py (path:/tmp/pip-mkk9RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:31 INFO - Downloading blessings-1.6.tar.gz 05:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:31 INFO - Installing collected packages: blessings 05:21:31 INFO - Running setup.py install for blessings 05:21:31 INFO - Successfully installed blessings 05:21:31 INFO - Cleaning up... 05:21:31 INFO - Return code: 0 05:21:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:31 INFO - Reading from file tmpfile_stdout 05:21:31 INFO - Current package versions: 05:21:31 INFO - argparse == 1.2.1 05:21:31 INFO - blessings == 1.6 05:21:31 INFO - blobuploader == 1.2.4 05:21:31 INFO - docopt == 0.6.1 05:21:31 INFO - functools32 == 3.2.3-2 05:21:31 INFO - jsonschema == 2.5.1 05:21:31 INFO - manifestparser == 1.1 05:21:31 INFO - mozInstall == 1.12 05:21:31 INFO - mozcrash == 0.17 05:21:31 INFO - mozdebug == 0.1 05:21:31 INFO - mozdevice == 0.48 05:21:31 INFO - mozfile == 1.2 05:21:31 INFO - mozhttpd == 0.7 05:21:31 INFO - mozinfo == 0.9 05:21:31 INFO - mozleak == 0.1 05:21:31 INFO - mozlog == 3.2 05:21:31 INFO - moznetwork == 0.27 05:21:31 INFO - mozprocess == 0.22 05:21:31 INFO - mozprofile == 0.28 05:21:31 INFO - mozrunner == 6.11 05:21:31 INFO - mozscreenshot == 0.1 05:21:31 INFO - mozsystemmonitor == 0.3 05:21:31 INFO - moztest == 0.7 05:21:31 INFO - mozversion == 1.4 05:21:31 INFO - psutil == 3.1.1 05:21:31 INFO - requests == 1.2.3 05:21:31 INFO - wsgiref == 0.1.2 05:21:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:31 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 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:31 INFO - Using env: {'DISPLAY': ':0', 05:21:31 INFO - 'HOME': '/home/cltbld', 05:21:31 INFO - 'LANG': 'en_US.UTF-8', 05:21:31 INFO - 'LANGUAGE': 'en_US:en', 05:21:31 INFO - 'LOGNAME': 'cltbld', 05:21:31 INFO - 'MAIL': '/var/mail/cltbld', 05:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:31 INFO - 'MOZ_NO_REMOTE': '1', 05:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:31 INFO - 'NO_EM_RESTART': '1', 05:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:31 INFO - 'PWD': '/builds/slave/test', 05:21:31 INFO - 'SHELL': '/bin/bash', 05:21:31 INFO - 'SHLVL': '1', 05:21:31 INFO - 'TERM': 'linux', 05:21:31 INFO - 'TMOUT': '86400', 05:21:31 INFO - 'USER': 'cltbld', 05:21:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:31 INFO - '_': '/tools/buildbot/bin/python'} 05:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:32 INFO - Cleaning up... 05:21:32 INFO - Return code: 0 05:21:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21: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', 'jsonschema'] in /builds/slave/test/build 05:21: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 jsonschema 05:21:32 INFO - Using env: {'DISPLAY': ':0', 05:21:32 INFO - 'HOME': '/home/cltbld', 05:21:32 INFO - 'LANG': 'en_US.UTF-8', 05:21:32 INFO - 'LANGUAGE': 'en_US:en', 05:21:32 INFO - 'LOGNAME': 'cltbld', 05:21:32 INFO - 'MAIL': '/var/mail/cltbld', 05:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:32 INFO - 'MOZ_NO_REMOTE': '1', 05:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:32 INFO - 'NO_EM_RESTART': '1', 05:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:32 INFO - 'PWD': '/builds/slave/test', 05:21:32 INFO - 'SHELL': '/bin/bash', 05:21:32 INFO - 'SHLVL': '1', 05:21:32 INFO - 'TERM': 'linux', 05:21:32 INFO - 'TMOUT': '86400', 05:21:32 INFO - 'USER': 'cltbld', 05:21:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:32 INFO - '_': '/tools/buildbot/bin/python'} 05:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:32 INFO - Cleaning up... 05:21:32 INFO - Return code: 0 05:21:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21: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')]} 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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')]} 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb457d08f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3f020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21: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', 'flake8'] in /builds/slave/test/build 05:21: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 flake8 05:21:32 INFO - Using env: {'DISPLAY': ':0', 05:21:32 INFO - 'HOME': '/home/cltbld', 05:21:32 INFO - 'LANG': 'en_US.UTF-8', 05:21:32 INFO - 'LANGUAGE': 'en_US:en', 05:21:32 INFO - 'LOGNAME': 'cltbld', 05:21:32 INFO - 'MAIL': '/var/mail/cltbld', 05:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:32 INFO - 'MOZ_NO_REMOTE': '1', 05:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:32 INFO - 'NO_EM_RESTART': '1', 05:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:32 INFO - 'PWD': '/builds/slave/test', 05:21:32 INFO - 'SHELL': '/bin/bash', 05:21:32 INFO - 'SHLVL': '1', 05:21:32 INFO - 'TERM': 'linux', 05:21:32 INFO - 'TMOUT': '86400', 05:21:32 INFO - 'USER': 'cltbld', 05:21:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:32 INFO - '_': '/tools/buildbot/bin/python'} 05:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:32 INFO - Downloading/unpacking flake8 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:35 INFO - no previously-included directories found matching 'docs/_build' 05:21:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:35 INFO - Running setup.py install for pep8 05:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:35 INFO - no previously-included directories found matching 'docs/_build' 05:21:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:35 INFO - Cleaning up... 05:21:35 INFO - Return code: 0 05:21:35 INFO - Running post-action listener: _resource_record_post_action 05:21:35 INFO - Running post-action listener: _start_resource_monitoring 05:21:35 INFO - Starting resource monitoring. 05:21:35 INFO - ##### 05:21:35 INFO - ##### Finished create-virtualenv step (success) 05:21:35 INFO - ##### 05:21:35 INFO - ##### 05:21:35 INFO - ##### Running install step. 05:21:35 INFO - ##### 05:21:35 INFO - Running pre-action listener: _resource_record_pre_action 05:21:35 INFO - Running main action method: install 05:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:35 INFO - Reading from file tmpfile_stdout 05:21:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:35 INFO - Reading from file tmpfile_stdout 05:21:35 INFO - Output received: 05:21:35 INFO - Usage: mozinstall [options] installer 05:21:35 INFO - Options: 05:21:35 INFO - -h, --help show this help message and exit 05:21:35 INFO - -d DEST, --destination=DEST 05:21:35 INFO - Directory to install application into. [default: 05:21:35 INFO - "/builds/slave/test"] 05:21:35 INFO - --app=APP Application being installed. [default: firefox] 05:21:35 INFO - mkdir: /builds/slave/test/build/application 05:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:51 INFO - Reading from file tmpfile_stdout 05:21:51 INFO - Output received: 05:21:51 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:51 INFO - Running post-action listener: _resource_record_post_action 05:21:51 INFO - ##### 05:21:51 INFO - ##### Finished install step (success) 05:21:51 INFO - ##### 05:21:51 INFO - ##### 05:21:51 INFO - ##### Running run-tests step. 05:21:51 INFO - ##### 05:21:51 INFO - Running pre-action listener: _resource_record_pre_action 05:21:51 INFO - Running main action method: run_tests 05:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:51 INFO - Python 2.7.3 05:21:51 INFO - Return code: 0 05:21:51 INFO - grabbing minidump binary from tooltool 05:21:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:51 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 0x1ad12e0>, '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 0x1a3d140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3d5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:21:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:21:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:21:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:51 INFO - Return code: 0 05:21:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:52 INFO - Return code: 0 05:21:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:21:52 INFO - Using env: {'DISPLAY': ':0', 05:21:52 INFO - 'HOME': '/home/cltbld', 05:21:52 INFO - 'LANG': 'en_US.UTF-8', 05:21:52 INFO - 'LANGUAGE': 'en_US:en', 05:21:52 INFO - 'LOGNAME': 'cltbld', 05:21:52 INFO - 'MAIL': '/var/mail/cltbld', 05:21:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:52 INFO - 'MOZ_NO_REMOTE': '1', 05:21:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:52 INFO - 'NO_EM_RESTART': '1', 05:21:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:52 INFO - 'PWD': '/builds/slave/test', 05:21:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:52 INFO - 'SHELL': '/bin/bash', 05:21:52 INFO - 'SHLVL': '1', 05:21:52 INFO - 'TERM': 'linux', 05:21:52 INFO - 'TMOUT': '86400', 05:21:52 INFO - 'USER': 'cltbld', 05:21:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562', 05:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:52 INFO - '_': '/tools/buildbot/bin/python'} 05:21:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:21:52 INFO - mozversion application_buildid: 20160624023357 05:21:52 INFO - mozversion application_changeset: afcdd85399636b518887cc17aedbda8cc1c1f197 05:21:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:21:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:52 INFO - mozversion application_name: Firefox 05:21:52 INFO - mozversion application_remotingname: firefox-dev 05:21:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:21:52 INFO - mozversion application_vendor: Mozilla 05:21:52 INFO - mozversion application_version: 49.0a2 05:21:52 INFO - mozversion platform_buildid: 20160624023357 05:21:52 INFO - mozversion platform_changeset: afcdd85399636b518887cc17aedbda8cc1c1f197 05:21:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:21:52 INFO - mozversion platform_version: 49.0a2 05:21:52 INFO - using testdate: 1466770912 05:21:52 INFO - actual date: 1466770912 05:21:52 INFO - starting webserver on 'localhost:52022' 05:21:52 INFO - SUITE-START | Running 2 tests 05:21:52 INFO - TEST-START | dromaeo_css 05:21:52 INFO - operating with platform_type : linux_ 05:21:52 INFO - Initialising browser for dromaeo_css test... 05:21:52 INFO - TEST-INFO | started process 20847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWh2ONC/profile http://localhost:52022/getInfo.html) 05:21:57 INFO - PROCESS | 20847 | __metrics Screen width/height:1600/1200 05:21:57 INFO - PROCESS | 20847 | colorDepth:24 05:21:57 INFO - PROCESS | 20847 | Browser inner width/height: 1024/697 05:21:57 INFO - PROCESS | 20847 | __metrics 05:21:58 ERROR - PROCESS | 20847 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:21:59 INFO - TEST-INFO | 20847: exit 0 05:21:59 INFO - Browser initialized. 05:21:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:59 INFO - TEST-INFO | started process 20977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWh2ONC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:11 INFO - PROCESS | 20977 | RSS: Main: 155938816 05:22:11 INFO - PROCESS | 20977 | 05:23:00 INFO - PROCESS | 20977 | 1466770980657 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:08 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52022/tests/dromaeo/cssquery-ext.html) 05:25:09 INFO - PROCESS | 20977 | RSS: Main: 159346688 05:25:09 INFO - PROCESS | 20977 | 05:28:11 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-ext.html (next: http://localhost:52022/tests/dromaeo/cssquery-jquery.html) 05:28:12 INFO - PROCESS | 20977 | RSS: Main: 157544448 05:28:12 INFO - PROCESS | 20977 | 05:31:14 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52022/tests/dromaeo/cssquery-mootools.html) 05:31:14 INFO - PROCESS | 20977 | RSS: Main: 157696000 05:31:14 INFO - PROCESS | 20977 | 05:34:16 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52022/tests/dromaeo/cssquery-prototype.html) 05:34:17 INFO - PROCESS | 20977 | RSS: Main: 156844032 05:34:17 INFO - PROCESS | 20977 | 05:37:19 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52022/tests/dromaeo/cssquery-yui.html) 05:37:20 INFO - PROCESS | 20977 | RSS: Main: 159145984 05:37:20 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | Cycle 1(1): loaded http://localhost:52022/tests/dromaeo/cssquery-yui.html (next: http://localhost:52022/tests/dromaeo/cssquery-dojo.html) 05:40:22 INFO - PROCESS | 20977 | RSS: Main: 159862784 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | __start_tp_report 05:40:22 INFO - PROCESS | 20977 | _x_x_mozilla_page_load 05:40:22 INFO - PROCESS | 20977 | _x_x_mozilla_page_load_details 05:40:22 INFO - PROCESS | 20977 | |i|pagename|runs| 05:40:22 INFO - PROCESS | 20977 | |0;dojo.html;3409.198838273006;3426.657334266575;3427.400204964131;3458.982705086474;3465.826708664566;5733.942660573393;5756.51069659079;5806.796762113332;5819;5875.412458754123;5798.478136967672;5888;5888.528917686585;5896.646201227929;5898.646081235118;5264.657797243177;5281.471852814707;5291.708956007418;5302.416734159258;5334.306540149775;5218.425973142951;5238.3975842778;5269.65747226431;5331.840044798662;5357.651752636086;5270.894582108355;5281.551068159192;5299.046171689094;5315.282436871012;5326.493983071602;5367.436419175989;5374.892502149935;5376.542993845528;5400.189971504266;5410.675359478424;5098.413682426494;5110.5911527078115;5170.482951704837;5259.86850328741;5266.289050978107;5628.690422026787;5666.546676265889;5696.487316141567;5697.914531282034;5703.600747947646;6144.5084393248435;6176.69116544171;6187.257529096492;6192.040233763729;6196.659183744892;6118.357572454873;6126.050462178369;6132.753252973555;6136.079588061782;6234.688265586748;5776.653400795965;5777.653340799523;5812.941870581282;5826.096954971986;5835.241418615553;6371.872562548723;6382.20222472191;6382.425581697669;6387.489000879918;6387.936120638827;6034.818955431344;6076.787312444043;6099.634021958696;6110.771402862413;6135.693215339215;6224.657643829542;6234.376562343729;6272.843178920563;6290.402411770874;6297.275813281532;6131;6180.505559555225;6250.218722659668;6253.96873015632;6255.937440625627;6149.600275982047;6211.875762484725;6232.25212974446;6294.748210071637;6308.337624549448;4685.367475390779;4710.4347478302825;4725.243960966229;4743.02767932573;4765.9761701191965;4143.56492568282;4154.543000269968;4170.457840480718;4220.662347012231;4257.4252475915355;5752.568557358215;5902;5909.911351329733;5979.431953964453;6005.729742161613;6307.779227727007;6330.905036424458;6341.778037768656;6348.365163483707;6356.936430635635;5869.647821130746;5957.195778569838;6023.45788879003;6035.124906888476;6046.909296360558;5220.138677118309;5257.894842103213;5308.946910530845;5311.256424100629;5329.840104796862;6478.967605162038;6509.316521765147;6546.672666366662;6548.8035358939305;6551.705173267214;6120.816375508742;6168.907466387918;6273.343512057686;6369.0446433034485;6375.553711240169;6358;6471.320511346429;6474.5791523550815;6482.708278127401;6495.610263384212;6189.133521306931;6196.1015652731;6196.318404975359;6205.379462053758;6224.315325314121;6047.971844786309;6201.565890387629;6238.251409830667;6278.968605156945;6288.402601752826;6128.540359473147;6129.693515324127;6129.785457508966;6131.5601757859595;6150.138980542638;6131.8664907781995;6160.168377269011;6197.442230199304;6198.597091189058;6208.50331973432;5810.767569297181;6011.939880601138;6055.515558755377;6064.272287325549;6084.513238940785;6203.0075187971515;6218.347073557211;6227.782027629011;6253.7185826637;6266.968665156645;6111.511079113571;6116.418940200674;6126.6017708848785;6127.3566275540425;6132.693365331805 05:40:22 INFO - PROCESS | 20977 | |1;ext.html;588.1207594646003;643.4530648948393;657.4707360574738;662.4137638190201;684.2097377528955;40458;45713.54286457143;45797.54202457974;45832.999999999956;46117.53882461174;47357;48062.519374806245;48093.27860082093;48105.7594712026;48217;8922.33082518812;9112.453252804853;9114.361994660376;9126.269898408145;9134.314926380515;8994.820103597924;9098.818023639524;9100.681476148337;9115.316351273648;9117.68088116916;9086.182243598076;9125.863112053325;9126.041765614615;9170.312226582999;9178.770530736752;9041.09589041094;9071.319651026133;9089.27285817133;9096.77258068547;9131.771705707344;8972.955135224347;9051.728448146567;9051.909480905239;9054.185123338932;9114.13415725505;43579.34630980506;43838.123237535074;43995.34006989898;44080.559194407964;44193.77903110464;3913.960860391388;4111.280525907984;4233.364995250707;4295.742255464682;4626.514216007305;35829.64170358289;36544.817275913716;36565;36715.265694686226;36786.264274714624;4610.400647915783;4763.595094416979;4805.351277577517;4823.1800593899125;4845.515448455127;375032;377751;378855;380105.9999999972;380707;67277.32722672808;67849.66075169592;67871.66064169648;67912;68331;38476;39472.40791388132;39528.40707389391;41786.582134178876;41815.79092104581;19876.801231987494;19989.900050499655;20006.29977950794;20075.698864517042;20123.798762012484;14030.508932187324;14033.859661403256;14050.297485125702;14081.788773168411;14107.224102674247;21216.469588260108;21324.466888327606;21409.67885481719;21457;21495.14019439205;7354.264573542603;7440.627968601549;7455.962720186473;7564.962175189089;7641.2740789624895;989.4904124375952;1003.8795344558554;1081.3133660125877;1089.1341383600056;1113.4098927568402;32442.513362299585;33203.50194747081;33415.331693365995;33492.3301533968;33698;1172.5895936422185;1229.6434034130002;1236.9690757731128;1260.4454040222456;1295.8337496253448;17318;17596.12019399025;17771.378001769877;17804.55488612795;17837.821621783874;587068;632639;810194;832512;840946;60657.69671151616;61197;61473;61512.69243653753;61563.6921815397;1401.1663060479;1454.919979401143;1460.8758255548184;1468.7870258812413;1506.0737646347636;31172.22069448191;31572;31573.36853262968;32130.357392851543;32839.835800820845;51793.7410312946;52155;52321.21518177154;52508.21237681514;52556.737216313675;412809;416432;417172;418430;420056;29838.55242171326;29971.100866974026;30702.84648576743;30892;30983;48265.75867120642;48635.02729945452;49176.50823491719;49743;50066.249006265665;41836.12038469738;43009.784951075046;43054.35418468663;43209.56790432055;43761.56238437575;41299.38050929298;41328.79335603423;42061;42392.36411453769;42821;41158.38262426006;42600.14799703927;42611;42631.573684264;42632.36051459169;35397.1150721234;35449.46825797667;36131.81934090313;36743;36930.44604330991;27772;28154.85922570374;28232.576511352756;28487;28615.570766438937 05:40:22 INFO - PROCESS | 20977 | |2;jquery.html;415.18001946156323;419.4337644180355;422.2652584502966;424.9213895429345;439.3826673523698;18774.718379224305;19717.507062323468;20487.795122048792;21408;21508.354749357506;17340.56648583786;18821.905890470563;19156.042197890118;19873.40379788605;20804.68792968103;5950.10748387742;6116.633002019871;6131.570790044699;6146.569740118193;6173.0740388941795;5819.447152520525;6094.96952515239;6099.57302988791;6100.542459315547;6100.969495152518;5876.265466816648;5961.374055724152;6007.158997740298;6014.458698717114;6052.273727152748;6023.789167379121;6082.81751547452;6083.96572582662;6090.934086534839;6093.146959425661;5183.792648294064;5289.259503669489;5368.275282836806;5397.7031263280505;5440.129579267338;24053;24269.514609707883;24651.260462185983;24768.5046299073;24878.253652390456;2537.6574162488014;2579.9226023219335;2624.475104979012;2636.222314417232;2857.3713782967716;14814.481493147796;15180.544583662508;15189.240537973168;15427.3829046838;15792.131432771193;1984.9801501985085;2053.5482193917314;2095.989520052405;2105.631514484959;2142.121730090671;82179;83373.99999999939;83719.58140209322;84357.57821210855;84610;11083.72290692739;11548.826767598493;11602.013828824645;11650.53397864076;11770.822917708161;14172.787408188886;16136.75794863078;16249.10629915366;16252.837471625133;16279.674406511804;8573.828523429496;8913.37606367561;8979.775505612412;9334.346595738232;9497.287703422271;9050.275977921881;9187.173154416134;9236.953815230881;9386.67146649864;9486.810263794685;6778.559393639398;7189.388901943289;7206.207317195104;7310.926890731131;7411.110666720028;1970.4975231315923;1988.125224901068;1988.5028742814297;2037.918483260653;2050.7436570428695;928.535732133933;981.9705408837603;1038.3562191441354;1055.1031623120286;1169.5088063013554;19853.404397868086;20126.19495220175;20127.39617811468;20409.14272001921;20801.895990520254;1084.8318510630866;1136.7499150186945;1139.2480962564669;1143.857017872766;1144.296257801446;11342.886571134348;11393.802571452645;11465.31208127515;11553.537858485735;11658.94170529142;506970;508352;510662;519420;520106;82372.58813705893;87785;88019.55990220136;88037.55981220053;88211.55894220488;1086.4296244471716;1100.7963526747578;1111.2275919907734;1112.8052590796578;1126.3748619516084;16570.58573535623;17666.205020774352;17891.910540447214;18363.26546938161;18383.26466941361;42248.155036899705;43293.35059974166;43685.56314436815;43915;44643.10713785771;59820;61307.693461532406;61577.69211153915;62104.06843897255;62384.376156239676;8962.417442866194;9033.096690330914;9044.909550904407;9150.267978561566;9313.767155821159;10368.844467333147;13738.244396557886;14080;14235;14618.634534136732;11801;12145.332006739714;12259.632211033684;12457.252564846138;12557.811632825698;11983.700407489883;12000.279983201035;12149.635510934686;12354.382280886099;12806.359682015676;12301.75396492083;12319.63041108768;12340.938295308466;12353.3823308836;13084.28036457966;9071.773205669911;9197.172254497127;9201.815963680823;9366.906330936603;9372.718818435458;12139.150259481752;12259.835315645;12263.448144833683;12335.074869384653;12485.93757031209 05:40:22 INFO - PROCESS | 20977 | |3;mootools.html;1490.9403623855044;1529.502911553745;1716.7424886267058;1858.7769467663882;1874.596961653246;9484.620615175394;9999.800003999915;10225.846612300802;10294.382337059773;10303.227257955647;9708.902910970888;9881.110700037014;9947.452890091043;9967.75080622983;9997.600095996151;2562.231330600822;2579.5098931203106;2604.804639652024;2606.6741657292837;2611.033917450546;2539.415934335104;2572.511222867649;2584.289320436876;2593.5461294273523;2599.129291687287;2483.987580062106;2553.9233822985248;2611.8302310349864;2619.2011436511857;2623.199924023172;2483.466054798218;2498.2380373986016;2501.9116684242413;2522.281149872296;2524.482481091372;2470.209532949457;2470.703515578124;2480.231128350217;2503.5243303772227;2521.1176088369107;9614.086661767122;9714.077162669535;9741.853872191923;9782.902170978341;9830.754231144207;5844.649321040709;5987.371326010793;6001;6013.849653758691;6020.096985452174;3506.386382383073;3630.219502806909;3687.907802304937;3694.556653201633;3716.256748650254;1198.7362780188344;1250.9437075331632;1251.7482517482517;1258.5028913579176;1261.5584545409124;14452.349644266033;14478.92760536201;14595.489157879529;14677.559673209715;14732.18972956487;4981.601471882241;4984.252362145708;5071.39143302806;5072.771725272371;5075.771590278447;11118.666440006813;11204.551817927191;11228.270162439416;11257.605983790529;11268.436578171222;5673.205751194753;5794.594378393472;5797.826065218051;5843.03589907669;5851.707414629252;4792.161371759928;5206.947930520722;5341.732913354394;5355.303810504687;5483.095289277305;4115.682981445909;4150.169966006811;4161.812718427678;4244.511881133647;4259;1230.1081715756006;1242.863285038645;1252.2987127208792;1253.5361916090922;1255.2405794494382;999.5352161244911;1017.7455636090978;1047.4657924458581;1112.3103675721104;1138.703936976392;6675.265720770809;6807.421369183675;6955.200151982587;6997.510174287852;7081.964590177119;463.6615270852297;465.31133921795254;468.9157438708884;480.46188269138787;484.04401307417567;4786.0667169901535;4826.975865120652;4848.17581011229;4871.171900776876;4898.436679781799;12169.939150304192;12485.93757031209;12596.937015314865;12607.558735444216;12621.684457888627;11863.762724745457;12343.814842777365;12371.566995155126;12530;12540.122191446511;8898.555072246361;8982.685606003759;9056.320775941698;9060.81878362429;9114.772130696652;6719.126513553207;6965.373116419547;6965.825854353479;7022.297770223141;7150.821229469097;11340.829887551528;11442.656720298404;11623;11645.76708465843;11701.590444334748;11837.46731397072;11846.881531184923;11929.522819087138;11947.402629868298;11954.760904781682;8934.195922367018;8954.507502087186;8962.68630597926;9039.23166530826;9044.366894317334;9443.197328226903;9475.194608458083;9512.286578506779;9558.761030974281;9590.952045239728;8587.527685977331;8647.178518040777;8695.521746304014;8740.34447416459;8747.868781968149;8403.579821009047;8424.4945303282;8458.238758511763;8500.277476414327;8564.48613083217;7588;7600.771976840703;7636.885446718193;7646.770596882103;7699.076110866732;5700.771969121189;5729.455701708331;5746.597738158289;5768.105943578752;5800.361960184461;5839.182514447895;5846.970765146317;5939.46544810969;5982.312034116132;6015.639061656315 05:40:22 INFO - PROCESS | 20977 | |4;prototype.html;341.85129468681123;346.565060848635;348.23214811340995;353.11368465152475;353.75590842318815;5824.271966004249;5835.795747148851;5843.123531470282;5871.765129394825;5893.557983151265;5761.337446193689;5770.740316685748;5779.855503612412;5783.739731712072;5787.971060144693;4074.653654439369;4409.9857032882455;4432.822687092513;4445.755483448409;4446.533114023029;4417.182821178077;4433.246348120827;4444.644428445733;4452.708714472799;4459.799309031101;4401.933970990438;4404.625606823424;4419.663154318485;4420.138073075752;4421.403110580079;4256.829726810924;4378.2784633061965;4395.428594282723;4403.779811009436;4407.20670279348;3875.748076375027;3882.233583719401;3889.144388234584;3890.610938906115;3896.181801821621;5533.1976863354585;5535.916961245584;5538.584606154554;5552.3892371839065;5557.7209446426805;4873.6832105913;5054;5056.544910957995;5059.2916991621205;5066.138756411419;5932.792352267693;5961.344252132305;5992.820215393502;6047.5766696331275;6056.121862329937;4285.892852678677;4292.390353617394;4298.978505107486;4307.590778876001;4316.503602085769;6004.609700369462;6297.748090076391;6310.5898116622275;6310.8640444720395;6334.841628959267;4305.720128191658;4360.302351623725;4365.410669559569;4373.781310934441;4382.167388196232;4420.823167073281;4427.339747594652;4438.622717069021;4441.467023957146;4445.51099379068;4839.927401088987;5089.262057001714;5099.337086178847;5104.183330667075;5112.795488180505;6084.543659225487;6087.969560152171;6089.5737298388685;6121.663308517986;6140.478059365004;1500.864922157011;1504.4734342979868;1531.1502116325546;1531.9770203446958;1533.172087072968;955.5952749458285;1005.2812239248972;1026.6201505442884;1028.4138041316378;1029.5572903651353;5858.882822343615;5889.204957330791;5889.882202356014;5893.970530147321;5905.616134951214;6128.682333298362;6190.50475961922;6195.752169913153;6233.594816337014;6264.342244064399;5653.575981801381;5905.616134951214;5935.465808077208;5981.700914954235;5984.640921544721;3325.617553981275;3348.8995330140133;3361.83190840457;3362.7309815214726;3370.7808992415416;6170.475509581646;6415.454686351619;6460.512702609529;6473.838154046092;6476.417122459001;6356.650384228819;6363.363663633692;6407.871842563122;6423.325550817191;6445.484361251089;6173.8456538586;6444.323346048691;6485.573173901828;6511;6518.57629254097;6277.780277690259;6356.77751278703;6370.649614271259;6371;6378.170837791057;6047.5464340173785;6229.034499652561;6249.593776404519;6256.405641464054;6262.15460912771;6331.461825744679;6470.48236141117;6498.285188629342;6561.637810388352;6568;4334.826606935813;4341.500727416261;4373.890652733707;4399.14216727735;4415.072834704748;6072.423119803611;6310.29622002066;6323.399277068671;6333.429991300805;6335.271443784024;6140.416660417253;6142.447179753844;6151.846203844761;6160.784372547118;6178.691065446799;5871.882562348815;6144.078388241799;6149.354317796567;6161.876762464815;6168.568200225941;5960.552958528041;6026;6028.854517641634;6066.696665166813;6096.8780624388155;6091.817245482643;6099.75600975956;6123.877522449437;6154.753809847735;6158.291796443287;5839.445252700986;5892.970535147297;5930.458080898911;5998.49012833914;6025.969870150797 05:40:22 INFO - PROCESS | 20977 | |5;yui.html;738.7192866710649;760.5018712743155;787.1852632525338;849.4139044059599;877.5261358866211;16084.919575402122;16759.329626814913;16768.83231167688;16772.49682509525;16797.244124014418;15932.761008584852;16077.517674469755;16082.678346433064;16175.676486470293;16179.514614561582;735.8712225360567;863.7236084452977;890.1988210610438;893.7720881175292;893.9910600893973;885.5041176940933;889.0975659705405;893.1247377569986;894.8523493623577;896.1307531694279;941.5104145844157;942.9339946203769;945.0832692288469;951.1582249708988;953.1850268020846;934.8083642853198;941.8822647169104;943.580106852451;945.6359301668838;949.7578117580008;688.703857341343;693.0470602920983;694.1150033707014;694.2502097734434;694.9583025018516;15967.680646387007;16027.759583606256;16106.208840077177;16108.919455402765;16153.4346297879;15942.760858587131;16067.678646427006;16102.75845862313;16380.180990950405;16427.932184408095;11839.545869556594;12527.310997895112;13162.802557961639;13471.528496502673;13808.309584520734;4643.349931009661;4671.7853358126795;4731.1720448921305;4751.667383283171;4774.618030557547;66382;66742;66976.3302366975;68004.31995680078;69794.65102674454;12457.563985260473;12584.622461326175;12766.872331276754;12891.871081289255;13031.609051728463;22459.663105053438;22613.88693056557;22628;22644;22710.31869043931;9224.301911661178;9411.294152938557;9446.716598502057;9451.716448506555;9478.289128315404;4903.06841700083;4929.3345398371475;4962.826301079517;4963.106640804617;5076.644634875597;3666.3400587893902;3733.4026555750947;3768.773873567595;3771.4719939208535;3775.131719704483;634.9396807303299;635.5678138865524;638.1321402892063;649.1172006071739;649.5940037476577;662.4336192555392;732.4945787406672;734.4308161175132;739.6671497826;750.3809357280265;10058.346207496636;10558.788824223626;10724.14206863449;10843.822890194053;10991.505382257817;732.5824280160258;745.3143108340231;757.6439073635382;760.5094713909608;764.7246991083206;5285.68285902847;5355.732213389315;5413.106837371868;5419.810306639249;5443.727813609304;115092.42453787845;117595.41202293934;117753;119342.40328798474;119713;96710.5164474173;96852;97793;102190;102709;88820;89969.10030899738;90142.54928725446;90192.5490372544;93573;9657.179139773198;9766.265445675223;9837.508124593598;10146.441945693057;10241.487925603838;46305.305420418044;47520.52479475161;53341;53988.460115398346;55050;51313.48686513236;52508.474915251885;63080.68459657672;74571;76544.2345576537;13582.320883955961;14162.93777966636;14310.642233944234;14362.928185359006;14496.275186240435;15837.920810395874;15930.283137258619;16359.100249485917;16392.918035409748;17012;14899.478518252243;15173.165475898932;15273.847261527242;15276.694466110393;15592.844071559139;13497.86502134966;13507.747193172709;13958.930205348908;14493.347799349265;14940.327685254408;14272.785908211592;14575.708485830011;15109.848901510844;15133;15264.313105910038;11035.779284414428;11865.644030679094;12205.633830985085;12669.556565520163;12680.048996325497;12342.13605047638;12425.875741242471;12519.874801251872;12820;12886.67783305425 05:40:22 INFO - PROCESS | 20977 | __end_tp_report 05:40:22 INFO - PROCESS | 20977 | __start_cc_report 05:40:22 INFO - PROCESS | 20977 | _x_x_mozilla_cycle_collect,333 05:40:22 INFO - PROCESS | 20977 | __end_cc_report 05:40:22 INFO - PROCESS | 20977 | __startTimestamp1466772022820__endTimestamp 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | ------- Summary: start ------- 05:40:22 INFO - PROCESS | 20977 | Number of tests: 6 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#0] dojo.html Cycles:165 Average:5797.79 Median:6084.51 stddev:669.81 (11.0%) stddev-sans-first:645.12 05:40:22 INFO - PROCESS | 20977 | Values: 3409.2 3426.7 3427.4 3459.0 3465.8 5733.9 5756.5 5806.8 5819.0 5875.4 5798.5 5888.0 5888.5 5896.6 5898.6 5264.7 5281.5 5291.7 5302.4 5334.3 5218.4 5238.4 5269.7 5331.8 5357.7 5270.9 5281.6 5299.0 5315.3 5326.5 5367.4 5374.9 5376.5 5400.2 5410.7 5098.4 5110.6 5170.5 5259.9 5266.3 5628.7 5666.5 5696.5 5697.9 5703.6 6144.5 6176.7 6187.3 6192.0 6196.7 6118.4 6126.1 6132.8 6136.1 6234.7 5776.7 5777.7 5812.9 5826.1 5835.2 6371.9 6382.2 6382.4 6387.5 6387.9 6034.8 6076.8 6099.6 6110.8 6135.7 6224.7 6234.4 6272.8 6290.4 6297.3 6131.0 6180.5 6250.2 6254.0 6255.9 6149.6 6211.9 6232.3 6294.7 6308.3 4685.4 4710.4 4725.2 4743.0 4766.0 4143.6 4154.5 4170.5 4220.7 4257.4 5752.6 5902.0 5909.9 5979.4 6005.7 6307.8 6330.9 6341.8 6348.4 6356.9 5869.6 5957.2 6023.5 6035.1 6046.9 5220.1 5257.9 5308.9 5311.3 5329.8 6479.0 6509.3 6546.7 6548.8 6551.7 6120.8 6168.9 6273.3 6369.0 6375.6 6358.0 6471.3 6474.6 6482.7 6495.6 6189.1 6196.1 6196.3 6205.4 6224.3 6048.0 6201.6 6238.3 6279.0 6288.4 6128.5 6129.7 6129.8 6131.6 6150.1 6131.9 6160.2 6197.4 6198.6 6208.5 5810.8 6011.9 6055.5 6064.3 6084.5 6203.0 6218.3 6227.8 6253.7 6267.0 6111.5 6116.4 6126.6 6127.4 6132.7 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#1] ext.html Cycles:180 Average:66856.00 Median:42621.29 stddev:144902.19 (340.0%) stddev-sans-first:145223.26 05:40:22 INFO - PROCESS | 20977 | Values: 588.1 643.5 657.5 662.4 684.2 40458.0 45713.5 45797.5 45833.0 46117.5 47357.0 48062.5 48093.3 48105.8 48217.0 8922.3 9112.5 9114.4 9126.3 9134.3 8994.8 9098.8 9100.7 9115.3 9117.7 9086.2 9125.9 9126.0 9170.3 9178.8 9041.1 9071.3 9089.3 9096.8 9131.8 8973.0 9051.7 9051.9 9054.2 9114.1 43579.3 43838.1 43995.3 44080.6 44193.8 3914.0 4111.3 4233.4 4295.7 4626.5 35829.6 36544.8 36565.0 36715.3 36786.3 4610.4 4763.6 4805.4 4823.2 4845.5 375032.0 377751.0 378855.0 380106.0 380707.0 67277.3 67849.7 67871.7 67912.0 68331.0 38476.0 39472.4 39528.4 41786.6 41815.8 19876.8 19989.9 20006.3 20075.7 20123.8 14030.5 14033.9 14050.3 14081.8 14107.2 21216.5 21324.5 21409.7 21457.0 21495.1 7354.3 7440.6 7456.0 7565.0 7641.3 989.5 1003.9 1081.3 1089.1 1113.4 32442.5 33203.5 33415.3 33492.3 33698.0 1172.6 1229.6 1237.0 1260.4 1295.8 17318.0 17596.1 17771.4 17804.6 17837.8 587068.0 632639.0 810194.0 832512.0 840946.0 60657.7 61197.0 61473.0 61512.7 61563.7 1401.2 1454.9 1460.9 1468.8 1506.1 31172.2 31572.0 31573.4 32130.4 32839.8 51793.7 52155.0 52321.2 52508.2 52556.7 412809.0 416432.0 417172.0 418430.0 420056.0 29838.6 29971.1 30702.8 30892.0 30983.0 48265.8 48635.0 49176.5 49743.0 50066.2 41836.1 43009.8 43054.4 43209.6 43761.6 41299.4 41328.8 42061.0 42392.4 42821.0 41158.4 42600.1 42611.0 42631.6 42632.4 35397.1 35449.5 36131.8 36743.0 36930.4 27772.0 28154.9 28232.6 28487.0 28615.6 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#2] jquery.html Cycles:180 Average:30316.44 Median:24709.88 stddev:84344.14 (341.3%) stddev-sans-first:84550.87 05:40:22 INFO - PROCESS | 20977 | Values: 415.2 419.4 422.3 424.9 439.4 18774.7 19717.5 20487.8 21408.0 21508.4 17340.6 18821.9 19156.0 19873.4 20804.7 5950.1 6116.6 6131.6 6146.6 6173.1 5819.4 6095.0 6099.6 6100.5 6101.0 5876.3 5961.4 6007.2 6014.5 6052.3 6023.8 6082.8 6084.0 6090.9 6093.1 5183.8 5289.3 5368.3 5397.7 5440.1 24053.0 24269.5 24651.3 24768.5 24878.3 2537.7 2579.9 2624.5 2636.2 2857.4 14814.5 15180.5 15189.2 15427.4 15792.1 1985.0 2053.5 2096.0 2105.6 2142.1 82179.0 83374.0 83719.6 84357.6 84610.0 11083.7 11548.8 11602.0 11650.5 11770.8 14172.8 16136.8 16249.1 16252.8 16279.7 8573.8 8913.4 8979.8 9334.3 9497.3 9050.3 9187.2 9237.0 9386.7 9486.8 6778.6 7189.4 7206.2 7310.9 7411.1 1970.5 1988.1 1988.5 2037.9 2050.7 928.5 982.0 1038.4 1055.1 1169.5 19853.4 20126.2 20127.4 20409.1 20801.9 1084.8 1136.7 1139.2 1143.9 1144.3 11342.9 11393.8 11465.3 11553.5 11658.9 506970.0 508352.0 510662.0 519420.0 520106.0 82372.6 87785.0 88019.6 88037.6 88211.6 1086.4 1100.8 1111.2 1112.8 1126.4 16570.6 17666.2 17891.9 18363.3 18383.3 42248.2 43293.4 43685.6 43915.0 44643.1 59820.0 61307.7 61577.7 62104.1 62384.4 8962.4 9033.1 9044.9 9150.3 9313.8 10368.8 13738.2 14080.0 14235.0 14618.6 11801.0 12145.3 12259.6 12457.3 12557.8 11983.7 12000.3 12149.6 12354.4 12806.4 12301.8 12319.6 12340.9 12353.4 13084.3 9071.8 9197.2 9201.8 9366.9 9372.7 12139.2 12259.8 12263.4 12335.1 12485.9 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#3] mootools.html Cycles:180 Average:6522.80 Median:4789.11 stddev:3823.19 (79.8%) stddev-sans-first:3815.22 05:40:22 INFO - PROCESS | 20977 | Values: 1490.9 1529.5 1716.7 1858.8 1874.6 9484.6 9999.8 10225.8 10294.4 10303.2 9708.9 9881.1 9947.5 9967.8 9997.6 2562.2 2579.5 2604.8 2606.7 2611.0 2539.4 2572.5 2584.3 2593.5 2599.1 2484.0 2553.9 2611.8 2619.2 2623.2 2483.5 2498.2 2501.9 2522.3 2524.5 2470.2 2470.7 2480.2 2503.5 2521.1 9614.1 9714.1 9741.9 9782.9 9830.8 5844.6 5987.4 6001.0 6013.8 6020.1 3506.4 3630.2 3687.9 3694.6 3716.3 1198.7 1250.9 1251.7 1258.5 1261.6 14452.3 14478.9 14595.5 14677.6 14732.2 4981.6 4984.3 5071.4 5072.8 5075.8 11118.7 11204.6 11228.3 11257.6 11268.4 5673.2 5794.6 5797.8 5843.0 5851.7 4792.2 5206.9 5341.7 5355.3 5483.1 4115.7 4150.2 4161.8 4244.5 4259.0 1230.1 1242.9 1252.3 1253.5 1255.2 999.5 1017.7 1047.5 1112.3 1138.7 6675.3 6807.4 6955.2 6997.5 7082.0 463.7 465.3 468.9 480.5 484.0 4786.1 4827.0 4848.2 4871.2 4898.4 12169.9 12485.9 12596.9 12607.6 12621.7 11863.8 12343.8 12371.6 12530.0 12540.1 8898.6 8982.7 9056.3 9060.8 9114.8 6719.1 6965.4 6965.8 7022.3 7150.8 11340.8 11442.7 11623.0 11645.8 11701.6 11837.5 11846.9 11929.5 11947.4 11954.8 8934.2 8954.5 8962.7 9039.2 9044.4 9443.2 9475.2 9512.3 9558.8 9591.0 8587.5 8647.2 8695.5 8740.3 8747.9 8403.6 8424.5 8458.2 8500.3 8564.5 7588.0 7600.8 7636.9 7646.8 7699.1 5700.8 5729.5 5746.6 5768.1 5800.4 5839.2 5847.0 5939.5 5982.3 6015.6 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#4] prototype.html Cycles:180 Average:5101.41 Median:5871.82 stddev:1529.60 (26.0%) stddev-sans-first:1491.59 05:40:22 INFO - PROCESS | 20977 | Values: 341.9 346.6 348.2 353.1 353.8 5824.3 5835.8 5843.1 5871.8 5893.6 5761.3 5770.7 5779.9 5783.7 5788.0 4074.7 4410.0 4432.8 4445.8 4446.5 4417.2 4433.2 4444.6 4452.7 4459.8 4401.9 4404.6 4419.7 4420.1 4421.4 4256.8 4378.3 4395.4 4403.8 4407.2 3875.7 3882.2 3889.1 3890.6 3896.2 5533.2 5535.9 5538.6 5552.4 5557.7 4873.7 5054.0 5056.5 5059.3 5066.1 5932.8 5961.3 5992.8 6047.6 6056.1 4285.9 4292.4 4299.0 4307.6 4316.5 6004.6 6297.7 6310.6 6310.9 6334.8 4305.7 4360.3 4365.4 4373.8 4382.2 4420.8 4427.3 4438.6 4441.5 4445.5 4839.9 5089.3 5099.3 5104.2 5112.8 6084.5 6088.0 6089.6 6121.7 6140.5 1500.9 1504.5 1531.2 1532.0 1533.2 955.6 1005.3 1026.6 1028.4 1029.6 5858.9 5889.2 5889.9 5894.0 5905.6 6128.7 6190.5 6195.8 6233.6 6264.3 5653.6 5905.6 5935.5 5981.7 5984.6 3325.6 3348.9 3361.8 3362.7 3370.8 6170.5 6415.5 6460.5 6473.8 6476.4 6356.7 6363.4 6407.9 6423.3 6445.5 6173.8 6444.3 6485.6 6511.0 6518.6 6277.8 6356.8 6370.6 6371.0 6378.2 6047.5 6229.0 6249.6 6256.4 6262.2 6331.5 6470.5 6498.3 6561.6 6568.0 4334.8 4341.5 4373.9 4399.1 4415.1 6072.4 6310.3 6323.4 6333.4 6335.3 6140.4 6142.4 6151.8 6160.8 6178.7 5871.9 6144.1 6149.4 6161.9 6168.6 5960.6 6026.0 6028.9 6066.7 6096.9 6091.8 6099.8 6123.9 6154.8 6158.3 5839.4 5893.0 5930.5 5998.5 6026.0 05:40:22 INFO - PROCESS | 20977 | 05:40:22 INFO - PROCESS | 20977 | [#5] yui.html Cycles:180 Average:21078.24 Median:4657.57 stddev:29450.48 (632.3%) stddev-sans-first:29493.49 05:40:22 INFO - PROCESS | 20977 | Values: 738.7 760.5 787.2 849.4 877.5 16084.9 16759.3 16768.8 16772.5 16797.2 15932.8 16077.5 16082.7 16175.7 16179.5 735.9 863.7 890.2 893.8 894.0 885.5 889.1 893.1 894.9 896.1 941.5 942.9 945.1 951.2 953.2 934.8 941.9 943.6 945.6 949.8 688.7 693.0 694.1 694.3 695.0 15967.7 16027.8 16106.2 16108.9 16153.4 15942.8 16067.7 16102.8 16380.2 16427.9 11839.5 12527.3 13162.8 13471.5 13808.3 4643.3 4671.8 4731.2 4751.7 4774.6 66382.0 66742.0 66976.3 68004.3 69794.7 12457.6 12584.6 12766.9 12891.9 13031.6 22459.7 22613.9 22628.0 22644.0 22710.3 9224.3 9411.3 9446.7 9451.7 9478.3 4903.1 4929.3 4962.8 4963.1 5076.6 3666.3 3733.4 3768.8 3771.5 3775.1 634.9 635.6 638.1 649.1 649.6 662.4 732.5 734.4 739.7 750.4 10058.3 10558.8 10724.1 10843.8 10991.5 732.6 745.3 757.6 760.5 764.7 5285.7 5355.7 5413.1 5419.8 5443.7 115092.4 117595.4 117753.0 119342.4 119713.0 96710.5 96852.0 97793.0 102190.0 102709.0 88820.0 89969.1 90142.5 90192.5 93573.0 9657.2 9766.3 9837.5 10146.4 10241.5 46305.3 47520.5 53341.0 53988.5 55050.0 51313.5 52508.5 63080.7 74571.0 76544.2 13582.3 14162.9 14310.6 14362.9 14496.3 15837.9 15930.3 16359.1 16392.9 17012.0 14899.5 15173.2 15273.8 15276.7 15592.8 13497.9 13507.7 13958.9 14493.3 14940.3 14272.8 14575.7 15109.8 15133.0 15264.3 11035.8 11865.6 12205.6 12669.6 12680.0 12342.1 12425.9 12519.9 12820.0 12886.7 05:40:22 INFO - PROCESS | 20977 | -------- Summary: end -------- 05:40:22 INFO - PROCESS | 20977 | 05:40:23 INFO - TEST-INFO | 20977: exit 0 05:40:23 INFO - TEST-OK | dromaeo_css | took 1110594ms 05:40:23 INFO - TEST-START | kraken 05:40:23 INFO - operating with platform_type : linux_ 05:40:23 INFO - Initialising browser for kraken test... 05:40:23 INFO - TEST-INFO | started process 21226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFHMQS/profile http://localhost:52022/getInfo.html) 05:40:28 INFO - PROCESS | 21226 | __metrics Screen width/height:1600/1200 05:40:28 INFO - PROCESS | 21226 | colorDepth:24 05:40:28 INFO - PROCESS | 21226 | Browser inner width/height: 1024/697 05:40:28 INFO - PROCESS | 21226 | __metrics 05:40:29 ERROR - PROCESS | 21226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:40:29 INFO - TEST-INFO | 21226: exit 0 05:40:29 INFO - Browser initialized. 05:40:29 INFO - Running cycle 1/1 for kraken test... 05:40:29 INFO - TEST-INFO | started process 21353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEFHMQS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:41 INFO - PROCESS | 21353 | RSS: Main: 155955200 05:40:41 INFO - PROCESS | 21353 | 05:40:44 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52022/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:45 INFO - PROCESS | 21353 | RSS: Main: 161554432 05:40:45 INFO - PROCESS | 21353 | 05:40:47 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52022/tests/kraken/driver.html?testName=audio-dft) 05:40:48 INFO - PROCESS | 21353 | RSS: Main: 160694272 05:40:48 INFO - PROCESS | 21353 | 05:40:51 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52022/tests/kraken/driver.html?testName=audio-fft) 05:40:51 INFO - PROCESS | 21353 | RSS: Main: 161599488 05:40:51 INFO - PROCESS | 21353 | 05:40:53 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52022/tests/kraken/driver.html?testName=audio-oscillator) 05:40:54 INFO - PROCESS | 21353 | RSS: Main: 161050624 05:40:54 INFO - PROCESS | 21353 | 05:40:56 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52022/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:57 INFO - PROCESS | 21353 | RSS: Main: 160886784 05:40:57 INFO - PROCESS | 21353 | 05:41:00 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52022/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:01 INFO - PROCESS | 21353 | RSS: Main: 160759808 05:41:01 INFO - PROCESS | 21353 | 05:41:04 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52022/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:05 INFO - PROCESS | 21353 | RSS: Main: 161468416 05:41:05 INFO - PROCESS | 21353 | 05:41:07 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52022/tests/kraken/driver.html?testName=json-parse-financial) 05:41:08 INFO - PROCESS | 21353 | RSS: Main: 160899072 05:41:08 INFO - PROCESS | 21353 | 05:41:10 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52022/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:10 INFO - PROCESS | 21353 | RSS: Main: 160849920 05:41:10 INFO - PROCESS | 21353 | 05:41:12 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:13 INFO - PROCESS | 21353 | RSS: Main: 160903168 05:41:13 INFO - PROCESS | 21353 | 05:41:15 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:15 INFO - PROCESS | 21353 | RSS: Main: 161669120 05:41:15 INFO - PROCESS | 21353 | 05:41:18 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:18 INFO - PROCESS | 21353 | RSS: Main: 162095104 05:41:18 INFO - PROCESS | 21353 | 05:41:21 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:22 INFO - PROCESS | 21353 | RSS: Main: 161767424 05:41:22 INFO - PROCESS | 21353 | 05:41:23 INFO - PROCESS | 21353 | Cycle 1(1): loaded http://localhost:52022/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52022/tests/kraken/driver.html?testName=ai-astar) 05:41:24 INFO - PROCESS | 21353 | RSS: Main: 162357248 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | __start_tp_report 05:41:24 INFO - PROCESS | 21353 | _x_x_mozilla_page_load 05:41:24 INFO - PROCESS | 21353 | _x_x_mozilla_page_load_details 05:41:24 INFO - PROCESS | 21353 | |i|pagename|runs| 05:41:24 INFO - PROCESS | 21353 | |0;ai-astar;112;105;111;110;111;111;112;110;111;110 05:41:24 INFO - PROCESS | 21353 | |1;audio-beat-detection;168;125;160;182;126;149;150;126;192;137 05:41:24 INFO - PROCESS | 21353 | |2;audio-dft;162;164;173;166;162;162;163;162;163;164 05:41:24 INFO - PROCESS | 21353 | |3;audio-fft;77;86;75;168;76;75;74;76;165;76 05:41:24 INFO - PROCESS | 21353 | |4;audio-oscillator;84;84;143;88;85;85;149;85;85;143 05:41:24 INFO - PROCESS | 21353 | |5;imaging-gaussian-blur;118;117;118;118;117;118;118;119;117;117 05:41:24 INFO - PROCESS | 21353 | |6;imaging-darkroom;146;149;147;147;146;148;148;150;148;146 05:41:24 INFO - PROCESS | 21353 | |7;imaging-desaturate;95;100;95;95;95;99;96;96;96;95 05:41:24 INFO - PROCESS | 21353 | |8;json-parse-financial;51;51;52;53;51;60;52;53;50;52 05:41:24 INFO - PROCESS | 21353 | |9;json-stringify-tinderbox;60;60;60;60;60;60;60;60;60;59 05:41:24 INFO - PROCESS | 21353 | |10;stanford-crypto-aes;78;79;76;76;82;82;77;78;111;76 05:41:24 INFO - PROCESS | 21353 | |11;stanford-crypto-ccm;127;124;126;119;118;117;118;122;124;134 05:41:24 INFO - PROCESS | 21353 | |12;stanford-crypto-pbkdf2;159;161;152;161;153;155;157;151;155;159 05:41:24 INFO - PROCESS | 21353 | |13;stanford-crypto-sha256-iterative;63;62;63;61;61;66;60;61;61;62 05:41:24 INFO - PROCESS | 21353 | __end_tp_report 05:41:24 INFO - PROCESS | 21353 | __start_cc_report 05:41:24 INFO - PROCESS | 21353 | _x_x_mozilla_cycle_collect,921 05:41:24 INFO - PROCESS | 21353 | __end_cc_report 05:41:24 INFO - PROCESS | 21353 | __startTimestamp1466772084141__endTimestamp 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | ------- Summary: start ------- 05:41:24 INFO - PROCESS | 21353 | Number of tests: 14 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.03 05:41:24 INFO - PROCESS | 21353 | Values: 112.0 105.0 111.0 110.0 111.0 111.0 112.0 110.0 111.0 110.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.00 stddev:23.89 (15.4%) stddev-sans-first:24.58 05:41:24 INFO - PROCESS | 21353 | Values: 168.0 125.0 160.0 182.0 126.0 149.0 150.0 126.0 192.0 137.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:3.38 (2.1%) stddev-sans-first:3.50 05:41:24 INFO - PROCESS | 21353 | Values: 162.0 164.0 173.0 166.0 162.0 162.0 163.0 162.0 163.0 164.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:37.94 (49.9%) stddev-sans-first:39.70 05:41:24 INFO - PROCESS | 21353 | Values: 77.0 86.0 75.0 168.0 76.0 75.0 74.0 76.0 165.0 76.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:28.98 (34.1%) stddev-sans-first:29.90 05:41:24 INFO - PROCESS | 21353 | Values: 84.0 84.0 143.0 88.0 85.0 85.0 149.0 85.0 85.0 143.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:41:24 INFO - PROCESS | 21353 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 118.0 119.0 117.0 117.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:1.35 (0.9%) stddev-sans-first:1.32 05:41:24 INFO - PROCESS | 21353 | Values: 146.0 149.0 147.0 147.0 146.0 148.0 148.0 150.0 148.0 146.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:95.50 stddev:1.81 (1.9%) stddev-sans-first:1.87 05:41:24 INFO - PROCESS | 21353 | Values: 95.0 100.0 95.0 95.0 95.0 99.0 96.0 96.0 96.0 95.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.00 stddev:2.80 (5.4%) stddev-sans-first:2.92 05:41:24 INFO - PROCESS | 21353 | Values: 51.0 51.0 52.0 53.0 51.0 60.0 52.0 53.0 50.0 52.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 05:41:24 INFO - PROCESS | 21353 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 59.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:78.00 stddev:10.61 (13.6%) stddev-sans-first:11.17 05:41:24 INFO - PROCESS | 21353 | Values: 78.0 79.0 76.0 76.0 82.0 82.0 77.0 78.0 111.0 76.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:124.00 stddev:5.28 (4.3%) stddev-sans-first:5.39 05:41:24 INFO - PROCESS | 21353 | Values: 127.0 124.0 126.0 119.0 118.0 117.0 118.0 122.0 124.0 134.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:158.00 stddev:3.65 (2.3%) stddev-sans-first:3.74 05:41:24 INFO - PROCESS | 21353 | Values: 159.0 161.0 152.0 161.0 153.0 155.0 157.0 151.0 155.0 159.0 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - PROCESS | 21353 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.76 05:41:24 INFO - PROCESS | 21353 | Values: 63.0 62.0 63.0 61.0 61.0 66.0 60.0 61.0 61.0 62.0 05:41:24 INFO - PROCESS | 21353 | -------- Summary: end -------- 05:41:24 INFO - PROCESS | 21353 | 05:41:24 INFO - TEST-INFO | 21353: exit 0 05:41:25 INFO - TEST-OK | kraken | took 61552ms 05:41:25 INFO - SUITE-END | took 1172s 05:41:25 INFO - Completed test suite (00:19:32) 05:41:25 INFO - javascript benchmark 05:41:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7812.53739338555, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3409.198838273006, 3426.657334266575, 3427.400204964131, 3458.982705086474, 3465.826708664566, 5733.942660573393, 5756.51069659079, 5806.796762113332, 5819.0, 5875.412458754123, 5798.478136967672, 5888.0, 5888.528917686585, 5896.646201227929, 5898.646081235118, 5264.657797243177, 5281.471852814707, 5291.708956007418, 5302.416734159258, 5334.306540149775, 5218.425973142951, 5238.3975842778, 5269.65747226431, 5331.840044798662, 5357.651752636086, 5270.894582108355, 5281.551068159192, 5299.046171689094, 5315.282436871012, 5326.493983071602, 5367.436419175989, 5374.892502149935, 5376.542993845528, 5400.189971504266, 5410.675359478424, 5098.413682426494, 5110.5911527078115, 5170.482951704837, 5259.86850328741, 5266.289050978107, 5628.690422026787, 5666.546676265889, 5696.487316141567, 5697.914531282034, 5703.600747947646, 6144.5084393248435, 6176.69116544171, 6187.257529096492, 6192.040233763729, 6196.659183744892, 6118.357572454873, 6126.050462178369, 6132.753252973555, 6136.079588061782, 6234.688265586748, 5776.653400795965, 5777.653340799523, 5812.941870581282, 5826.096954971986, 5835.241418615553, 6371.872562548723, 6382.20222472191, 6382.425581697669, 6387.489000879918, 6387.936120638827, 6034.818955431344, 6076.787312444043, 6099.634021958696, 6110.771402862413, 6135.693215339215, 6224.657643829542, 6234.376562343729, 6272.843178920563, 6290.402411770874, 6297.275813281532, 6131.0, 6180.505559555225, 6250.218722659668, 6253.96873015632, 6255.937440625627, 6149.600275982047, 6211.875762484725, 6232.25212974446, 6294.748210071637, 6308.337624549448, 4685.367475390779, 4710.4347478302825, 4725.243960966229, 4743.02767932573, 4765.9761701191965, 4143.56492568282, 4154.543000269968, 4170.457840480718, 4220.662347012231, 4257.4252475915355, 5752.568557358215, 5902.0, 5909.911351329733, 5979.431953964453, 6005.729742161613, 6307.779227727007, 6330.905036424458, 6341.778037768656, 6348.365163483707, 6356.936430635635, 5869.647821130746, 5957.195778569838, 6023.45788879003, 6035.124906888476, 6046.909296360558, 5220.138677118309, 5257.894842103213, 5308.946910530845, 5311.256424100629, 5329.840104796862, 6478.967605162038, 6509.316521765147, 6546.672666366662, 6548.8035358939305, 6551.705173267214, 6120.816375508742, 6168.907466387918, 6273.343512057686, 6369.0446433034485, 6375.553711240169, 6358.0, 6471.320511346429, 6474.5791523550815, 6482.708278127401, 6495.610263384212, 6189.133521306931, 6196.1015652731, 6196.318404975359, 6205.379462053758, 6224.315325314121, 6047.971844786309, 6201.565890387629, 6238.251409830667, 6278.968605156945, 6288.402601752826, 6128.540359473147, 6129.693515324127, 6129.785457508966, 6131.5601757859595, 6150.138980542638, 6131.8664907781995, 6160.168377269011, 6197.442230199304, 6198.597091189058, 6208.50331973432, 5810.767569297181, 6011.939880601138, 6055.515558755377, 6064.272287325549, 6084.513238940785, 6203.0075187971515, 6218.347073557211, 6227.782027629011, 6253.7185826637, 6266.968665156645, 6111.511079113571, 6116.418940200674, 6126.6017708848785, 6127.3566275540425, 6132.693365331805], "value": 5752.211052421345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.1207594646003, 643.4530648948393, 657.4707360574738, 662.4137638190201, 684.2097377528955, 40458.0, 45713.54286457143, 45797.54202457974, 45832.999999999956, 46117.53882461174, 47357.0, 48062.519374806245, 48093.27860082093, 48105.7594712026, 48217.0, 8922.33082518812, 9112.453252804853, 9114.361994660376, 9126.269898408145, 9134.314926380515, 8994.820103597924, 9098.818023639524, 9100.681476148337, 9115.316351273648, 9117.68088116916, 9086.182243598076, 9125.863112053325, 9126.041765614615, 9170.312226582999, 9178.770530736752, 9041.09589041094, 9071.319651026133, 9089.27285817133, 9096.77258068547, 9131.771705707344, 8972.955135224347, 9051.728448146567, 9051.909480905239, 9054.185123338932, 9114.13415725505, 43579.34630980506, 43838.123237535074, 43995.34006989898, 44080.559194407964, 44193.77903110464, 3913.960860391388, 4111.280525907984, 4233.364995250707, 4295.742255464682, 4626.514216007305, 35829.64170358289, 36544.817275913716, 36565.0, 36715.265694686226, 36786.264274714624, 4610.400647915783, 4763.595094416979, 4805.351277577517, 4823.1800593899125, 4845.515448455127, 375032.0, 377751.0, 378855.0, 380105.9999999972, 380707.0, 67277.32722672808, 67849.66075169592, 67871.66064169648, 67912.0, 68331.0, 38476.0, 39472.40791388132, 39528.40707389391, 41786.582134178876, 41815.79092104581, 19876.801231987494, 19989.900050499655, 20006.29977950794, 20075.698864517042, 20123.798762012484, 14030.508932187324, 14033.859661403256, 14050.297485125702, 14081.788773168411, 14107.224102674247, 21216.469588260108, 21324.466888327606, 21409.67885481719, 21457.0, 21495.14019439205, 7354.264573542603, 7440.627968601549, 7455.962720186473, 7564.962175189089, 7641.2740789624895, 989.4904124375952, 1003.8795344558554, 1081.3133660125877, 1089.1341383600056, 1113.4098927568402, 32442.513362299585, 33203.50194747081, 33415.331693365995, 33492.3301533968, 33698.0, 1172.5895936422185, 1229.6434034130002, 1236.9690757731128, 1260.4454040222456, 1295.8337496253448, 17318.0, 17596.12019399025, 17771.378001769877, 17804.55488612795, 17837.821621783874, 587068.0, 632639.0, 810194.0, 832512.0, 840946.0, 60657.69671151616, 61197.0, 61473.0, 61512.69243653753, 61563.6921815397, 1401.1663060479, 1454.919979401143, 1460.8758255548184, 1468.7870258812413, 1506.0737646347636, 31172.22069448191, 31572.0, 31573.36853262968, 32130.357392851543, 32839.835800820845, 51793.7410312946, 52155.0, 52321.21518177154, 52508.21237681514, 52556.737216313675, 412809.0, 416432.0, 417172.0, 418430.0, 420056.0, 29838.55242171326, 29971.100866974026, 30702.84648576743, 30892.0, 30983.0, 48265.75867120642, 48635.02729945452, 49176.50823491719, 49743.0, 50066.249006265665, 41836.12038469738, 43009.784951075046, 43054.35418468663, 43209.56790432055, 43761.56238437575, 41299.38050929298, 41328.79335603423, 42061.0, 42392.36411453769, 42821.0, 41158.38262426006, 42600.14799703927, 42611.0, 42631.573684264, 42632.36051459169, 35397.1150721234, 35449.46825797667, 36131.81934090313, 36743.0, 36930.44604330991, 27772.0, 28154.85922570374, 28232.576511352756, 28487.0, 28615.570766438937], "value": 21176.697739318228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.18001946156323, 419.4337644180355, 422.2652584502966, 424.9213895429345, 439.3826673523698, 18774.718379224305, 19717.507062323468, 20487.795122048792, 21408.0, 21508.354749357506, 17340.56648583786, 18821.905890470563, 19156.042197890118, 19873.40379788605, 20804.68792968103, 5950.10748387742, 6116.633002019871, 6131.570790044699, 6146.569740118193, 6173.0740388941795, 5819.447152520525, 6094.96952515239, 6099.57302988791, 6100.542459315547, 6100.969495152518, 5876.265466816648, 5961.374055724152, 6007.158997740298, 6014.458698717114, 6052.273727152748, 6023.789167379121, 6082.81751547452, 6083.96572582662, 6090.934086534839, 6093.146959425661, 5183.792648294064, 5289.259503669489, 5368.275282836806, 5397.7031263280505, 5440.129579267338, 24053.0, 24269.514609707883, 24651.260462185983, 24768.5046299073, 24878.253652390456, 2537.6574162488014, 2579.9226023219335, 2624.475104979012, 2636.222314417232, 2857.3713782967716, 14814.481493147796, 15180.544583662508, 15189.240537973168, 15427.3829046838, 15792.131432771193, 1984.9801501985085, 2053.5482193917314, 2095.989520052405, 2105.631514484959, 2142.121730090671, 82179.0, 83373.99999999939, 83719.58140209322, 84357.57821210855, 84610.0, 11083.72290692739, 11548.826767598493, 11602.013828824645, 11650.53397864076, 11770.822917708161, 14172.787408188886, 16136.75794863078, 16249.10629915366, 16252.837471625133, 16279.674406511804, 8573.828523429496, 8913.37606367561, 8979.775505612412, 9334.346595738232, 9497.287703422271, 9050.275977921881, 9187.173154416134, 9236.953815230881, 9386.67146649864, 9486.810263794685, 6778.559393639398, 7189.388901943289, 7206.207317195104, 7310.926890731131, 7411.110666720028, 1970.4975231315923, 1988.125224901068, 1988.5028742814297, 2037.918483260653, 2050.7436570428695, 928.535732133933, 981.9705408837603, 1038.3562191441354, 1055.1031623120286, 1169.5088063013554, 19853.404397868086, 20126.19495220175, 20127.39617811468, 20409.14272001921, 20801.895990520254, 1084.8318510630866, 1136.7499150186945, 1139.2480962564669, 1143.857017872766, 1144.296257801446, 11342.886571134348, 11393.802571452645, 11465.31208127515, 11553.537858485735, 11658.94170529142, 506970.0, 508352.0, 510662.0, 519420.0, 520106.0, 82372.58813705893, 87785.0, 88019.55990220136, 88037.55981220053, 88211.55894220488, 1086.4296244471716, 1100.7963526747578, 1111.2275919907734, 1112.8052590796578, 1126.3748619516084, 16570.58573535623, 17666.205020774352, 17891.910540447214, 18363.26546938161, 18383.26466941361, 42248.155036899705, 43293.35059974166, 43685.56314436815, 43915.0, 44643.10713785771, 59820.0, 61307.693461532406, 61577.69211153915, 62104.06843897255, 62384.376156239676, 8962.417442866194, 9033.096690330914, 9044.909550904407, 9150.267978561566, 9313.767155821159, 10368.844467333147, 13738.244396557886, 14080.0, 14235.0, 14618.634534136732, 11801.0, 12145.332006739714, 12259.632211033684, 12457.252564846138, 12557.811632825698, 11983.700407489883, 12000.279983201035, 12149.635510934686, 12354.382280886099, 12806.359682015676, 12301.75396492083, 12319.63041108768, 12340.938295308466, 12353.3823308836, 13084.28036457966, 9071.773205669911, 9197.172254497127, 9201.815963680823, 9366.906330936603, 9372.718818435458, 12139.150259481752, 12259.835315645, 12263.448144833683, 12335.074869384653, 12485.93757031209], "value": 9921.631318286138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.9403623855044, 1529.502911553745, 1716.7424886267058, 1858.7769467663882, 1874.596961653246, 9484.620615175394, 9999.800003999915, 10225.846612300802, 10294.382337059773, 10303.227257955647, 9708.902910970888, 9881.110700037014, 9947.452890091043, 9967.75080622983, 9997.600095996151, 2562.231330600822, 2579.5098931203106, 2604.804639652024, 2606.6741657292837, 2611.033917450546, 2539.415934335104, 2572.511222867649, 2584.289320436876, 2593.5461294273523, 2599.129291687287, 2483.987580062106, 2553.9233822985248, 2611.8302310349864, 2619.2011436511857, 2623.199924023172, 2483.466054798218, 2498.2380373986016, 2501.9116684242413, 2522.281149872296, 2524.482481091372, 2470.209532949457, 2470.703515578124, 2480.231128350217, 2503.5243303772227, 2521.1176088369107, 9614.086661767122, 9714.077162669535, 9741.853872191923, 9782.902170978341, 9830.754231144207, 5844.649321040709, 5987.371326010793, 6001.0, 6013.849653758691, 6020.096985452174, 3506.386382383073, 3630.219502806909, 3687.907802304937, 3694.556653201633, 3716.256748650254, 1198.7362780188344, 1250.9437075331632, 1251.7482517482517, 1258.5028913579176, 1261.5584545409124, 14452.349644266033, 14478.92760536201, 14595.489157879529, 14677.559673209715, 14732.18972956487, 4981.601471882241, 4984.252362145708, 5071.39143302806, 5072.771725272371, 5075.771590278447, 11118.666440006813, 11204.551817927191, 11228.270162439416, 11257.605983790529, 11268.436578171222, 5673.205751194753, 5794.594378393472, 5797.826065218051, 5843.03589907669, 5851.707414629252, 4792.161371759928, 5206.947930520722, 5341.732913354394, 5355.303810504687, 5483.095289277305, 4115.682981445909, 4150.169966006811, 4161.812718427678, 4244.511881133647, 4259.0, 1230.1081715756006, 1242.863285038645, 1252.2987127208792, 1253.5361916090922, 1255.2405794494382, 999.5352161244911, 1017.7455636090978, 1047.4657924458581, 1112.3103675721104, 1138.703936976392, 6675.265720770809, 6807.421369183675, 6955.200151982587, 6997.510174287852, 7081.964590177119, 463.6615270852297, 465.31133921795254, 468.9157438708884, 480.46188269138787, 484.04401307417567, 4786.0667169901535, 4826.975865120652, 4848.17581011229, 4871.171900776876, 4898.436679781799, 12169.939150304192, 12485.93757031209, 12596.937015314865, 12607.558735444216, 12621.684457888627, 11863.762724745457, 12343.814842777365, 12371.566995155126, 12530.0, 12540.122191446511, 8898.555072246361, 8982.685606003759, 9056.320775941698, 9060.81878362429, 9114.772130696652, 6719.126513553207, 6965.373116419547, 6965.825854353479, 7022.297770223141, 7150.821229469097, 11340.829887551528, 11442.656720298404, 11623.0, 11645.76708465843, 11701.590444334748, 11837.46731397072, 11846.881531184923, 11929.522819087138, 11947.402629868298, 11954.760904781682, 8934.195922367018, 8954.507502087186, 8962.68630597926, 9039.23166530826, 9044.366894317334, 9443.197328226903, 9475.194608458083, 9512.286578506779, 9558.761030974281, 9590.952045239728, 8587.527685977331, 8647.178518040777, 8695.521746304014, 8740.34447416459, 8747.868781968149, 8403.579821009047, 8424.4945303282, 8458.238758511763, 8500.277476414327, 8564.48613083217, 7588.0, 7600.771976840703, 7636.885446718193, 7646.770596882103, 7699.076110866732, 5700.771969121189, 5729.455701708331, 5746.597738158289, 5768.105943578752, 5800.361960184461, 5839.182514447895, 5846.970765146317, 5939.46544810969, 5982.312034116132, 6015.639061656315], "value": 5063.624296521448, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.85129468681123, 346.565060848635, 348.23214811340995, 353.11368465152475, 353.75590842318815, 5824.271966004249, 5835.795747148851, 5843.123531470282, 5871.765129394825, 5893.557983151265, 5761.337446193689, 5770.740316685748, 5779.855503612412, 5783.739731712072, 5787.971060144693, 4074.653654439369, 4409.9857032882455, 4432.822687092513, 4445.755483448409, 4446.533114023029, 4417.182821178077, 4433.246348120827, 4444.644428445733, 4452.708714472799, 4459.799309031101, 4401.933970990438, 4404.625606823424, 4419.663154318485, 4420.138073075752, 4421.403110580079, 4256.829726810924, 4378.2784633061965, 4395.428594282723, 4403.779811009436, 4407.20670279348, 3875.748076375027, 3882.233583719401, 3889.144388234584, 3890.610938906115, 3896.181801821621, 5533.1976863354585, 5535.916961245584, 5538.584606154554, 5552.3892371839065, 5557.7209446426805, 4873.6832105913, 5054.0, 5056.544910957995, 5059.2916991621205, 5066.138756411419, 5932.792352267693, 5961.344252132305, 5992.820215393502, 6047.5766696331275, 6056.121862329937, 4285.892852678677, 4292.390353617394, 4298.978505107486, 4307.590778876001, 4316.503602085769, 6004.609700369462, 6297.748090076391, 6310.5898116622275, 6310.8640444720395, 6334.841628959267, 4305.720128191658, 4360.302351623725, 4365.410669559569, 4373.781310934441, 4382.167388196232, 4420.823167073281, 4427.339747594652, 4438.622717069021, 4441.467023957146, 4445.51099379068, 4839.927401088987, 5089.262057001714, 5099.337086178847, 5104.183330667075, 5112.795488180505, 6084.543659225487, 6087.969560152171, 6089.5737298388685, 6121.663308517986, 6140.478059365004, 1500.864922157011, 1504.4734342979868, 1531.1502116325546, 1531.9770203446958, 1533.172087072968, 955.5952749458285, 1005.2812239248972, 1026.6201505442884, 1028.4138041316378, 1029.5572903651353, 5858.882822343615, 5889.204957330791, 5889.882202356014, 5893.970530147321, 5905.616134951214, 6128.682333298362, 6190.50475961922, 6195.752169913153, 6233.594816337014, 6264.342244064399, 5653.575981801381, 5905.616134951214, 5935.465808077208, 5981.700914954235, 5984.640921544721, 3325.617553981275, 3348.8995330140133, 3361.83190840457, 3362.7309815214726, 3370.7808992415416, 6170.475509581646, 6415.454686351619, 6460.512702609529, 6473.838154046092, 6476.417122459001, 6356.650384228819, 6363.363663633692, 6407.871842563122, 6423.325550817191, 6445.484361251089, 6173.8456538586, 6444.323346048691, 6485.573173901828, 6511.0, 6518.57629254097, 6277.780277690259, 6356.77751278703, 6370.649614271259, 6371.0, 6378.170837791057, 6047.5464340173785, 6229.034499652561, 6249.593776404519, 6256.405641464054, 6262.15460912771, 6331.461825744679, 6470.48236141117, 6498.285188629342, 6561.637810388352, 6568.0, 4334.826606935813, 4341.500727416261, 4373.890652733707, 4399.14216727735, 4415.072834704748, 6072.423119803611, 6310.29622002066, 6323.399277068671, 6333.429991300805, 6335.271443784024, 6140.416660417253, 6142.447179753844, 6151.846203844761, 6160.784372547118, 6178.691065446799, 5871.882562348815, 6144.078388241799, 6149.354317796567, 6161.876762464815, 6168.568200225941, 5960.552958528041, 6026.0, 6028.854517641634, 6066.696665166813, 6096.8780624388155, 6091.817245482643, 6099.75600975956, 6123.877522449437, 6154.753809847735, 6158.291796443287, 5839.445252700986, 5892.970535147297, 5930.458080898911, 5998.49012833914, 6025.969870150797], "value": 4608.62050049595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.7192866710649, 760.5018712743155, 787.1852632525338, 849.4139044059599, 877.5261358866211, 16084.919575402122, 16759.329626814913, 16768.83231167688, 16772.49682509525, 16797.244124014418, 15932.761008584852, 16077.517674469755, 16082.678346433064, 16175.676486470293, 16179.514614561582, 735.8712225360567, 863.7236084452977, 890.1988210610438, 893.7720881175292, 893.9910600893973, 885.5041176940933, 889.0975659705405, 893.1247377569986, 894.8523493623577, 896.1307531694279, 941.5104145844157, 942.9339946203769, 945.0832692288469, 951.1582249708988, 953.1850268020846, 934.8083642853198, 941.8822647169104, 943.580106852451, 945.6359301668838, 949.7578117580008, 688.703857341343, 693.0470602920983, 694.1150033707014, 694.2502097734434, 694.9583025018516, 15967.680646387007, 16027.759583606256, 16106.208840077177, 16108.919455402765, 16153.4346297879, 15942.760858587131, 16067.678646427006, 16102.75845862313, 16380.180990950405, 16427.932184408095, 11839.545869556594, 12527.310997895112, 13162.802557961639, 13471.528496502673, 13808.309584520734, 4643.349931009661, 4671.7853358126795, 4731.1720448921305, 4751.667383283171, 4774.618030557547, 66382.0, 66742.0, 66976.3302366975, 68004.31995680078, 69794.65102674454, 12457.563985260473, 12584.622461326175, 12766.872331276754, 12891.871081289255, 13031.609051728463, 22459.663105053438, 22613.88693056557, 22628.0, 22644.0, 22710.31869043931, 9224.301911661178, 9411.294152938557, 9446.716598502057, 9451.716448506555, 9478.289128315404, 4903.06841700083, 4929.3345398371475, 4962.826301079517, 4963.106640804617, 5076.644634875597, 3666.3400587893902, 3733.4026555750947, 3768.773873567595, 3771.4719939208535, 3775.131719704483, 634.9396807303299, 635.5678138865524, 638.1321402892063, 649.1172006071739, 649.5940037476577, 662.4336192555392, 732.4945787406672, 734.4308161175132, 739.6671497826, 750.3809357280265, 10058.346207496636, 10558.788824223626, 10724.14206863449, 10843.822890194053, 10991.505382257817, 732.5824280160258, 745.3143108340231, 757.6439073635382, 760.5094713909608, 764.7246991083206, 5285.68285902847, 5355.732213389315, 5413.106837371868, 5419.810306639249, 5443.727813609304, 115092.42453787845, 117595.41202293934, 117753.0, 119342.40328798474, 119713.0, 96710.5164474173, 96852.0, 97793.0, 102190.0, 102709.0, 88820.0, 89969.10030899738, 90142.54928725446, 90192.5490372544, 93573.0, 9657.179139773198, 9766.265445675223, 9837.508124593598, 10146.441945693057, 10241.487925603838, 46305.305420418044, 47520.52479475161, 53341.0, 53988.460115398346, 55050.0, 51313.48686513236, 52508.474915251885, 63080.68459657672, 74571.0, 76544.2345576537, 13582.320883955961, 14162.93777966636, 14310.642233944234, 14362.928185359006, 14496.275186240435, 15837.920810395874, 15930.283137258619, 16359.100249485917, 16392.918035409748, 17012.0, 14899.478518252243, 15173.165475898932, 15273.847261527242, 15276.694466110393, 15592.844071559139, 13497.86502134966, 13507.747193172709, 13958.930205348908, 14493.347799349265, 14940.327685254408, 14272.785908211592, 14575.708485830011, 15109.848901510844, 15133.0, 15264.313105910038, 11035.779284414428, 11865.644030679094, 12205.633830985085, 12669.556565520163, 12680.048996325497, 12342.13605047638, 12425.875741242471, 12519.874801251872, 12820.0, 12886.67783305425], "value": 8061.27961386828, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 125.0, 160.0, 182.0, 126.0, 149.0, 150.0, 126.0, 192.0, 137.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 173.0, 166.0, 162.0, 162.0, 163.0, 162.0, 163.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 86.0, 75.0, 168.0, 76.0, 75.0, 74.0, 76.0, 165.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 143.0, 88.0, 85.0, 85.0, 149.0, 85.0, 85.0, 143.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 149.0, 147.0, 147.0, 146.0, 148.0, 148.0, 150.0, 148.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 95.0, 95.0, 95.0, 99.0, 96.0, 96.0, 96.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 53.0, 51.0, 60.0, 52.0, 53.0, 50.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 76.0, 76.0, 82.0, 82.0, 77.0, 78.0, 111.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 126.0, 119.0, 118.0, 117.0, 118.0, 122.0, 124.0, 134.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 152.0, 161.0, 153.0, 155.0, 157.0, 151.0, 155.0, 159.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 61.0, 61.0, 66.0, 60.0, 61.0, 61.0, 62.0], "value": 62.0, "unit": "score"}]}]} 05:41:25 INFO - Return code: 0 05:41:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:25 ERROR - # TBPL SUCCESS # 05:41:25 INFO - Running post-action listener: _resource_record_post_action 05:41:25 INFO - ##### 05:41:25 INFO - ##### Finished run-tests step (success) 05:41:25 INFO - ##### 05:41:25 INFO - Running post-run listener: _resource_record_post_run 05:41:25 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509915136; Read time: 12; Write time: 620716 05:41:25 INFO - TinderboxPrint: CPU usage
13.4% 05:41:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:41:25 INFO - TinderboxPrint: I/O write bytes / time
509,915,136 / 620,716 05:41:25 INFO - TinderboxPrint: CPU idle
8,217.0 (86.6%) 05:41:25 INFO - TinderboxPrint: CPU user
1,208.7 (12.7%) 05:41:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:25 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259670016; Read time: 0; Write time: 355492 05:41:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249659392; Read time: 12; Write time: 265212 05:41:26 INFO - Running post-run listener: _upload_blobber_files 05:41:26 INFO - Blob upload gear active. 05:41:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:41:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:27 INFO - (blobuploader) - INFO - Done attempting. 05:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:41:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:31 INFO - (blobuploader) - INFO - Done attempting. 05:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:32 INFO - (blobuploader) - INFO - Done attempting. 05:41:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:32 INFO - Return code: 0 05:41:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc1c5ce7d444c4646be73658fa72a0946c688301509849e9ff4510e8650a2ac9371b676a9391fe38682652b9a9be380119a0c014b00e668e2a8533b80ede7a7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8504525757e4b73dbc69ec7d91856ea3760b5686c381765207d3010fab82d3ef5cc33d2cfa5e63fb1fda343d0eddfb5a98b174ff5e4a19c98a0ac796b1baff02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b07da328b3d0baf24cbaedb865c20c8afbc9e0cb5d150149adb4d1abc8d2f6b895fa7012b48b2e3a15b4b624e82ee6f98f2da984006c62844f9c367370dbf7"} 05:41:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:32 INFO - Contents: 05:41:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc1c5ce7d444c4646be73658fa72a0946c688301509849e9ff4510e8650a2ac9371b676a9391fe38682652b9a9be380119a0c014b00e668e2a8533b80ede7a7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8504525757e4b73dbc69ec7d91856ea3760b5686c381765207d3010fab82d3ef5cc33d2cfa5e63fb1fda343d0eddfb5a98b174ff5e4a19c98a0ac796b1baff02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b07da328b3d0baf24cbaedb865c20c8afbc9e0cb5d150149adb4d1abc8d2f6b895fa7012b48b2e3a15b4b624e82ee6f98f2da984006c62844f9c367370dbf7"} 05:41:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:32 INFO - Copying logs to upload dir... 05:41:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.868181 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-24 05:41:32.160732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:41:32.164056) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc1c5ce7d444c4646be73658fa72a0946c688301509849e9ff4510e8650a2ac9371b676a9391fe38682652b9a9be380119a0c014b00e668e2a8533b80ede7a7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8504525757e4b73dbc69ec7d91856ea3760b5686c381765207d3010fab82d3ef5cc33d2cfa5e63fb1fda343d0eddfb5a98b174ff5e4a19c98a0ac796b1baff02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b07da328b3d0baf24cbaedb865c20c8afbc9e0cb5d150149adb4d1abc8d2f6b895fa7012b48b2e3a15b4b624e82ee6f98f2da984006c62844f9c367370dbf7"} build_url:https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/OzIqfqpEStik9b6brvmCuQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc1c5ce7d444c4646be73658fa72a0946c688301509849e9ff4510e8650a2ac9371b676a9391fe38682652b9a9be380119a0c014b00e668e2a8533b80ede7a7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8504525757e4b73dbc69ec7d91856ea3760b5686c381765207d3010fab82d3ef5cc33d2cfa5e63fb1fda343d0eddfb5a98b174ff5e4a19c98a0ac796b1baff02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56b07da328b3d0baf24cbaedb865c20c8afbc9e0cb5d150149adb4d1abc8d2f6b895fa7012b48b2e3a15b4b624e82ee6f98f2da984006c62844f9c367370dbf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:41:32.192003) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:41:32.192390) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466770857.476022-1347846562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:41:32.278010) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:41:32.278373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:41:32.278741) ========= ========= Total master_lag: 0.17 =========