builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1468101420.66 results: success (0) buildid: 20160709122525 builduid: 1e9bf3169ba849d18c7fe9db278880e9 revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.662551) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.663058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.663373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.708458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.708767) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-09 14:57:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 224M=0s 2016-07-09 14:57:01 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113314 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.860741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.861088) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019684 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.943541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:00.943993) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 --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 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 --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=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-09 14:57:01,633 truncating revision to first 12 chars 2016-07-09 14:57:01,633 Setting DEBUG logging. 2016-07-09 14:57:01,633 attempt 1/10 2016-07-09 14:57:01,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e3b5b3c31e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-09 14:57:02,178 unpacking tar archive at: mozilla-aurora-8e3b5b3c31e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.906204 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:01.871475) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:01.871861) ========= script_repo_revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:01.872352) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:01.872686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-09 14:57:01.890684) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-09 14:57:01.891004) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:57:02 INFO - MultiFileLogger online at 20160709 14:57:02 in /builds/slave/test 14:57:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:57:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:57:02 INFO - {'append_to_log': False, 14:57:02 INFO - 'base_work_dir': '/builds/slave/test', 14:57:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:57:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:57:02 INFO - 'branch': 'Mozilla-Aurora', 14:57:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:57:02 INFO - 'config_files': ('talos/linux_config.py',), 14:57:02 INFO - 'default_actions': ('clobber', 14:57:02 INFO - 'read-buildbot-config', 14:57:02 INFO - 'download-and-extract', 14:57:02 INFO - 'populate-webroot', 14:57:02 INFO - 'create-virtualenv', 14:57:02 INFO - 'install', 14:57:02 INFO - 'run-tests'), 14:57:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:57:02 INFO - 'download_minidump_stackwalk': True, 14:57:02 INFO - 'download_symbols': 'ondemand', 14:57:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:57:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:57:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:57:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:57:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:57:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:57:02 INFO - 'installer_path': 'installer.exe', 14:57:02 INFO - 'log_level': 'info', 14:57:02 INFO - 'log_name': 'talos', 14:57:02 INFO - 'log_to_console': True, 14:57:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:57:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:57:02 INFO - 'opt_config_files': (), 14:57:02 INFO - 'pip_index': False, 14:57:02 INFO - 'sps_profile': False, 14:57:02 INFO - 'sps_profile_interval': 0, 14:57:02 INFO - 'suite': 'dromaeojs', 14:57:02 INFO - 'system_bits': '32', 14:57:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:57:02 INFO - 'title': 'talos-linux64-ix-040', 14:57:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:57:02 INFO - 'use_talos_json': True, 14:57:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:57:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:57:02 INFO - 'work_dir': 'build'} 14:57:02 INFO - ##### 14:57:02 INFO - ##### Running clobber step. 14:57:02 INFO - ##### 14:57:02 INFO - Running pre-action listener: _resource_record_pre_action 14:57:02 INFO - Running main action method: clobber 14:57:02 INFO - rmtree: /builds/slave/test/build 14:57:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:57:03 INFO - Running post-action listener: _resource_record_post_action 14:57:03 INFO - ##### 14:57:03 INFO - ##### Finished clobber step (success) 14:57:03 INFO - ##### 14:57:03 INFO - ##### 14:57:03 INFO - ##### Running read-buildbot-config step. 14:57:03 INFO - ##### 14:57:03 INFO - Running pre-action listener: _resource_record_pre_action 14:57:03 INFO - Running main action method: read_buildbot_config 14:57:03 INFO - Using buildbot properties: 14:57:03 INFO - { 14:57:03 INFO - "project": "", 14:57:03 INFO - "product": "firefox", 14:57:03 INFO - "script_repo_revision": "production", 14:57:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:57:03 INFO - "repository": "", 14:57:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:57:03 INFO - "buildid": "20160709122525", 14:57:03 INFO - "pgo_build": "True", 14:57:03 INFO - "basedir": "/builds/slave/test", 14:57:03 INFO - "buildnumber": 362, 14:57:03 INFO - "slavename": "talos-linux64-ix-040", 14:57:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:57:03 INFO - "platform": "ubuntu64_hw", 14:57:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:57:03 INFO - "branch": "mozilla-aurora", 14:57:03 INFO - "repo_path": "releases/mozilla-aurora", 14:57:03 INFO - "revision": "8e3b5b3c31e5fffedaa5bc253222a6ca567bf421", 14:57:03 INFO - "stage_platform": "linux64-pgo", 14:57:03 INFO - "builduid": "1e9bf3169ba849d18c7fe9db278880e9", 14:57:03 INFO - "slavebuilddir": "test" 14:57:03 INFO - } 14:57:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:57:03 INFO - Running post-action listener: _resource_record_post_action 14:57:03 INFO - ##### 14:57:03 INFO - ##### Finished read-buildbot-config step (success) 14:57:03 INFO - ##### 14:57:03 INFO - ##### 14:57:03 INFO - ##### Running download-and-extract step. 14:57:03 INFO - ##### 14:57:03 INFO - Running pre-action listener: _resource_record_pre_action 14:57:03 INFO - Running main action method: download_and_extract 14:57:03 INFO - mkdir: /builds/slave/test/build/tests 14:57: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')]} 14:57:03 INFO - https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:57:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:57:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:57:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:04 INFO - Downloaded 1361 bytes. 14:57:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:57:04 INFO - Using the following test package requirements: 14:57:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:57:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:57:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:57:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'jsshell-linux-x86_64.zip'], 14:57:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:57:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:57:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:57:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:57:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:57:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:57:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:57:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:57:04 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')]} 14:57:04 INFO - https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:57:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:57:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:05 INFO - Downloaded 24525413 bytes. 14:57: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'] 14:57: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 14:57:07 INFO - Return code: 0 14:57:07 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 14:57: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')]} 14:57:07 INFO - https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:57:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:57:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:08 INFO - Downloaded 24525413 bytes. 14:57:08 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'] 14:57:08 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 14:57:10 INFO - Return code: 0 14:57:10 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')]} 14:57:10 INFO - https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:57:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:57:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:57:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:13 INFO - Downloaded 10833369 bytes. 14:57:13 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'] 14:57:13 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 14:57:13 INFO - Return code: 0 14:57: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')]} 14:57:13 INFO - https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:57:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:57:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:57:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B29I-zWjSGKK5lObJhZaWA/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 14:57:19 INFO - Downloaded 63619827 bytes. 14:57:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:57:19 INFO - mkdir: /builds/slave/test/properties 14:57:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:19 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:19 INFO - Contents: 14:57:19 INFO - build_url:https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:57:20 INFO - Running post-action listener: _resource_record_post_action 14:57:20 INFO - Running post-action listener: set_extra_try_arguments 14:57:20 INFO - ##### 14:57:20 INFO - ##### Finished download-and-extract step (success) 14:57:20 INFO - ##### 14:57:20 INFO - ##### 14:57:20 INFO - ##### Running populate-webroot step. 14:57:20 INFO - ##### 14:57:20 INFO - Running pre-action listener: _resource_record_pre_action 14:57:20 INFO - Running main action method: populate_webroot 14:57:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:20 INFO - '--tppagecycles', 14:57:20 INFO - '7'], 14:57:20 INFO - 'tests': ['tsvgm']}}, 14:57:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:57:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:57:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:57:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['damp', 'tps']}, 14:57:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'tests': ['damp', 'tps']}, 14:57:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['dromaeo_dom']}, 14:57:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'other-e10s': {'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['a11yr', 14:57:20 INFO - 'ts_paint', 14:57:20 INFO - 'tpaint', 14:57:20 INFO - 'sessionrestore', 14:57:20 INFO - 'sessionrestore_no_auto_restore', 14:57:20 INFO - 'tabpaint']}, 14:57:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['tsvgx', 14:57:20 INFO - 'tsvgr_opacity', 14:57:20 INFO - 'tart', 14:57:20 INFO - 'tscrollx', 14:57:20 INFO - 'cart']}, 14:57:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:57:20 INFO - 'tsvgr_opacity', 14:57:20 INFO - 'tart', 14:57:20 INFO - 'tscrollx', 14:57:20 INFO - 'cart']}, 14:57:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'talos_options': ['--disable-e10s'], 14:57:20 INFO - 'tests': ['tp5o']}, 14:57:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'tests': ['tp5o']}, 14:57:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'talos_options': ['--disable-e10s', 14:57:20 INFO - '--xperf_path', 14:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:20 INFO - 'tests': ['tp5n']}, 14:57:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:20 INFO - 'talos_options': ['--xperf_path', 14:57:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:20 INFO - 'tests': ['tp5n']}}, 14:57:20 INFO - 'talos.zip': {'path': '', 14:57:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:20 INFO - Running post-action listener: _resource_record_post_action 14:57:20 INFO - ##### 14:57:20 INFO - ##### Finished populate-webroot step (success) 14:57:20 INFO - ##### 14:57:20 INFO - ##### 14:57:20 INFO - ##### Running create-virtualenv step. 14:57:20 INFO - ##### 14:57:20 INFO - Running pre-action listener: _resource_record_pre_action 14:57:20 INFO - Running main action method: create_virtualenv 14:57:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:20 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 14:57:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:57:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:20 INFO - Using real prefix '/usr' 14:57:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:22 INFO - Installing pip.................done. 14:57:22 INFO - Return code: 0 14:57:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:22 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:22 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 14:57:22 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 14:57:22 INFO - Using env: {'DISPLAY': ':0', 14:57:22 INFO - 'HOME': '/home/cltbld', 14:57:22 INFO - 'LANG': 'en_US.UTF-8', 14:57:22 INFO - 'LANGUAGE': 'en_US:en', 14:57:22 INFO - 'LOGNAME': 'cltbld', 14:57:22 INFO - 'MAIL': '/var/mail/cltbld', 14:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:22 INFO - 'MOZ_NO_REMOTE': '1', 14:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:22 INFO - 'NO_EM_RESTART': '1', 14:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:22 INFO - 'PWD': '/builds/slave/test', 14:57:22 INFO - 'SHELL': '/bin/bash', 14:57:22 INFO - 'SHLVL': '1', 14:57:22 INFO - 'TERM': 'linux', 14:57:22 INFO - 'TMOUT': '86400', 14:57:22 INFO - 'USER': 'cltbld', 14:57:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:22 INFO - '_': '/tools/buildbot/bin/python'} 14:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:22 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 14:57:22 INFO - Cleaning up... 14:57:22 INFO - Return code: 0 14:57:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:22 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:22 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 14:57:22 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 14:57:22 INFO - Using env: {'DISPLAY': ':0', 14:57:22 INFO - 'HOME': '/home/cltbld', 14:57:22 INFO - 'LANG': 'en_US.UTF-8', 14:57:22 INFO - 'LANGUAGE': 'en_US:en', 14:57:22 INFO - 'LOGNAME': 'cltbld', 14:57:22 INFO - 'MAIL': '/var/mail/cltbld', 14:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:22 INFO - 'MOZ_NO_REMOTE': '1', 14:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:22 INFO - 'NO_EM_RESTART': '1', 14:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:22 INFO - 'PWD': '/builds/slave/test', 14:57:22 INFO - 'SHELL': '/bin/bash', 14:57:22 INFO - 'SHLVL': '1', 14:57:22 INFO - 'TERM': 'linux', 14:57:22 INFO - 'TMOUT': '86400', 14:57:22 INFO - 'USER': 'cltbld', 14:57:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:22 INFO - '_': '/tools/buildbot/bin/python'} 14:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:23 INFO - Downloading/unpacking psutil>=3.1.1 14:57: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 14:57: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 14:57: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 14:57: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 14:57: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 14:57: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 14:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:25 INFO - Installing collected packages: psutil 14:57:25 INFO - Running setup.py install for psutil 14:57:25 INFO - building 'psutil._psutil_linux' extension 14:57:25 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 14:57:25 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 14:57:25 INFO - building 'psutil._psutil_posix' extension 14:57:25 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 14:57:25 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 14:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:25 INFO - Successfully installed psutil 14:57:25 INFO - Cleaning up... 14:57:25 INFO - Return code: 0 14:57:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:25 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:25 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 14:57:25 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 14:57:25 INFO - Using env: {'DISPLAY': ':0', 14:57:25 INFO - 'HOME': '/home/cltbld', 14:57:25 INFO - 'LANG': 'en_US.UTF-8', 14:57:25 INFO - 'LANGUAGE': 'en_US:en', 14:57:25 INFO - 'LOGNAME': 'cltbld', 14:57:25 INFO - 'MAIL': '/var/mail/cltbld', 14:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:25 INFO - 'MOZ_NO_REMOTE': '1', 14:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:25 INFO - 'NO_EM_RESTART': '1', 14:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:25 INFO - 'PWD': '/builds/slave/test', 14:57:25 INFO - 'SHELL': '/bin/bash', 14:57:25 INFO - 'SHLVL': '1', 14:57:25 INFO - 'TERM': 'linux', 14:57:25 INFO - 'TMOUT': '86400', 14:57:25 INFO - 'USER': 'cltbld', 14:57:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:25 INFO - '_': '/tools/buildbot/bin/python'} 14:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:57:25 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 14:57:25 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 14:57:25 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 14:57:25 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 14:57:25 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 14:57:25 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 14:57:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:57:27 INFO - Installing collected packages: mozsystemmonitor 14:57:27 INFO - Running setup.py install for mozsystemmonitor 14:57:27 INFO - Successfully installed mozsystemmonitor 14:57:27 INFO - Cleaning up... 14:57:28 INFO - Return code: 0 14:57:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:57: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')]} 14:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:28 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:28 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 14:57:28 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 14:57:28 INFO - Using env: {'DISPLAY': ':0', 14:57:28 INFO - 'HOME': '/home/cltbld', 14:57:28 INFO - 'LANG': 'en_US.UTF-8', 14:57:28 INFO - 'LANGUAGE': 'en_US:en', 14:57:28 INFO - 'LOGNAME': 'cltbld', 14:57:28 INFO - 'MAIL': '/var/mail/cltbld', 14:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:28 INFO - 'MOZ_NO_REMOTE': '1', 14:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:28 INFO - 'NO_EM_RESTART': '1', 14:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:28 INFO - 'PWD': '/builds/slave/test', 14:57:28 INFO - 'SHELL': '/bin/bash', 14:57:28 INFO - 'SHLVL': '1', 14:57:28 INFO - 'TERM': 'linux', 14:57:28 INFO - 'TMOUT': '86400', 14:57:28 INFO - 'USER': 'cltbld', 14:57:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:28 INFO - '_': '/tools/buildbot/bin/python'} 14:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:57:28 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 14:57:28 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 14:57:28 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 14:57:28 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 14:57:28 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 14:57:28 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 14:57:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:30 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:30 INFO - warning: no files found matching '*.txt' 14:57:30 INFO - no previously-included directories found matching 'build' 14:57:30 INFO - no previously-included directories found matching 'dist' 14:57:30 INFO - no previously-included directories found matching '.git*' 14:57:30 INFO - Installing collected packages: jsonschema, functools32 14:57:30 INFO - Running setup.py install for functools32 14:57:30 INFO - warning: no files found matching '*.txt' 14:57:30 INFO - no previously-included directories found matching 'build' 14:57:30 INFO - no previously-included directories found matching 'dist' 14:57:30 INFO - no previously-included directories found matching '.git*' 14:57:30 INFO - Successfully installed jsonschema functools32 14:57:30 INFO - Cleaning up... 14:57:30 INFO - Return code: 0 14:57:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:57:30 INFO - Using env: {'DISPLAY': ':0', 14:57:30 INFO - 'HOME': '/home/cltbld', 14:57:30 INFO - 'LANG': 'en_US.UTF-8', 14:57:30 INFO - 'LANGUAGE': 'en_US:en', 14:57:30 INFO - 'LOGNAME': 'cltbld', 14:57:30 INFO - 'MAIL': '/var/mail/cltbld', 14:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:30 INFO - 'MOZ_NO_REMOTE': '1', 14:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:30 INFO - 'NO_EM_RESTART': '1', 14:57:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:30 INFO - 'PWD': '/builds/slave/test', 14:57:30 INFO - 'SHELL': '/bin/bash', 14:57:30 INFO - 'SHLVL': '1', 14:57:30 INFO - 'TERM': 'linux', 14:57:30 INFO - 'TMOUT': '86400', 14:57:30 INFO - 'USER': 'cltbld', 14:57:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:30 INFO - '_': '/tools/buildbot/bin/python'} 14:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57: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 14:57: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 14:57: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 14:57: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 14:57: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 14:57: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 14:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - Downloading docopt-0.6.1.tar.gz 14:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:33 INFO - Running setup.py install for blobuploader 14:57:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:33 INFO - Running setup.py install for requests 14:57:33 INFO - Running setup.py install for docopt 14:57:34 INFO - Successfully installed blobuploader requests docopt 14:57:34 INFO - Cleaning up... 14:57:34 INFO - Return code: 0 14:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:34 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')]} 14:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:34 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')]} 14:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:34 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:34 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 14:57:34 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 14:57:34 INFO - Using env: {'DISPLAY': ':0', 14:57:34 INFO - 'HOME': '/home/cltbld', 14:57:34 INFO - 'LANG': 'en_US.UTF-8', 14:57:34 INFO - 'LANGUAGE': 'en_US:en', 14:57:34 INFO - 'LOGNAME': 'cltbld', 14:57:34 INFO - 'MAIL': '/var/mail/cltbld', 14:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:34 INFO - 'MOZ_NO_REMOTE': '1', 14:57:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:34 INFO - 'NO_EM_RESTART': '1', 14:57:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:34 INFO - 'PWD': '/builds/slave/test', 14:57:34 INFO - 'SHELL': '/bin/bash', 14:57:34 INFO - 'SHLVL': '1', 14:57:34 INFO - 'TERM': 'linux', 14:57:34 INFO - 'TMOUT': '86400', 14:57:34 INFO - 'USER': 'cltbld', 14:57:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:34 INFO - '_': '/tools/buildbot/bin/python'} 14:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:34 INFO - Running setup.py (path:/tmp/pip-pWLXzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:34 INFO - Running setup.py (path:/tmp/pip-r0EruK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:34 INFO - Running setup.py (path:/tmp/pip-6gcHLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:34 INFO - Running setup.py (path:/tmp/pip-xTSgxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:34 INFO - Running setup.py (path:/tmp/pip-emgpQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:34 INFO - Running setup.py (path:/tmp/pip-MI9_Rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:34 INFO - Running setup.py (path:/tmp/pip-h6UY8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:34 INFO - Running setup.py (path:/tmp/pip-gxz82S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:34 INFO - Running setup.py (path:/tmp/pip-HvivGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:34 INFO - Running setup.py (path:/tmp/pip-aUlFu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:35 INFO - Running setup.py (path:/tmp/pip-IcanLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:35 INFO - Running setup.py (path:/tmp/pip-Rk4h6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:35 INFO - Running setup.py (path:/tmp/pip-RsJosp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:35 INFO - Running setup.py (path:/tmp/pip-NPT4p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:35 INFO - Running setup.py (path:/tmp/pip-fSA8NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:35 INFO - Running setup.py (path:/tmp/pip-5zSV0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:35 INFO - Running setup.py (path:/tmp/pip-IegU9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:35 INFO - Running setup.py install for manifestparser 14:57:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:35 INFO - Running setup.py install for mozcrash 14:57:35 INFO - Running setup.py install for mozdebug 14:57:35 INFO - Running setup.py install for mozdevice 14:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:35 INFO - Running setup.py install for mozfile 14:57:36 INFO - Running setup.py install for mozhttpd 14:57:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for mozinfo 14:57:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for mozInstall 14:57:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for mozleak 14:57:36 INFO - Running setup.py install for mozlog 14:57:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for moznetwork 14:57:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for mozprocess 14:57:36 INFO - Running setup.py install for mozprofile 14:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:36 INFO - Running setup.py install for mozrunner 14:57:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:37 INFO - Running setup.py install for mozscreenshot 14:57:37 INFO - Running setup.py install for moztest 14:57:37 INFO - Running setup.py install for mozversion 14:57:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:37 INFO - Cleaning up... 14:57:37 INFO - Return code: 0 14:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:37 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')]} 14:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:37 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')]} 14:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:37 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:37 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 14:57:37 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 14:57:37 INFO - Using env: {'DISPLAY': ':0', 14:57:37 INFO - 'HOME': '/home/cltbld', 14:57:37 INFO - 'LANG': 'en_US.UTF-8', 14:57:37 INFO - 'LANGUAGE': 'en_US:en', 14:57:37 INFO - 'LOGNAME': 'cltbld', 14:57:37 INFO - 'MAIL': '/var/mail/cltbld', 14:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:37 INFO - 'MOZ_NO_REMOTE': '1', 14:57:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:37 INFO - 'NO_EM_RESTART': '1', 14:57:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:37 INFO - 'PWD': '/builds/slave/test', 14:57:37 INFO - 'SHELL': '/bin/bash', 14:57:37 INFO - 'SHLVL': '1', 14:57:37 INFO - 'TERM': 'linux', 14:57:37 INFO - 'TMOUT': '86400', 14:57:37 INFO - 'USER': 'cltbld', 14:57:37 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:37 INFO - '_': '/tools/buildbot/bin/python'} 14:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:37 INFO - Running setup.py (path:/tmp/pip-tKJQD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:37 INFO - Running setup.py (path:/tmp/pip-AZrJWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:37 INFO - Running setup.py (path:/tmp/pip-Enx2VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:37 INFO - Running setup.py (path:/tmp/pip-duHgGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:37 INFO - Running setup.py (path:/tmp/pip-vAfT_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:37 INFO - Running setup.py (path:/tmp/pip-PNiQiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:37 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)) 14:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:37 INFO - Running setup.py (path:/tmp/pip-DOi_O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:38 INFO - Running setup.py (path:/tmp/pip-Eg9Axv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:38 INFO - Running setup.py (path:/tmp/pip-cct0z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:38 INFO - Running setup.py (path:/tmp/pip-_oidxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:38 INFO - Running setup.py (path:/tmp/pip-BNb3te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:38 INFO - Running setup.py (path:/tmp/pip-jidbUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:38 INFO - Running setup.py (path:/tmp/pip-LNcaOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:38 INFO - Running setup.py (path:/tmp/pip-HAZ8bo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:38 INFO - Running setup.py (path:/tmp/pip-sT4tOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:38 INFO - Running setup.py (path:/tmp/pip-YlaDg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:38 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)) 14:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:38 INFO - Running setup.py (path:/tmp/pip-e8udiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:38 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)) 14:57:38 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)) 14:57:38 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)) 14:57:38 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)) 14:57:38 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)) 14:57:38 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)) 14:57:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:40 INFO - Downloading blessings-1.6.tar.gz 14:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:40 INFO - Installing collected packages: blessings 14:57:40 INFO - Running setup.py install for blessings 14:57:40 INFO - Successfully installed blessings 14:57:40 INFO - Cleaning up... 14:57:40 INFO - Return code: 0 14:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:41 INFO - Reading from file tmpfile_stdout 14:57:41 INFO - Current package versions: 14:57:41 INFO - argparse == 1.2.1 14:57:41 INFO - blessings == 1.6 14:57:41 INFO - blobuploader == 1.2.4 14:57:41 INFO - docopt == 0.6.1 14:57:41 INFO - functools32 == 3.2.3-2 14:57:41 INFO - jsonschema == 2.5.1 14:57:41 INFO - manifestparser == 1.1 14:57:41 INFO - mozInstall == 1.12 14:57:41 INFO - mozcrash == 0.17 14:57:41 INFO - mozdebug == 0.1 14:57:41 INFO - mozdevice == 0.48 14:57:41 INFO - mozfile == 1.2 14:57:41 INFO - mozhttpd == 0.7 14:57:41 INFO - mozinfo == 0.9 14:57:41 INFO - mozleak == 0.1 14:57:41 INFO - mozlog == 3.2 14:57:41 INFO - moznetwork == 0.27 14:57:41 INFO - mozprocess == 0.22 14:57:41 INFO - mozprofile == 0.28 14:57:41 INFO - mozrunner == 6.11 14:57:41 INFO - mozscreenshot == 0.1 14:57:41 INFO - mozsystemmonitor == 0.3 14:57:41 INFO - moztest == 0.7 14:57:41 INFO - mozversion == 1.4 14:57:41 INFO - psutil == 3.1.1 14:57:41 INFO - requests == 1.2.3 14:57:41 INFO - wsgiref == 0.1.2 14:57:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 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 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:41 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 14:57:41 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 14:57:41 INFO - Using env: {'DISPLAY': ':0', 14:57:41 INFO - 'HOME': '/home/cltbld', 14:57:41 INFO - 'LANG': 'en_US.UTF-8', 14:57:41 INFO - 'LANGUAGE': 'en_US:en', 14:57:41 INFO - 'LOGNAME': 'cltbld', 14:57:41 INFO - 'MAIL': '/var/mail/cltbld', 14:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:41 INFO - 'MOZ_NO_REMOTE': '1', 14:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:41 INFO - 'NO_EM_RESTART': '1', 14:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:41 INFO - 'PWD': '/builds/slave/test', 14:57:41 INFO - 'SHELL': '/bin/bash', 14:57:41 INFO - 'SHLVL': '1', 14:57:41 INFO - 'TERM': 'linux', 14:57:41 INFO - 'TMOUT': '86400', 14:57:41 INFO - 'USER': 'cltbld', 14:57:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:41 INFO - '_': '/tools/buildbot/bin/python'} 14:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 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)) 14:57:41 INFO - Cleaning up... 14:57:41 INFO - Return code: 0 14:57:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:57:41 INFO - Using env: {'DISPLAY': ':0', 14:57:41 INFO - 'HOME': '/home/cltbld', 14:57:41 INFO - 'LANG': 'en_US.UTF-8', 14:57:41 INFO - 'LANGUAGE': 'en_US:en', 14:57:41 INFO - 'LOGNAME': 'cltbld', 14:57:41 INFO - 'MAIL': '/var/mail/cltbld', 14:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:41 INFO - 'MOZ_NO_REMOTE': '1', 14:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:41 INFO - 'NO_EM_RESTART': '1', 14:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:41 INFO - 'PWD': '/builds/slave/test', 14:57:41 INFO - 'SHELL': '/bin/bash', 14:57:41 INFO - 'SHLVL': '1', 14:57:41 INFO - 'TERM': 'linux', 14:57:41 INFO - 'TMOUT': '86400', 14:57:41 INFO - 'USER': 'cltbld', 14:57:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:41 INFO - '_': '/tools/buildbot/bin/python'} 14:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:57:41 INFO - Cleaning up... 14:57:41 INFO - Return code: 0 14:57:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7807ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2095350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', '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 14:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:57:41 INFO - Using env: {'DISPLAY': ':0', 14:57:41 INFO - 'HOME': '/home/cltbld', 14:57:41 INFO - 'LANG': 'en_US.UTF-8', 14:57:41 INFO - 'LANGUAGE': 'en_US:en', 14:57:41 INFO - 'LOGNAME': 'cltbld', 14:57:41 INFO - 'MAIL': '/var/mail/cltbld', 14:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:41 INFO - 'MOZ_NO_REMOTE': '1', 14:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:41 INFO - 'NO_EM_RESTART': '1', 14:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:41 INFO - 'PWD': '/builds/slave/test', 14:57:41 INFO - 'SHELL': '/bin/bash', 14:57:41 INFO - 'SHLVL': '1', 14:57:41 INFO - 'TERM': 'linux', 14:57:41 INFO - 'TMOUT': '86400', 14:57:41 INFO - 'USER': 'cltbld', 14:57:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:41 INFO - '_': '/tools/buildbot/bin/python'} 14:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:41 INFO - Downloading/unpacking flake8 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:57:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:57:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:43 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 14:57:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:44 INFO - no previously-included directories found matching 'docs/_build' 14:57:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:57:44 INFO - Running setup.py install for pep8 14:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:44 INFO - no previously-included directories found matching 'docs/_build' 14:57:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:57:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:57:44 INFO - Cleaning up... 14:57:44 INFO - Return code: 0 14:57:44 INFO - Running post-action listener: _resource_record_post_action 14:57:44 INFO - Running post-action listener: _start_resource_monitoring 14:57:44 INFO - Starting resource monitoring. 14:57:44 INFO - ##### 14:57:44 INFO - ##### Finished create-virtualenv step (success) 14:57:44 INFO - ##### 14:57:44 INFO - ##### 14:57:44 INFO - ##### Running install step. 14:57:44 INFO - ##### 14:57:44 INFO - Running pre-action listener: _resource_record_pre_action 14:57:44 INFO - Running main action method: install 14:57:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:44 INFO - Reading from file tmpfile_stdout 14:57:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:45 INFO - Reading from file tmpfile_stdout 14:57:45 INFO - Output received: 14:57:45 INFO - Usage: mozinstall [options] installer 14:57:45 INFO - Options: 14:57:45 INFO - -h, --help show this help message and exit 14:57:45 INFO - -d DEST, --destination=DEST 14:57:45 INFO - Directory to install application into. [default: 14:57:45 INFO - "/builds/slave/test"] 14:57:45 INFO - --app=APP Application being installed. [default: firefox] 14:57:45 INFO - mkdir: /builds/slave/test/build/application 14:57:45 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'] 14:57:45 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 14:58:00 INFO - Reading from file tmpfile_stdout 14:58:00 INFO - Output received: 14:58:00 INFO - /builds/slave/test/build/application/firefox/firefox 14:58:00 INFO - Running post-action listener: _resource_record_post_action 14:58:00 INFO - ##### 14:58:00 INFO - ##### Finished install step (success) 14:58:00 INFO - ##### 14:58:00 INFO - ##### 14:58:00 INFO - ##### Running run-tests step. 14:58:00 INFO - ##### 14:58:00 INFO - Running pre-action listener: _resource_record_pre_action 14:58:00 INFO - Running main action method: run_tests 14:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:58:00 INFO - Python 2.7.3 14:58:00 INFO - Return code: 0 14:58:00 INFO - grabbing minidump binary from tooltool 14:58: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')]} 14:58:00 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 0x21241c0>, '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 0x21250c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2125550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:58:00 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 14:58:00 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 14:58:00 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 14:58:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:58:00 INFO - Return code: 0 14:58:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:58:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:58:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:58:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:58:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:58:01 INFO - Return code: 0 14:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:58:01 INFO - Using env: {'DISPLAY': ':0', 14:58:01 INFO - 'HOME': '/home/cltbld', 14:58:01 INFO - 'LANG': 'en_US.UTF-8', 14:58:01 INFO - 'LANGUAGE': 'en_US:en', 14:58:01 INFO - 'LOGNAME': 'cltbld', 14:58:01 INFO - 'MAIL': '/var/mail/cltbld', 14:58:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:01 INFO - 'MOZ_NO_REMOTE': '1', 14:58:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:01 INFO - 'NO_EM_RESTART': '1', 14:58:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:01 INFO - 'PWD': '/builds/slave/test', 14:58:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:01 INFO - 'SHELL': '/bin/bash', 14:58:01 INFO - 'SHLVL': '1', 14:58:01 INFO - 'TERM': 'linux', 14:58:01 INFO - 'TMOUT': '86400', 14:58:01 INFO - 'USER': 'cltbld', 14:58:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379', 14:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:01 INFO - '_': '/tools/buildbot/bin/python'} 14:58:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:58:02 INFO - mozversion application_buildid: 20160709122525 14:58:02 INFO - mozversion application_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 14:58:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:58:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:58:02 INFO - mozversion application_name: Firefox 14:58:02 INFO - mozversion application_remotingname: firefox-dev 14:58:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:58:02 INFO - mozversion application_vendor: Mozilla 14:58:02 INFO - mozversion application_version: 49.0a2 14:58:02 INFO - mozversion platform_buildid: 20160709122525 14:58:02 INFO - mozversion platform_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 14:58:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:58:02 INFO - mozversion platform_version: 49.0a2 14:58:02 INFO - using testdate: 1468101482 14:58:02 INFO - actual date: 1468101482 14:58:02 INFO - starting webserver on 'localhost:51588' 14:58:02 INFO - SUITE-START | Running 2 tests 14:58:02 INFO - TEST-START | dromaeo_css 14:58:02 INFO - operating with platform_type : linux_ 14:58:02 INFO - Initialising browser for dromaeo_css test... 14:58:02 INFO - TEST-INFO | started process 19687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXAqnY/profile http://localhost:51588/getInfo.html) 14:58:06 INFO - PROCESS | 19687 | __metrics Screen width/height:1600/1200 14:58:06 INFO - PROCESS | 19687 | colorDepth:24 14:58:06 INFO - PROCESS | 19687 | Browser inner width/height: 1024/697 14:58:06 INFO - PROCESS | 19687 | __metrics 14:58:07 ERROR - PROCESS | 19687 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:58:08 INFO - TEST-INFO | 19687: exit 0 14:58:08 INFO - Browser initialized. 14:58:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:58:08 INFO - TEST-INFO | started process 19778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQXAqnY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:19 INFO - PROCESS | 19778 | RSS: Main: 145068032 14:58:19 INFO - PROCESS | 19778 | 14:59:11 INFO - PROCESS | 19778 | 1468101551104 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:01:19 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51588/tests/dromaeo/cssquery-ext.html) 15:01:20 INFO - PROCESS | 19778 | RSS: Main: 256073728 15:01:20 INFO - PROCESS | 19778 | 15:04:22 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-ext.html (next: http://localhost:51588/tests/dromaeo/cssquery-jquery.html) 15:04:23 INFO - PROCESS | 19778 | RSS: Main: 232439808 15:04:23 INFO - PROCESS | 19778 | 15:07:24 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51588/tests/dromaeo/cssquery-mootools.html) 15:07:25 INFO - PROCESS | 19778 | RSS: Main: 235524096 15:07:25 INFO - PROCESS | 19778 | 15:10:27 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51588/tests/dromaeo/cssquery-prototype.html) 15:10:27 INFO - PROCESS | 19778 | RSS: Main: 224583680 15:10:27 INFO - PROCESS | 19778 | 15:13:30 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51588/tests/dromaeo/cssquery-yui.html) 15:13:31 INFO - PROCESS | 19778 | RSS: Main: 201580544 15:13:31 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | Cycle 1(1): loaded http://localhost:51588/tests/dromaeo/cssquery-yui.html (next: http://localhost:51588/tests/dromaeo/cssquery-dojo.html) 15:16:33 INFO - PROCESS | 19778 | RSS: Main: 247926784 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | __start_tp_report 15:16:33 INFO - PROCESS | 19778 | _x_x_mozilla_page_load 15:16:33 INFO - PROCESS | 19778 | _x_x_mozilla_page_load_details 15:16:33 INFO - PROCESS | 19778 | |i|pagename|runs| 15:16:33 INFO - PROCESS | 19778 | |0;dojo.html;3338.8163650999195;3358.983205083976;3359.093044877883;3382.374260761761;3404.3872103021445;5486.204500347452;5574.777008919638;5579.135234038726;5579.967705974397;5586.022446071936;5523.309586301712;5567.582431317647;5568.053430916743;5579.8605034874145;5608.2428872102255;4889.657723959324;5021.949780502194;5037.773300201499;5071.7717702703285;5116.616253780962;4860.8055677772845;4998.775055122528;5040.7731652075745;5041;5046.44489106198;5019.6988180709095;5034.295198672189;5039.09296326661;5040.36995375578;5044.19292913134;5152.149895267276;5159.690418574897;5163.483651634807;5168.250603662448;5200.271961925334;4925.285833554115;4973.254011898208;5024.271480635324;5071.3407257056715;5081.060003899291;5378.997482489602;5379.38137114233;5415;5423.83728488146;5468.48049435303;5957.106434034929;5968.552358573081;5969;5973.372795856416;5977.043673012341;5855.76576936922;5887.852803679943;5911.408859114054;5944.286685597713;6007.128966299906;5560.36055853582;5564.4991950724225;5564.888702225933;5573.999999999959;5587.161925711094;5895.587308888336;6056.739568173163;6057.826063111042;6083.361247069082;6088.786892458831;5729.914051289234;5820.854478638068;5843.415658434207;5851.1223316502865;5853.239078919798;5845.298564172242;5924.259467566554;5924.644521328734;5952.761889524457;5958.582899197015;5745.396733343023;5819.679917604488;5823.126531020296;5870.765169393177;5874.353821079678;5874.823755287348;5924.5852790305125;5943.762249510058;5944.524438044946;5984.611000284967;4556.430446194226;4576.954230457719;4580.496145424001;4585.28928016158;4600.95399046012;3996.540397854226;4028.254772867029;4077.7961101944784;4089.2026054919006;4118.444010058603;5666.773329066874;5677.37548869624;5692.117721753135;5694.857628559319;5707.914381284284;5980.282366116007;5998.1602575639445;6001.099835024781;6003.849903752441;6028.2766068072115;5417.945820541823;5579.163125531121;5600.859978500489;5609.9158512621525;5620.859478512988;5153.330067091254;5154.304168937146;5155.948440515622;5156.767945442464;5165.121929271958;6173.69131543421;6176.722047507873;6190.473809726223;6195.070739389128;6195.349488303754;5814.127880817911;5891.528677705687;5965.28416590012;5965.433283838029;5999.5800293979;6158.52442671984;6210.5652604319075;6215.968920155551;6224.875502490016;6227;5710.628809127394;5897.262842144732;5908.409159084229;5912.586118971631;5934.139549765347;5837.445442682938;5852.531797456279;5890.028145356139;5918.852028699317;5928.940710593011;5698.572607054404;5737.770489180386;5783.652980821164;5789.913151302818;5791.507721843691;5617.8033768817895;5744.798932037359;5751.827445176651;5794.362620111869;5816.389279125631;5711.343195532567;5791.131330300489;5791.623544469596;5792.94207057924;5831.883362332815;5895.41045895407;5920.141579470866;5933.643981361132;5937.406259374201;5945.643261404157;5483.095289277384;5591;5633.436656334334;5767.279090113736;5799.043157879071 15:16:33 INFO - PROCESS | 19778 | |1;ext.html;582.9271341082363;604.295995165632;618.6257314324833;646.3019938466454;659.1332397896768;32678.183045423877;46081.76959115204;46795.532044679625;46867.59397218089;46880.53119468804;48666.27000594994;49389.25916111261;49443.50556494434;49490.50509494913;49510.75244623772;8239.752807415756;8396.622152003143;8405.53769542678;8937.195652391283;9108.316876234276;10484.37093774372;10771.138308935306;10771.407572583505;11067.557297708083;11073.390963497004;10914.181436392262;11025.669229923114;11043.116550675926;11047.558097676083;11053.944730276378;8258.339332853357;10685.732856678605;10689.198310126694;10769.084627806686;10898.400587967659;10434;10847.349159050482;10855.457227138611;10879.401632910187;10879.510422030948;44886.77556612196;45330;45394;45525.772371138264;45580.31629525527;3540.716742660581;3698.6486283802997;3718.4608231806237;3721.7580857244193;4024.9597504024878;34330.656693433;34372.82813585941;34805;34923;35012.64987350119;4621.8151273949;4636.907261854778;4712.764361781931;4723.692959957626;4808.35087263222;401830;403755;404195;404323;404945;35057.64942350595;35257.29485410277;71131;71999.2800072003;72057;41216;41323.38014929718;41345.1730965385;41558;41565.58434415678;15794.684106317809;15862.286197121157;15920.442784502487;15930.123843188736;15933;11201.66395008151;11409.315441073562;11578.594749183738;11580.710482237842;13000.67498312531;9147.359684822131;9163.450192988443;9249.306302027375;9266.258699304039;9275.257979361635;3431.4509678451327;3488.354654388946;3505.702015328726;3509.5437593112733;3539.858405663796;1033.8811036730872;1071.5553045486035;1078.5793540519203;1141.9086473082134;1237.8019516877437;31982.200444989063;33592.49611255833;33701;33806.32387352239;34058;1158.3455347728507;1161.9128565357632;1163.8836116388463;1175.835383046374;1217.3852204636778;17805.287788488316;18068.819311806976;18112.637747244982;18161.27354905789;18197.818021819614;606943;609999;612802;613807;614490;66921.33078669151;67708;67778.3222167772;67858.66070669614;67928.3207167922;1311.4754098360731;1399.7130588229593;1403.3965394880095;1414.9363278652486;1429.1353730992807;35249;36184.93551877885;36351.54593816323;36681.213975414634;36965.86072445426;56614.433855662566;57470.7126464365;57495;57542;57642.42357576371;341157;346050;348949;349186;349870;28011;29846.403071938876;30208.395832083675;30870.69129308678;32291.35417291594;52215;52847.20729189142;53565;53826.19260711014;53952.730236348565;43557.80712140954;43636.78181609072;43773.56226437822;44525.777371114236;45083;44009.77995110004;45497;45872;46017.76991115023;46258.074838503715;45497.545024549334;46325;46370;46410.30384544167;46684;37801.432978505894;39929.2014159721;40204.79897600493;40411.7979410101;40927.97680057903;31106;31746.841265793522;32208.35583288368;32263.677363226067;32511.349773003934 15:16:33 INFO - PROCESS | 19778 | |2;jquery.html;427.33590058613015;429.97420154790706;433.3240145373216;437.10611798871327;439.64388845035523;19024.71462928057;19462.805371946295;20340.694889576633;20378.89810550947;20395.694064589043;19594.430962818737;20591.897040514814;20852.791472085275;20882.373528794124;20940.790592094076;5731.283589551295;5983.431574000463;6024.246969128859;6027.578069535134;6029.276486821587;5729.312482502106;5899;5905.43898329658;5907.645541267538;5940.079287710412;5812.622179558336;5818.5636077294375;5821.243238379026;5823.330317013555;5866.120081987715;5754.798582049629;5825.155352473867;5827.184194212814;5828.708564571797;5829.0382086955815;5020.949790502084;5046.1421558334805;5176.741162941876;5186.040582492251;5188.792448302063;24101;24151.396215094588;24198.274051778473;24545.38636534083;24601.50796984068;2292.346681195851;2377.0848223434105;2446.021591363451;2500.3124140861228;2951.7638588912837;14762.926185369111;14842.25788710571;14861;14877.553673389815;15131.924340378338;1902.8953407562578;1928.9035548222673;1959.3827944197533;1982.603479304145;2037.7045328427296;87537.71500670773;89915.10084899132;89987.55006224927;90315;91418.08581914229;11258.43707814606;11373;11483.36841473727;11621.6513504595;11707.356095414663;16558.089305088095;16616.335346586002;16667.083310417802;16670.083145426874;16722.331106755595;8441.873371899426;8701.521416322037;8711.259542938795;8803.779905502413;8805.207531322212;8243.422960392714;8254;8297.25324720778;8327.20891515305;8379.95810020946;7029.402500787388;7074.787756367317;7102.964485177541;7156.713731450684;7231.240719724353;1876.1088482970754;1876.9249230030919;1923.1249781349452;1923.8749481283671;1961.5880665060497;997.4115271989416;1005.5374527717186;1059.2426415113232;1144.5593446523148;1156.2484385149553;19241.80758192428;19465.610687786164;20037.899810501145;20248.89875550613;21086.894565527073;1034.177828626244;1050.2858056521638;1056.804491169136;1065.5471424644495;1088.646189988257;10917;11267.887321126684;11510.251833630788;11532.769344613229;11551.826722599168;521719;534096;536255;538553;541627;98879.50560247153;102625;103400.48299758603;103651.48174259081;104483;1121.5738019552355;1124.0614087237086;1127.0701671121194;1131.9603813866474;1173.3781096018952;17677.823221768132;17974.37089701854;18120.18459169367;18145.274189032818;18328.725069123706;43386.56613433825;44101.779491103625;44345.556544435436;44845.775771120934;46081.539184609064;63531.682341588;64229.678851605444;64495;64523.67738161279;65492;7649.541027538366;8228.094909559824;8901.777455563662;8902.065283145177;9199.448033118035;10457.68626941193;13383.263920484467;13420.798688019493;13476.393562289917;13825.893928485899;11847.526098955945;11875.881241187477;12246.571370002008;12313.13808033465;12451;11163.609273675382;11235.4382280884;11953.760924781282;11970.922616964515;12140.696482588006;6529.804105876831;10868.532748078907;11018.724531886766;11618.419079045845;12211.816822747844;8285.212904774036;8412.242898139197;8431.704890328809;8520.829583408173;8555.61499732526;11647.534098636299;11977.101717371057;11995.820062698893;12101.69745756363;12197 15:16:33 INFO - PROCESS | 19778 | |3;mootools.html;1384.896132790041;1552.8757699384048;1567.059764141515;1745.3629425259776;1849.7502837116995;8680.609372578234;8828.735137945863;9025.142611451918;9048.411853229536;9259.583318750656;8861.86707199391;9055.547222638857;9281.118293762082;9293.44239345638;9295;2129.446343950576;2183.2795177591356;2346.225745503988;2414.0464516515967;2450.2281781238944;2395.73646898841;2408.1330720940446;2409.6867407237037;2411.590029694947;2412.5536775696464;2412.1195763546357;2414.2515820095828;2443.755624437551;2446.0338166424253;2446.633005049248;2059.557195203031;2332.3119679694532;2365.4086478380405;2395.0539536883007;2398.8560686358874;2420.092465325503;2428.647846062329;2445.4497738008986;2447.4737931344666;2449.510097980411;8858.86711699325;9210.677626283048;9228.077192280785;9235.861462078074;9242.768930776718;5463.262459567987;5603.523700485463;5608.943910560883;5612.326520817528;5613.578981576398;3276.0990727549874;3387.6442973487924;3439.4840773884116;3486.7384946128886;3498.335316289922;1125.9774804503945;1159.2870384713424;1159.5187996981326;1159.9710007249803;1175.5004123247586;13218.272994985176;13252.46990120394;13274.66813329665;13285.402156902866;13289.468421263138;4849.369581954394;4893.926591101136;4920.704757714549;4951.405831300267;5002.649814513022;10557.366558006544;10596.629117980834;10605.310654807412;10609.575616975235;10613.84079238812;5489.752961116759;5492.752826122754;5493.752781124859;5494.450554944554;5499.312585926759;4560.1335746208115;4926.3349447824085;5005.224190250517;5014.899702006012;5097.6941383517105;4202.075543380452;4218;4281.593248641374;4323.265044942367;4328.567143285646;1323.7484877873173;1328.4951718346965;1335.1855368225374;1336.0781061067833;1338.43785610044;973.177664873181;999.5202302894506;1008.5461542305992;1010.4998025977188;1012.6759436980095;5981.760729570856;6040.154378387029;6069.757209711651;6072.726727297282;6172.9074063889075;496.4662987288679;501.8068043803089;510.8646208754683;514.0823629820752;518.0131848827989;4200.558941311179;4205.663546916239;4214.7471151731;4236.76697781625;4250.171216612793;11029.503672334764;11326.886731132749;11345.376004319676;11387.487563059682;11414.714632134097;11091.889081109248;11186.776264474665;11211.103111751041;11250.156238282161;11255.831162532568;8305.418620696493;8350.206730360605;8523.531205783618;8582.485050896967;8793.208611224893;6099.176611157437;6248.781292654735;6257.2491301044165;6303.338149494421;6304.810855674337;10265.58937642486;10547.208959327927;10580.36517808934;10683.94658026705;10719.785604287714;10670.0930420912;10675.89324106749;10844.078253348238;10924.890751092387;10949.507272172612;7796.181400952818;7946.086200087064;8002.119766825528;8082.757517274491;8175.182481751777;8957.328200384867;9009.414388064755;9058.320625953213;9073.45559266446;9185.954070229605;8042.235987581171;8054.073781514966;8230.135835737161;8290.709825156091;8328.958355208186;7926.167752385916;7981.281684648409;8012.158723334199;8077.798055048671;8088.150744171778;7318.085239345082;7328.78013659591;7412.740554080581;7422.294881986203;7423.777286681192;5104.566111880532;5114.616403769658;5120.667156634807;5131.384233891957;5170.5346518813485;5272.156454967187;5342.732863356739;5393.568514518751;5393.6763794172475;5470.835874923759 15:16:33 INFO - PROCESS | 19778 | |4;prototype.html;334.7372312734502;341.8700893660409;343.0565943654949;343.06685814584324;351.40787772603164;5257.158854583267;5356.11624082027;5433.755481003354;5463.617546771728;5477.753501092446;5428.9185662215095;5431.538319242859;5432.871018026309;5433.6196466247375;5454.372747134081;4226.387173859788;4246.087091275383;4246.617804397603;4252.532221455637;4256.936145957813;4061.2689715851134;4093.447384603085;4166.749995000295;4256.638185754199;4275.5510671379525;4180.825970495356;4182.205380977604;4190.287651099306;4209.515905670841;4218.514870789868;4183.581641835807;4196.538380778127;4199.181159673864;4202.193056985495;4202.915941681149;3647.1064589175558;3684.5394325709285;3732.346839303111;3746.456763769238;3751.143184123849;5152.149895267276;5161.329027226437;5189.299444574972;5204.34945631796;5206.323177986876;4814.277858321245;4815.735134567597;4815.975920120412;4820.542048505386;4849.709017458964;5413.458654134594;5625.915611265835;5637.885792827689;5639.2668953035845;5686.800961966353;4053.7365071270274;4069.8982525436804;4083.1833633273463;4089.795510224477;4097;5798.651546123827;5803.709814509258;5840.153177789197;5840.795572154997;5863.560232982543;4079.286124928126;4129.2773764591675;4139.668826493873;4139.875803725893;4173.561776013536;4234.13200293939;4255.255330317182;4258.5954334338185;4260.488741350996;4267.935980960288;4816.638752093537;4824.469308376076;4824.541668541483;4832.251001094836;4838.830640927551;5392.56859451243;5672.716364181774;5690.943090569124;5713.229083894308;5721.256236689287;1460.2844606143126;1460.5983354577577;1465.7434948883902;1472.168224952898;1473.6536913825244;872.6683860133236;894.9910500895038;904.8959369672572;913.2830727878717;915.4461550761827;4989.950100498949;4995.350604421402;4995.600351971833;4999.175136102503;4999.525045120708;5239.397469291004;5274.657147285414;5292.391374991848;5300.655457395334;5300.780820411327;4658.464276608166;4931.260310953314;4954.133026720309;4964.8758781030765;5043.319151914445;2781.95676621267;2791.916242512728;2794.608754774333;2799.7340252675963;2808.9297767555977;5305.647059999676;5386.407495175527;5386.542143917733;5395.757190926418;5400.567954563704;5276.498732620395;5292.814751483679;5539.7784088636;5977.432143946318;6009.429104235091;6012.564911210967;6041.7916416716835;6052.061930400795;6067.330374635147;6072.635641861502;5645.661260324394;5825.766969321349;5845.357010728731;5875.265591801025;5900.586958912835;5790.507806836466;5818.214541036906;5824;5825;5830.017793950077;5995.250593675791;6050.30421501533;6071.301800292847;6091.878162436815;6115.327313995546;3775.37706278472;3917.196974620253;4006.939895901622;4151.522574903804;4165.208610364021;5762.683052432157;5822.7670893163795;5829.15477255787;5833.599936015241;5834.737436815269;5495.725213739377;5658.207850900795;5673.432656734293;5686.061799802987;5687.317521897398;5689.146628005832;5699.316082070178;5699.857503562444;5705.201271821865;5721.998650236109;5619.719014049199;5622.5501959842295;5627.634203776742;5661.943380566142;5668.327843286323;5590.832275031756;5713.632386860588;5720.02759530889;5737.483626473638;5751.971240143773;5588.46317262756;5606.495415412633;5627.690477023803;5628.718564071862;5659.26429564154 15:16:33 INFO - PROCESS | 19778 | |5;yui.html;806.1696452653765;829.4898637338039;882.8190221004693;892.3619611977437;899.7120921305185;16161.272742726576;17396;17451.301947922082;17460.47618571442;17466.737998929995;14548.927255363735;14608.269586520659;14611.269436528184;14612.19632920189;14619.853801461983;727.8762610356252;748.4835463530147;748.6443939128925;749.7900587835414;857.9742607721778;859.4027151129936;862.9741107766777;863.3007264116086;863.386995233385;864.6887120636598;916.7937214126835;926.2127191886876;926.7312479381005;927.5408672707019;927.9907200928005;910.6903652758094;916.2486760856101;916.9403988740711;917.0279503726072;917.2432742987029;562.6708375600278;669.1501792723263;681.4854784637566;683.596677960006;686.800827759949;16024;16066.27701753424;16108.677826443405;16116.919415402965;16164.595885102848;14794.852051479562;15505.302261398265;15559.688806223925;15638.218089095613;15924.840751592452;13928.37322320498;13934.58196254114;13996.090254133449;14008.579742607637;14394.784078238834;4638.814447422099;4649;4667.8599642010795;4712.31671407644;4740.857774266743;78703;80685;80919.7862032076;81742.59128704318;82133;12371.69070773238;12381.071419643562;12409.44157512896;12499.312537810507;12624.936875315565;22813.771862281497;22832.65751013736;22873.88563057174;22877.428064298525;22925.42686432819;8455.408121431441;8578.18507241811;8784.121587841164;8842.513661748537;8873.556322183866;5069.6451248413;5103.183490641553;5107.668001579886;5125.4874512549195;5181.3782346118705;3567.7502574820032;3684.2999830032745;3688.926221475609;3689.8524059037336;3696.537932758405;677.4512644757762;680.9080774095434;689.5001124184926;691.5332150798191;701.8526109517059;652.46171908175;669.8660267946431;672.1430176524872;688.9483288753263;715.8103102677794;9926.602935882629;10105.595776169019;10141.340812847142;10200.591976321013;10271.229657775697;592.0674936974283;667.609448472649;668.1680561977058;689.2693744630708;726.46604745512;4670.915065219542;4772.880677983078;4868.488808675038;4888.535589119028;4945.480724523945;71029;97758.51120744493;99006.5049674747;100926.49536752269;115504;68758.65620671965;90964;108328;111967;115052.42473787577;77095.61452192703;99615;100547;101269;102346.48826755819;10294.536745846304;10642.308249964037;10761.192910531898;10788.730281743019;10901.454927253448;53791.73104134611;54557.18164227619;55407.16889246745;55725.606859828826;55743;75868;85183;85583.57208213919;86177;86373.56813215894;14366.425342986164;14383;14384.208868512333;14418.206998615176;14715.411383544966;14482.927585362006;14695;16092.839071609602;16327.836721632631;16821;15026.398944042116;15118;15253.923730381277;15398.46105386306;16070.116143611745;14855.554333370017;15362.923185384001;15428;15546.144962027198;16142.435014774426;12569.622911312676;12600.936995314965;12655.177413468095;12854.357282136043;13383.39774710121;11870.703232419259;12065.457054432396;12503.249805011728;12851.485940562272;12866.935665321613;12091.516339346328;12190.878091219329;12441.379858516682;12477.5008999639;12505.56230531927 15:16:33 INFO - PROCESS | 19778 | __end_tp_report 15:16:33 INFO - PROCESS | 19778 | __start_cc_report 15:16:33 INFO - PROCESS | 19778 | _x_x_mozilla_cycle_collect,926 15:16:33 INFO - PROCESS | 19778 | __end_cc_report 15:16:33 INFO - PROCESS | 19778 | __startTimestamp1468102593687__endTimestamp 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | ------- Summary: start ------- 15:16:33 INFO - PROCESS | 19778 | Number of tests: 6 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#0] dojo.html Cycles:165 Average:5520.01 Median:5729.91 stddev:607.43 (10.6%) stddev-sans-first:584.69 15:16:33 INFO - PROCESS | 19778 | Values: 3338.8 3359.0 3359.1 3382.4 3404.4 5486.2 5574.8 5579.1 5580.0 5586.0 5523.3 5567.6 5568.1 5579.9 5608.2 4889.7 5021.9 5037.8 5071.8 5116.6 4860.8 4998.8 5040.8 5041.0 5046.4 5019.7 5034.3 5039.1 5040.4 5044.2 5152.1 5159.7 5163.5 5168.3 5200.3 4925.3 4973.3 5024.3 5071.3 5081.1 5379.0 5379.4 5415.0 5423.8 5468.5 5957.1 5968.6 5969.0 5973.4 5977.0 5855.8 5887.9 5911.4 5944.3 6007.1 5560.4 5564.5 5564.9 5574.0 5587.2 5895.6 6056.7 6057.8 6083.4 6088.8 5729.9 5820.9 5843.4 5851.1 5853.2 5845.3 5924.3 5924.6 5952.8 5958.6 5745.4 5819.7 5823.1 5870.8 5874.4 5874.8 5924.6 5943.8 5944.5 5984.6 4556.4 4577.0 4580.5 4585.3 4601.0 3996.5 4028.3 4077.8 4089.2 4118.4 5666.8 5677.4 5692.1 5694.9 5707.9 5980.3 5998.2 6001.1 6003.8 6028.3 5417.9 5579.2 5600.9 5609.9 5620.9 5153.3 5154.3 5155.9 5156.8 5165.1 6173.7 6176.7 6190.5 6195.1 6195.3 5814.1 5891.5 5965.3 5965.4 5999.6 6158.5 6210.6 6216.0 6224.9 6227.0 5710.6 5897.3 5908.4 5912.6 5934.1 5837.4 5852.5 5890.0 5918.9 5928.9 5698.6 5737.8 5783.7 5789.9 5791.5 5617.8 5744.8 5751.8 5794.4 5816.4 5711.3 5791.1 5791.6 5792.9 5831.9 5895.4 5920.1 5933.6 5937.4 5945.6 5483.1 5591.0 5633.4 5767.3 5799.0 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#1] ext.html Cycles:180 Average:62299.78 Median:20761.60 stddev:124512.34 (599.7%) stddev-sans-first:124775.41 15:16:33 INFO - PROCESS | 19778 | Values: 582.9 604.3 618.6 646.3 659.1 32678.2 46081.8 46795.5 46867.6 46880.5 48666.3 49389.3 49443.5 49490.5 49510.8 8239.8 8396.6 8405.5 8937.2 9108.3 10484.4 10771.1 10771.4 11067.6 11073.4 10914.2 11025.7 11043.1 11047.6 11053.9 8258.3 10685.7 10689.2 10769.1 10898.4 10434.0 10847.3 10855.5 10879.4 10879.5 44886.8 45330.0 45394.0 45525.8 45580.3 3540.7 3698.6 3718.5 3721.8 4025.0 34330.7 34372.8 34805.0 34923.0 35012.6 4621.8 4636.9 4712.8 4723.7 4808.4 401830.0 403755.0 404195.0 404323.0 404945.0 35057.6 35257.3 71131.0 71999.3 72057.0 41216.0 41323.4 41345.2 41558.0 41565.6 15794.7 15862.3 15920.4 15930.1 15933.0 11201.7 11409.3 11578.6 11580.7 13000.7 9147.4 9163.5 9249.3 9266.3 9275.3 3431.5 3488.4 3505.7 3509.5 3539.9 1033.9 1071.6 1078.6 1141.9 1237.8 31982.2 33592.5 33701.0 33806.3 34058.0 1158.3 1161.9 1163.9 1175.8 1217.4 17805.3 18068.8 18112.6 18161.3 18197.8 606943.0 609999.0 612802.0 613807.0 614490.0 66921.3 67708.0 67778.3 67858.7 67928.3 1311.5 1399.7 1403.4 1414.9 1429.1 35249.0 36184.9 36351.5 36681.2 36965.9 56614.4 57470.7 57495.0 57542.0 57642.4 341157.0 346050.0 348949.0 349186.0 349870.0 28011.0 29846.4 30208.4 30870.7 32291.4 52215.0 52847.2 53565.0 53826.2 53952.7 43557.8 43636.8 43773.6 44525.8 45083.0 44009.8 45497.0 45872.0 46017.8 46258.1 45497.5 46325.0 46370.0 46410.3 46684.0 37801.4 39929.2 40204.8 40411.8 40928.0 31106.0 31746.8 32208.4 32263.7 32511.3 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#2] jquery.html Cycles:180 Average:31449.13 Median:21013.84 stddev:88272.23 (420.1%) stddev-sans-first:88489.13 15:16:33 INFO - PROCESS | 19778 | Values: 427.3 430.0 433.3 437.1 439.6 19024.7 19462.8 20340.7 20378.9 20395.7 19594.4 20591.9 20852.8 20882.4 20940.8 5731.3 5983.4 6024.2 6027.6 6029.3 5729.3 5899.0 5905.4 5907.6 5940.1 5812.6 5818.6 5821.2 5823.3 5866.1 5754.8 5825.2 5827.2 5828.7 5829.0 5020.9 5046.1 5176.7 5186.0 5188.8 24101.0 24151.4 24198.3 24545.4 24601.5 2292.3 2377.1 2446.0 2500.3 2951.8 14762.9 14842.3 14861.0 14877.6 15131.9 1902.9 1928.9 1959.4 1982.6 2037.7 87537.7 89915.1 89987.6 90315.0 91418.1 11258.4 11373.0 11483.4 11621.7 11707.4 16558.1 16616.3 16667.1 16670.1 16722.3 8441.9 8701.5 8711.3 8803.8 8805.2 8243.4 8254.0 8297.3 8327.2 8380.0 7029.4 7074.8 7103.0 7156.7 7231.2 1876.1 1876.9 1923.1 1923.9 1961.6 997.4 1005.5 1059.2 1144.6 1156.2 19241.8 19465.6 20037.9 20248.9 21086.9 1034.2 1050.3 1056.8 1065.5 1088.6 10917.0 11267.9 11510.3 11532.8 11551.8 521719.0 534096.0 536255.0 538553.0 541627.0 98879.5 102625.0 103400.5 103651.5 104483.0 1121.6 1124.1 1127.1 1132.0 1173.4 17677.8 17974.4 18120.2 18145.3 18328.7 43386.6 44101.8 44345.6 44845.8 46081.5 63531.7 64229.7 64495.0 64523.7 65492.0 7649.5 8228.1 8901.8 8902.1 9199.4 10457.7 13383.3 13420.8 13476.4 13825.9 11847.5 11875.9 12246.6 12313.1 12451.0 11163.6 11235.4 11953.8 11970.9 12140.7 6529.8 10868.5 11018.7 11618.4 12211.8 8285.2 8412.2 8431.7 8520.8 8555.6 11647.5 11977.1 11995.8 12101.7 12197.0 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#3] mootools.html Cycles:180 Average:6036.73 Median:4907.32 stddev:3483.42 (71.0%) stddev-sans-first:3475.64 15:16:33 INFO - PROCESS | 19778 | Values: 1384.9 1552.9 1567.1 1745.4 1849.8 8680.6 8828.7 9025.1 9048.4 9259.6 8861.9 9055.5 9281.1 9293.4 9295.0 2129.4 2183.3 2346.2 2414.0 2450.2 2395.7 2408.1 2409.7 2411.6 2412.6 2412.1 2414.3 2443.8 2446.0 2446.6 2059.6 2332.3 2365.4 2395.1 2398.9 2420.1 2428.6 2445.4 2447.5 2449.5 8858.9 9210.7 9228.1 9235.9 9242.8 5463.3 5603.5 5608.9 5612.3 5613.6 3276.1 3387.6 3439.5 3486.7 3498.3 1126.0 1159.3 1159.5 1160.0 1175.5 13218.3 13252.5 13274.7 13285.4 13289.5 4849.4 4893.9 4920.7 4951.4 5002.6 10557.4 10596.6 10605.3 10609.6 10613.8 5489.8 5492.8 5493.8 5494.5 5499.3 4560.1 4926.3 5005.2 5014.9 5097.7 4202.1 4218.0 4281.6 4323.3 4328.6 1323.7 1328.5 1335.2 1336.1 1338.4 973.2 999.5 1008.5 1010.5 1012.7 5981.8 6040.2 6069.8 6072.7 6172.9 496.5 501.8 510.9 514.1 518.0 4200.6 4205.7 4214.7 4236.8 4250.2 11029.5 11326.9 11345.4 11387.5 11414.7 11091.9 11186.8 11211.1 11250.2 11255.8 8305.4 8350.2 8523.5 8582.5 8793.2 6099.2 6248.8 6257.2 6303.3 6304.8 10265.6 10547.2 10580.4 10683.9 10719.8 10670.1 10675.9 10844.1 10924.9 10949.5 7796.2 7946.1 8002.1 8082.8 8175.2 8957.3 9009.4 9058.3 9073.5 9186.0 8042.2 8054.1 8230.1 8290.7 8329.0 7926.2 7981.3 8012.2 8077.8 8088.2 7318.1 7328.8 7412.7 7422.3 7423.8 5104.6 5114.6 5120.7 5131.4 5170.5 5272.2 5342.7 5393.6 5393.7 5470.8 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#4] prototype.html Cycles:180 Average:4702.47 Median:5296.74 stddev:1389.95 (26.2%) stddev-sans-first:1354.63 15:16:33 INFO - PROCESS | 19778 | Values: 334.7 341.9 343.1 343.1 351.4 5257.2 5356.1 5433.8 5463.6 5477.8 5428.9 5431.5 5432.9 5433.6 5454.4 4226.4 4246.1 4246.6 4252.5 4256.9 4061.3 4093.4 4166.7 4256.6 4275.6 4180.8 4182.2 4190.3 4209.5 4218.5 4183.6 4196.5 4199.2 4202.2 4202.9 3647.1 3684.5 3732.3 3746.5 3751.1 5152.1 5161.3 5189.3 5204.3 5206.3 4814.3 4815.7 4816.0 4820.5 4849.7 5413.5 5625.9 5637.9 5639.3 5686.8 4053.7 4069.9 4083.2 4089.8 4097.0 5798.7 5803.7 5840.2 5840.8 5863.6 4079.3 4129.3 4139.7 4139.9 4173.6 4234.1 4255.3 4258.6 4260.5 4267.9 4816.6 4824.5 4824.5 4832.3 4838.8 5392.6 5672.7 5690.9 5713.2 5721.3 1460.3 1460.6 1465.7 1472.2 1473.7 872.7 895.0 904.9 913.3 915.4 4990.0 4995.4 4995.6 4999.2 4999.5 5239.4 5274.7 5292.4 5300.7 5300.8 4658.5 4931.3 4954.1 4964.9 5043.3 2782.0 2791.9 2794.6 2799.7 2808.9 5305.6 5386.4 5386.5 5395.8 5400.6 5276.5 5292.8 5539.8 5977.4 6009.4 6012.6 6041.8 6052.1 6067.3 6072.6 5645.7 5825.8 5845.4 5875.3 5900.6 5790.5 5818.2 5824.0 5825.0 5830.0 5995.3 6050.3 6071.3 6091.9 6115.3 3775.4 3917.2 4006.9 4151.5 4165.2 5762.7 5822.8 5829.2 5833.6 5834.7 5495.7 5658.2 5673.4 5686.1 5687.3 5689.1 5699.3 5699.9 5705.2 5722.0 5619.7 5622.6 5627.6 5661.9 5668.3 5590.8 5713.6 5720.0 5737.5 5752.0 5588.5 5606.5 5627.7 5628.7 5659.3 15:16:33 INFO - PROCESS | 19778 | 15:16:33 INFO - PROCESS | 19778 | [#5] yui.html Cycles:180 Average:21608.08 Median:3693.20 stddev:30130.78 (815.8%) stddev-sans-first:30174.82 15:16:33 INFO - PROCESS | 19778 | Values: 806.2 829.5 882.8 892.4 899.7 16161.3 17396.0 17451.3 17460.5 17466.7 14548.9 14608.3 14611.3 14612.2 14619.9 727.9 748.5 748.6 749.8 858.0 859.4 863.0 863.3 863.4 864.7 916.8 926.2 926.7 927.5 928.0 910.7 916.2 916.9 917.0 917.2 562.7 669.2 681.5 683.6 686.8 16024.0 16066.3 16108.7 16116.9 16164.6 14794.9 15505.3 15559.7 15638.2 15924.8 13928.4 13934.6 13996.1 14008.6 14394.8 4638.8 4649.0 4667.9 4712.3 4740.9 78703.0 80685.0 80919.8 81742.6 82133.0 12371.7 12381.1 12409.4 12499.3 12624.9 22813.8 22832.7 22873.9 22877.4 22925.4 8455.4 8578.2 8784.1 8842.5 8873.6 5069.6 5103.2 5107.7 5125.5 5181.4 3567.8 3684.3 3688.9 3689.9 3696.5 677.5 680.9 689.5 691.5 701.9 652.5 669.9 672.1 688.9 715.8 9926.6 10105.6 10141.3 10200.6 10271.2 592.1 667.6 668.2 689.3 726.5 4670.9 4772.9 4868.5 4888.5 4945.5 71029.0 97758.5 99006.5 100926.5 115504.0 68758.7 90964.0 108328.0 111967.0 115052.4 77095.6 99615.0 100547.0 101269.0 102346.5 10294.5 10642.3 10761.2 10788.7 10901.5 53791.7 54557.2 55407.2 55725.6 55743.0 75868.0 85183.0 85583.6 86177.0 86373.6 14366.4 14383.0 14384.2 14418.2 14715.4 14482.9 14695.0 16092.8 16327.8 16821.0 15026.4 15118.0 15253.9 15398.5 16070.1 14855.6 15362.9 15428.0 15546.1 16142.4 12569.6 12600.9 12655.2 12854.4 13383.4 11870.7 12065.5 12503.2 12851.5 12866.9 12091.5 12190.9 12441.4 12477.5 12505.6 15:16:33 INFO - PROCESS | 19778 | -------- Summary: end -------- 15:16:33 INFO - PROCESS | 19778 | 15:16:34 INFO - TEST-INFO | 19778: exit 0 15:16:34 INFO - TEST-OK | dromaeo_css | took 1112306ms 15:16:34 INFO - TEST-START | kraken 15:16:34 INFO - operating with platform_type : linux_ 15:16:34 INFO - Initialising browser for kraken test... 15:16:34 INFO - TEST-INFO | started process 19962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVIRn3W/profile http://localhost:51588/getInfo.html) 15:16:38 INFO - PROCESS | 19962 | __metrics Screen width/height:1600/1200 15:16:38 INFO - PROCESS | 19962 | colorDepth:24 15:16:38 INFO - PROCESS | 19962 | Browser inner width/height: 1024/697 15:16:38 INFO - PROCESS | 19962 | __metrics 15:16:39 ERROR - PROCESS | 19962 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:16:40 INFO - TEST-INFO | 19962: exit 0 15:16:40 INFO - Browser initialized. 15:16:40 INFO - Running cycle 1/1 for kraken test... 15:16:40 INFO - TEST-INFO | started process 20052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVIRn3W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:51 INFO - PROCESS | 20052 | RSS: Main: 148881408 15:16:51 INFO - PROCESS | 20052 | 15:16:54 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection) 15:16:55 INFO - PROCESS | 20052 | RSS: Main: 198471680 15:16:55 INFO - PROCESS | 20052 | 15:16:57 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-dft) 15:16:58 INFO - PROCESS | 20052 | RSS: Main: 197025792 15:16:58 INFO - PROCESS | 20052 | 15:17:01 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-fft) 15:17:01 INFO - PROCESS | 20052 | RSS: Main: 282865664 15:17:01 INFO - PROCESS | 20052 | 15:17:03 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator) 15:17:04 INFO - PROCESS | 20052 | RSS: Main: 191504384 15:17:04 INFO - PROCESS | 20052 | 15:17:06 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:17:07 INFO - PROCESS | 20052 | RSS: Main: 192028672 15:17:07 INFO - PROCESS | 20052 | 15:17:10 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom) 15:17:10 INFO - PROCESS | 20052 | RSS: Main: 226533376 15:17:10 INFO - PROCESS | 20052 | 15:17:14 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate) 15:17:14 INFO - PROCESS | 20052 | RSS: Main: 225939456 15:17:14 INFO - PROCESS | 20052 | 15:17:17 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial) 15:17:18 INFO - PROCESS | 20052 | RSS: Main: 225951744 15:17:18 INFO - PROCESS | 20052 | 15:17:19 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:20 INFO - PROCESS | 20052 | RSS: Main: 204615680 15:17:20 INFO - PROCESS | 20052 | 15:17:21 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:22 INFO - PROCESS | 20052 | RSS: Main: 205467648 15:17:22 INFO - PROCESS | 20052 | 15:17:24 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:25 INFO - PROCESS | 20052 | RSS: Main: 210186240 15:17:25 INFO - PROCESS | 20052 | 15:17:27 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:28 INFO - PROCESS | 20052 | RSS: Main: 216375296 15:17:28 INFO - PROCESS | 20052 | 15:17:30 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:31 INFO - PROCESS | 20052 | RSS: Main: 217157632 15:17:31 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | Cycle 1(1): loaded http://localhost:51588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51588/tests/kraken/driver.html?testName=ai-astar) 15:17:33 INFO - PROCESS | 20052 | RSS: Main: 259350528 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | __start_tp_report 15:17:33 INFO - PROCESS | 20052 | _x_x_mozilla_page_load 15:17:33 INFO - PROCESS | 20052 | _x_x_mozilla_page_load_details 15:17:33 INFO - PROCESS | 20052 | |i|pagename|runs| 15:17:33 INFO - PROCESS | 20052 | |0;ai-astar;112;105;113;110;111;111;112;114;110;112 15:17:33 INFO - PROCESS | 20052 | |1;audio-beat-detection;155;123;126;174;129;124;149;128;167;125 15:17:33 INFO - PROCESS | 20052 | |2;audio-dft;162;162;160;161;161;162;161;160;161;159 15:17:33 INFO - PROCESS | 20052 | |3;audio-fft;74;75;76;125;74;76;76;75;97;74 15:17:33 INFO - PROCESS | 20052 | |4;audio-oscillator;84;84;109;84;84;85;122;84;84;119 15:17:33 INFO - PROCESS | 20052 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;118;117 15:17:33 INFO - PROCESS | 20052 | |6;imaging-darkroom;146;145;146;146;146;145;145;147;146;145 15:17:33 INFO - PROCESS | 20052 | |7;imaging-desaturate;95;94;95;95;96;94;94;94;95;94 15:17:33 INFO - PROCESS | 20052 | |8;json-parse-financial;50;50;50;52;51;50;52;51;52;51 15:17:33 INFO - PROCESS | 20052 | |9;json-stringify-tinderbox;67;59;59;59;59;59;59;60;59;60 15:17:33 INFO - PROCESS | 20052 | |10;stanford-crypto-aes;81;75;77;76;80;82;80;76;106;76 15:17:33 INFO - PROCESS | 20052 | |11;stanford-crypto-ccm;121;120;117;124;115;112;113;115;139;120 15:17:33 INFO - PROCESS | 20052 | |12;stanford-crypto-pbkdf2;153;154;153;158;154;153;154;153;154;153 15:17:33 INFO - PROCESS | 20052 | |13;stanford-crypto-sha256-iterative;61;60;62;60;60;61;61;59;61;60 15:17:33 INFO - PROCESS | 20052 | __end_tp_report 15:17:33 INFO - PROCESS | 20052 | __start_cc_report 15:17:33 INFO - PROCESS | 20052 | _x_x_mozilla_cycle_collect,1574 15:17:33 INFO - PROCESS | 20052 | __end_cc_report 15:17:33 INFO - PROCESS | 20052 | __startTimestamp1468102653287__endTimestamp 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | ------- Summary: start ------- 15:17:33 INFO - PROCESS | 20052 | Number of tests: 14 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.45 (2.2%) stddev-sans-first:2.57 15:17:33 INFO - PROCESS | 20052 | Values: 112.0 105.0 113.0 110.0 111.0 111.0 112.0 114.0 110.0 112.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:139.00 stddev:19.50 (14.0%) stddev-sans-first:19.91 15:17:33 INFO - PROCESS | 20052 | Values: 155.0 123.0 126.0 174.0 129.0 124.0 149.0 128.0 167.0 125.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.99 (0.6%) stddev-sans-first:0.97 15:17:33 INFO - PROCESS | 20052 | Values: 162.0 162.0 160.0 161.0 161.0 162.0 161.0 160.0 161.0 159.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:16.57 (21.9%) stddev-sans-first:17.31 15:17:33 INFO - PROCESS | 20052 | Values: 74.0 75.0 76.0 125.0 74.0 76.0 76.0 75.0 97.0 74.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:16.04 (19.1%) stddev-sans-first:16.61 15:17:33 INFO - PROCESS | 20052 | Values: 84.0 84.0 109.0 84.0 84.0 85.0 122.0 84.0 84.0 119.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:17:33 INFO - PROCESS | 20052 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 15:17:33 INFO - PROCESS | 20052 | Values: 146.0 145.0 146.0 146.0 146.0 145.0 145.0 147.0 146.0 145.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 15:17:33 INFO - PROCESS | 20052 | Values: 95.0 94.0 95.0 95.0 96.0 94.0 94.0 94.0 95.0 94.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.88 (1.7%) stddev-sans-first:0.87 15:17:33 INFO - PROCESS | 20052 | Values: 50.0 50.0 50.0 52.0 51.0 50.0 52.0 51.0 52.0 51.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:59.00 stddev:2.49 (4.2%) stddev-sans-first:0.44 15:17:33 INFO - PROCESS | 20052 | Values: 67.0 59.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 60.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:78.50 stddev:9.16 (11.7%) stddev-sans-first:9.71 15:17:33 INFO - PROCESS | 20052 | Values: 81.0 75.0 77.0 76.0 80.0 82.0 80.0 76.0 106.0 76.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.00 stddev:7.81 (6.5%) stddev-sans-first:8.26 15:17:33 INFO - PROCESS | 20052 | Values: 121.0 120.0 117.0 124.0 115.0 112.0 113.0 115.0 139.0 120.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:154.00 stddev:1.52 (1.0%) stddev-sans-first:1.58 15:17:33 INFO - PROCESS | 20052 | Values: 153.0 154.0 153.0 158.0 154.0 153.0 154.0 153.0 154.0 153.0 15:17:33 INFO - PROCESS | 20052 | 15:17:33 INFO - PROCESS | 20052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 15:17:33 INFO - PROCESS | 20052 | Values: 61.0 60.0 62.0 60.0 60.0 61.0 61.0 59.0 61.0 60.0 15:17:33 INFO - PROCESS | 20052 | -------- Summary: end -------- 15:17:33 INFO - PROCESS | 20052 | 15:17:34 INFO - TEST-INFO | 20052: exit 0 15:17:34 INFO - TEST-OK | kraken | took 59892ms 15:17:34 INFO - SUITE-END | took 1172s 15:17:34 INFO - Completed test suite (00:19:32) 15:17:34 INFO - javascript benchmark 15:17:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.8163650999195, 3358.983205083976, 3359.093044877883, 3382.374260761761, 3404.3872103021445, 5486.204500347452, 5574.777008919638, 5579.135234038726, 5579.967705974397, 5586.022446071936, 5523.309586301712, 5567.582431317647, 5568.053430916743, 5579.8605034874145, 5608.2428872102255, 4889.657723959324, 5021.949780502194, 5037.773300201499, 5071.7717702703285, 5116.616253780962, 4860.8055677772845, 4998.775055122528, 5040.7731652075745, 5041.0, 5046.44489106198, 5019.6988180709095, 5034.295198672189, 5039.09296326661, 5040.36995375578, 5044.19292913134, 5152.149895267276, 5159.690418574897, 5163.483651634807, 5168.250603662448, 5200.271961925334, 4925.285833554115, 4973.254011898208, 5024.271480635324, 5071.3407257056715, 5081.060003899291, 5378.997482489602, 5379.38137114233, 5415.0, 5423.83728488146, 5468.48049435303, 5957.106434034929, 5968.552358573081, 5969.0, 5973.372795856416, 5977.043673012341, 5855.76576936922, 5887.852803679943, 5911.408859114054, 5944.286685597713, 6007.128966299906, 5560.36055853582, 5564.4991950724225, 5564.888702225933, 5573.999999999959, 5587.161925711094, 5895.587308888336, 6056.739568173163, 6057.826063111042, 6083.361247069082, 6088.786892458831, 5729.914051289234, 5820.854478638068, 5843.415658434207, 5851.1223316502865, 5853.239078919798, 5845.298564172242, 5924.259467566554, 5924.644521328734, 5952.761889524457, 5958.582899197015, 5745.396733343023, 5819.679917604488, 5823.126531020296, 5870.765169393177, 5874.353821079678, 5874.823755287348, 5924.5852790305125, 5943.762249510058, 5944.524438044946, 5984.611000284967, 4556.430446194226, 4576.954230457719, 4580.496145424001, 4585.28928016158, 4600.95399046012, 3996.540397854226, 4028.254772867029, 4077.7961101944784, 4089.2026054919006, 4118.444010058603, 5666.773329066874, 5677.37548869624, 5692.117721753135, 5694.857628559319, 5707.914381284284, 5980.282366116007, 5998.1602575639445, 6001.099835024781, 6003.849903752441, 6028.2766068072115, 5417.945820541823, 5579.163125531121, 5600.859978500489, 5609.9158512621525, 5620.859478512988, 5153.330067091254, 5154.304168937146, 5155.948440515622, 5156.767945442464, 5165.121929271958, 6173.69131543421, 6176.722047507873, 6190.473809726223, 6195.070739389128, 6195.349488303754, 5814.127880817911, 5891.528677705687, 5965.28416590012, 5965.433283838029, 5999.5800293979, 6158.52442671984, 6210.5652604319075, 6215.968920155551, 6224.875502490016, 6227.0, 5710.628809127394, 5897.262842144732, 5908.409159084229, 5912.586118971631, 5934.139549765347, 5837.445442682938, 5852.531797456279, 5890.028145356139, 5918.852028699317, 5928.940710593011, 5698.572607054404, 5737.770489180386, 5783.652980821164, 5789.913151302818, 5791.507721843691, 5617.8033768817895, 5744.798932037359, 5751.827445176651, 5794.362620111869, 5816.389279125631, 5711.343195532567, 5791.131330300489, 5791.623544469596, 5792.94207057924, 5831.883362332815, 5895.41045895407, 5920.141579470866, 5933.643981361132, 5937.406259374201, 5945.643261404157, 5483.095289277384, 5591.0, 5633.436656334334, 5767.279090113736, 5799.043157879071], "value": 5481.080767217543, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.9271341082363, 604.295995165632, 618.6257314324833, 646.3019938466454, 659.1332397896768, 32678.183045423877, 46081.76959115204, 46795.532044679625, 46867.59397218089, 46880.53119468804, 48666.27000594994, 49389.25916111261, 49443.50556494434, 49490.50509494913, 49510.75244623772, 8239.752807415756, 8396.622152003143, 8405.53769542678, 8937.195652391283, 9108.316876234276, 10484.37093774372, 10771.138308935306, 10771.407572583505, 11067.557297708083, 11073.390963497004, 10914.181436392262, 11025.669229923114, 11043.116550675926, 11047.558097676083, 11053.944730276378, 8258.339332853357, 10685.732856678605, 10689.198310126694, 10769.084627806686, 10898.400587967659, 10434.0, 10847.349159050482, 10855.457227138611, 10879.401632910187, 10879.510422030948, 44886.77556612196, 45330.0, 45394.0, 45525.772371138264, 45580.31629525527, 3540.716742660581, 3698.6486283802997, 3718.4608231806237, 3721.7580857244193, 4024.9597504024878, 34330.656693433, 34372.82813585941, 34805.0, 34923.0, 35012.64987350119, 4621.8151273949, 4636.907261854778, 4712.764361781931, 4723.692959957626, 4808.35087263222, 401830.0, 403755.0, 404195.0, 404323.0, 404945.0, 35057.64942350595, 35257.29485410277, 71131.0, 71999.2800072003, 72057.0, 41216.0, 41323.38014929718, 41345.1730965385, 41558.0, 41565.58434415678, 15794.684106317809, 15862.286197121157, 15920.442784502487, 15930.123843188736, 15933.0, 11201.66395008151, 11409.315441073562, 11578.594749183738, 11580.710482237842, 13000.67498312531, 9147.359684822131, 9163.450192988443, 9249.306302027375, 9266.258699304039, 9275.257979361635, 3431.4509678451327, 3488.354654388946, 3505.702015328726, 3509.5437593112733, 3539.858405663796, 1033.8811036730872, 1071.5553045486035, 1078.5793540519203, 1141.9086473082134, 1237.8019516877437, 31982.200444989063, 33592.49611255833, 33701.0, 33806.32387352239, 34058.0, 1158.3455347728507, 1161.9128565357632, 1163.8836116388463, 1175.835383046374, 1217.3852204636778, 17805.287788488316, 18068.819311806976, 18112.637747244982, 18161.27354905789, 18197.818021819614, 606943.0, 609999.0, 612802.0, 613807.0, 614490.0, 66921.33078669151, 67708.0, 67778.3222167772, 67858.66070669614, 67928.3207167922, 1311.4754098360731, 1399.7130588229593, 1403.3965394880095, 1414.9363278652486, 1429.1353730992807, 35249.0, 36184.93551877885, 36351.54593816323, 36681.213975414634, 36965.86072445426, 56614.433855662566, 57470.7126464365, 57495.0, 57542.0, 57642.42357576371, 341157.0, 346050.0, 348949.0, 349186.0, 349870.0, 28011.0, 29846.403071938876, 30208.395832083675, 30870.69129308678, 32291.35417291594, 52215.0, 52847.20729189142, 53565.0, 53826.19260711014, 53952.730236348565, 43557.80712140954, 43636.78181609072, 43773.56226437822, 44525.777371114236, 45083.0, 44009.77995110004, 45497.0, 45872.0, 46017.76991115023, 46258.074838503715, 45497.545024549334, 46325.0, 46370.0, 46410.30384544167, 46684.0, 37801.432978505894, 39929.2014159721, 40204.79897600493, 40411.7979410101, 40927.97680057903, 31106.0, 31746.841265793522, 32208.35583288368, 32263.677363226067, 32511.349773003934], "value": 20449.928564281545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.33590058613015, 429.97420154790706, 433.3240145373216, 437.10611798871327, 439.64388845035523, 19024.71462928057, 19462.805371946295, 20340.694889576633, 20378.89810550947, 20395.694064589043, 19594.430962818737, 20591.897040514814, 20852.791472085275, 20882.373528794124, 20940.790592094076, 5731.283589551295, 5983.431574000463, 6024.246969128859, 6027.578069535134, 6029.276486821587, 5729.312482502106, 5899.0, 5905.43898329658, 5907.645541267538, 5940.079287710412, 5812.622179558336, 5818.5636077294375, 5821.243238379026, 5823.330317013555, 5866.120081987715, 5754.798582049629, 5825.155352473867, 5827.184194212814, 5828.708564571797, 5829.0382086955815, 5020.949790502084, 5046.1421558334805, 5176.741162941876, 5186.040582492251, 5188.792448302063, 24101.0, 24151.396215094588, 24198.274051778473, 24545.38636534083, 24601.50796984068, 2292.346681195851, 2377.0848223434105, 2446.021591363451, 2500.3124140861228, 2951.7638588912837, 14762.926185369111, 14842.25788710571, 14861.0, 14877.553673389815, 15131.924340378338, 1902.8953407562578, 1928.9035548222673, 1959.3827944197533, 1982.603479304145, 2037.7045328427296, 87537.71500670773, 89915.10084899132, 89987.55006224927, 90315.0, 91418.08581914229, 11258.43707814606, 11373.0, 11483.36841473727, 11621.6513504595, 11707.356095414663, 16558.089305088095, 16616.335346586002, 16667.083310417802, 16670.083145426874, 16722.331106755595, 8441.873371899426, 8701.521416322037, 8711.259542938795, 8803.779905502413, 8805.207531322212, 8243.422960392714, 8254.0, 8297.25324720778, 8327.20891515305, 8379.95810020946, 7029.402500787388, 7074.787756367317, 7102.964485177541, 7156.713731450684, 7231.240719724353, 1876.1088482970754, 1876.9249230030919, 1923.1249781349452, 1923.8749481283671, 1961.5880665060497, 997.4115271989416, 1005.5374527717186, 1059.2426415113232, 1144.5593446523148, 1156.2484385149553, 19241.80758192428, 19465.610687786164, 20037.899810501145, 20248.89875550613, 21086.894565527073, 1034.177828626244, 1050.2858056521638, 1056.804491169136, 1065.5471424644495, 1088.646189988257, 10917.0, 11267.887321126684, 11510.251833630788, 11532.769344613229, 11551.826722599168, 521719.0, 534096.0, 536255.0, 538553.0, 541627.0, 98879.50560247153, 102625.0, 103400.48299758603, 103651.48174259081, 104483.0, 1121.5738019552355, 1124.0614087237086, 1127.0701671121194, 1131.9603813866474, 1173.3781096018952, 17677.823221768132, 17974.37089701854, 18120.18459169367, 18145.274189032818, 18328.725069123706, 43386.56613433825, 44101.779491103625, 44345.556544435436, 44845.775771120934, 46081.539184609064, 63531.682341588, 64229.678851605444, 64495.0, 64523.67738161279, 65492.0, 7649.541027538366, 8228.094909559824, 8901.777455563662, 8902.065283145177, 9199.448033118035, 10457.68626941193, 13383.263920484467, 13420.798688019493, 13476.393562289917, 13825.893928485899, 11847.526098955945, 11875.881241187477, 12246.571370002008, 12313.13808033465, 12451.0, 11163.609273675382, 11235.4382280884, 11953.760924781282, 11970.922616964515, 12140.696482588006, 6529.804105876831, 10868.532748078907, 11018.724531886766, 11618.419079045845, 12211.816822747844, 8285.212904774036, 8412.242898139197, 8431.704890328809, 8520.829583408173, 8555.61499732526, 11647.534098636299, 11977.101717371057, 11995.820062698893, 12101.69745756363, 12197.0], "value": 9782.804772627036, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.896132790041, 1552.8757699384048, 1567.059764141515, 1745.3629425259776, 1849.7502837116995, 8680.609372578234, 8828.735137945863, 9025.142611451918, 9048.411853229536, 9259.583318750656, 8861.86707199391, 9055.547222638857, 9281.118293762082, 9293.44239345638, 9295.0, 2129.446343950576, 2183.2795177591356, 2346.225745503988, 2414.0464516515967, 2450.2281781238944, 2395.73646898841, 2408.1330720940446, 2409.6867407237037, 2411.590029694947, 2412.5536775696464, 2412.1195763546357, 2414.2515820095828, 2443.755624437551, 2446.0338166424253, 2446.633005049248, 2059.557195203031, 2332.3119679694532, 2365.4086478380405, 2395.0539536883007, 2398.8560686358874, 2420.092465325503, 2428.647846062329, 2445.4497738008986, 2447.4737931344666, 2449.510097980411, 8858.86711699325, 9210.677626283048, 9228.077192280785, 9235.861462078074, 9242.768930776718, 5463.262459567987, 5603.523700485463, 5608.943910560883, 5612.326520817528, 5613.578981576398, 3276.0990727549874, 3387.6442973487924, 3439.4840773884116, 3486.7384946128886, 3498.335316289922, 1125.9774804503945, 1159.2870384713424, 1159.5187996981326, 1159.9710007249803, 1175.5004123247586, 13218.272994985176, 13252.46990120394, 13274.66813329665, 13285.402156902866, 13289.468421263138, 4849.369581954394, 4893.926591101136, 4920.704757714549, 4951.405831300267, 5002.649814513022, 10557.366558006544, 10596.629117980834, 10605.310654807412, 10609.575616975235, 10613.84079238812, 5489.752961116759, 5492.752826122754, 5493.752781124859, 5494.450554944554, 5499.312585926759, 4560.1335746208115, 4926.3349447824085, 5005.224190250517, 5014.899702006012, 5097.6941383517105, 4202.075543380452, 4218.0, 4281.593248641374, 4323.265044942367, 4328.567143285646, 1323.7484877873173, 1328.4951718346965, 1335.1855368225374, 1336.0781061067833, 1338.43785610044, 973.177664873181, 999.5202302894506, 1008.5461542305992, 1010.4998025977188, 1012.6759436980095, 5981.760729570856, 6040.154378387029, 6069.757209711651, 6072.726727297282, 6172.9074063889075, 496.4662987288679, 501.8068043803089, 510.8646208754683, 514.0823629820752, 518.0131848827989, 4200.558941311179, 4205.663546916239, 4214.7471151731, 4236.76697781625, 4250.171216612793, 11029.503672334764, 11326.886731132749, 11345.376004319676, 11387.487563059682, 11414.714632134097, 11091.889081109248, 11186.776264474665, 11211.103111751041, 11250.156238282161, 11255.831162532568, 8305.418620696493, 8350.206730360605, 8523.531205783618, 8582.485050896967, 8793.208611224893, 6099.176611157437, 6248.781292654735, 6257.2491301044165, 6303.338149494421, 6304.810855674337, 10265.58937642486, 10547.208959327927, 10580.36517808934, 10683.94658026705, 10719.785604287714, 10670.0930420912, 10675.89324106749, 10844.078253348238, 10924.890751092387, 10949.507272172612, 7796.181400952818, 7946.086200087064, 8002.119766825528, 8082.757517274491, 8175.182481751777, 8957.328200384867, 9009.414388064755, 9058.320625953213, 9073.45559266446, 9185.954070229605, 8042.235987581171, 8054.073781514966, 8230.135835737161, 8290.709825156091, 8328.958355208186, 7926.167752385916, 7981.281684648409, 8012.158723334199, 8077.798055048671, 8088.150744171778, 7318.085239345082, 7328.78013659591, 7412.740554080581, 7422.294881986203, 7423.777286681192, 5104.566111880532, 5114.616403769658, 5120.667156634807, 5131.384233891957, 5170.5346518813485, 5272.156454967187, 5342.732863356739, 5393.568514518751, 5393.6763794172475, 5470.835874923759], "value": 4738.993646007663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.7372312734502, 341.8700893660409, 343.0565943654949, 343.06685814584324, 351.40787772603164, 5257.158854583267, 5356.11624082027, 5433.755481003354, 5463.617546771728, 5477.753501092446, 5428.9185662215095, 5431.538319242859, 5432.871018026309, 5433.6196466247375, 5454.372747134081, 4226.387173859788, 4246.087091275383, 4246.617804397603, 4252.532221455637, 4256.936145957813, 4061.2689715851134, 4093.447384603085, 4166.749995000295, 4256.638185754199, 4275.5510671379525, 4180.825970495356, 4182.205380977604, 4190.287651099306, 4209.515905670841, 4218.514870789868, 4183.581641835807, 4196.538380778127, 4199.181159673864, 4202.193056985495, 4202.915941681149, 3647.1064589175558, 3684.5394325709285, 3732.346839303111, 3746.456763769238, 3751.143184123849, 5152.149895267276, 5161.329027226437, 5189.299444574972, 5204.34945631796, 5206.323177986876, 4814.277858321245, 4815.735134567597, 4815.975920120412, 4820.542048505386, 4849.709017458964, 5413.458654134594, 5625.915611265835, 5637.885792827689, 5639.2668953035845, 5686.800961966353, 4053.7365071270274, 4069.8982525436804, 4083.1833633273463, 4089.795510224477, 4097.0, 5798.651546123827, 5803.709814509258, 5840.153177789197, 5840.795572154997, 5863.560232982543, 4079.286124928126, 4129.2773764591675, 4139.668826493873, 4139.875803725893, 4173.561776013536, 4234.13200293939, 4255.255330317182, 4258.5954334338185, 4260.488741350996, 4267.935980960288, 4816.638752093537, 4824.469308376076, 4824.541668541483, 4832.251001094836, 4838.830640927551, 5392.56859451243, 5672.716364181774, 5690.943090569124, 5713.229083894308, 5721.256236689287, 1460.2844606143126, 1460.5983354577577, 1465.7434948883902, 1472.168224952898, 1473.6536913825244, 872.6683860133236, 894.9910500895038, 904.8959369672572, 913.2830727878717, 915.4461550761827, 4989.950100498949, 4995.350604421402, 4995.600351971833, 4999.175136102503, 4999.525045120708, 5239.397469291004, 5274.657147285414, 5292.391374991848, 5300.655457395334, 5300.780820411327, 4658.464276608166, 4931.260310953314, 4954.133026720309, 4964.8758781030765, 5043.319151914445, 2781.95676621267, 2791.916242512728, 2794.608754774333, 2799.7340252675963, 2808.9297767555977, 5305.647059999676, 5386.407495175527, 5386.542143917733, 5395.757190926418, 5400.567954563704, 5276.498732620395, 5292.814751483679, 5539.7784088636, 5977.432143946318, 6009.429104235091, 6012.564911210967, 6041.7916416716835, 6052.061930400795, 6067.330374635147, 6072.635641861502, 5645.661260324394, 5825.766969321349, 5845.357010728731, 5875.265591801025, 5900.586958912835, 5790.507806836466, 5818.214541036906, 5824.0, 5825.0, 5830.017793950077, 5995.250593675791, 6050.30421501533, 6071.301800292847, 6091.878162436815, 6115.327313995546, 3775.37706278472, 3917.196974620253, 4006.939895901622, 4151.522574903804, 4165.208610364021, 5762.683052432157, 5822.7670893163795, 5829.15477255787, 5833.599936015241, 5834.737436815269, 5495.725213739377, 5658.207850900795, 5673.432656734293, 5686.061799802987, 5687.317521897398, 5689.146628005832, 5699.316082070178, 5699.857503562444, 5705.201271821865, 5721.998650236109, 5619.719014049199, 5622.5501959842295, 5627.634203776742, 5661.943380566142, 5668.327843286323, 5590.832275031756, 5713.632386860588, 5720.02759530889, 5737.483626473638, 5751.971240143773, 5588.46317262756, 5606.495415412633, 5627.690477023803, 5628.718564071862, 5659.26429564154], "value": 4259.033737287147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.1696452653765, 829.4898637338039, 882.8190221004693, 892.3619611977437, 899.7120921305185, 16161.272742726576, 17396.0, 17451.301947922082, 17460.47618571442, 17466.737998929995, 14548.927255363735, 14608.269586520659, 14611.269436528184, 14612.19632920189, 14619.853801461983, 727.8762610356252, 748.4835463530147, 748.6443939128925, 749.7900587835414, 857.9742607721778, 859.4027151129936, 862.9741107766777, 863.3007264116086, 863.386995233385, 864.6887120636598, 916.7937214126835, 926.2127191886876, 926.7312479381005, 927.5408672707019, 927.9907200928005, 910.6903652758094, 916.2486760856101, 916.9403988740711, 917.0279503726072, 917.2432742987029, 562.6708375600278, 669.1501792723263, 681.4854784637566, 683.596677960006, 686.800827759949, 16024.0, 16066.27701753424, 16108.677826443405, 16116.919415402965, 16164.595885102848, 14794.852051479562, 15505.302261398265, 15559.688806223925, 15638.218089095613, 15924.840751592452, 13928.37322320498, 13934.58196254114, 13996.090254133449, 14008.579742607637, 14394.784078238834, 4638.814447422099, 4649.0, 4667.8599642010795, 4712.31671407644, 4740.857774266743, 78703.0, 80685.0, 80919.7862032076, 81742.59128704318, 82133.0, 12371.69070773238, 12381.071419643562, 12409.44157512896, 12499.312537810507, 12624.936875315565, 22813.771862281497, 22832.65751013736, 22873.88563057174, 22877.428064298525, 22925.42686432819, 8455.408121431441, 8578.18507241811, 8784.121587841164, 8842.513661748537, 8873.556322183866, 5069.6451248413, 5103.183490641553, 5107.668001579886, 5125.4874512549195, 5181.3782346118705, 3567.7502574820032, 3684.2999830032745, 3688.926221475609, 3689.8524059037336, 3696.537932758405, 677.4512644757762, 680.9080774095434, 689.5001124184926, 691.5332150798191, 701.8526109517059, 652.46171908175, 669.8660267946431, 672.1430176524872, 688.9483288753263, 715.8103102677794, 9926.602935882629, 10105.595776169019, 10141.340812847142, 10200.591976321013, 10271.229657775697, 592.0674936974283, 667.609448472649, 668.1680561977058, 689.2693744630708, 726.46604745512, 4670.915065219542, 4772.880677983078, 4868.488808675038, 4888.535589119028, 4945.480724523945, 71029.0, 97758.51120744493, 99006.5049674747, 100926.49536752269, 115504.0, 68758.65620671965, 90964.0, 108328.0, 111967.0, 115052.42473787577, 77095.61452192703, 99615.0, 100547.0, 101269.0, 102346.48826755819, 10294.536745846304, 10642.308249964037, 10761.192910531898, 10788.730281743019, 10901.454927253448, 53791.73104134611, 54557.18164227619, 55407.16889246745, 55725.606859828826, 55743.0, 75868.0, 85183.0, 85583.57208213919, 86177.0, 86373.56813215894, 14366.425342986164, 14383.0, 14384.208868512333, 14418.206998615176, 14715.411383544966, 14482.927585362006, 14695.0, 16092.839071609602, 16327.836721632631, 16821.0, 15026.398944042116, 15118.0, 15253.923730381277, 15398.46105386306, 16070.116143611745, 14855.554333370017, 15362.923185384001, 15428.0, 15546.144962027198, 16142.435014774426, 12569.622911312676, 12600.936995314965, 12655.177413468095, 12854.357282136043, 13383.39774710121, 11870.703232419259, 12065.457054432396, 12503.249805011728, 12851.485940562272, 12866.935665321613, 12091.516339346328, 12190.878091219329, 12441.379858516682, 12477.5008999639, 12505.56230531927], "value": 8026.224380109452, "unit": "score"}], "name": "dromaeo_css", "value": 7497.71889329004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 113.0, 110.0, 111.0, 111.0, 112.0, 114.0, 110.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 123.0, 126.0, 174.0, 129.0, 124.0, 149.0, 128.0, 167.0, 125.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 125.0, 74.0, 76.0, 76.0, 75.0, 97.0, 74.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 84.0, 84.0, 85.0, 122.0, 84.0, 84.0, 119.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 52.0, 51.0, 50.0, 52.0, 51.0, 52.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 77.0, 76.0, 80.0, 82.0, 80.0, 76.0, 106.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 117.0, 124.0, 115.0, 112.0, 113.0, 115.0, 139.0, 120.0], "value": 119.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 153.0, 158.0, 154.0, 153.0, 154.0, 153.0, 154.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 60.0, 60.0, 61.0, 61.0, 59.0, 61.0, 60.0], "value": 60.5, "unit": "score"}], "name": "kraken", "value": 1471.3000000000002, "alertThreshold": 2.0}]} 15:17:34 INFO - Return code: 0 15:17:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:17:34 ERROR - # TBPL SUCCESS # 15:17:34 INFO - Running post-action listener: _resource_record_post_action 15:17:34 INFO - ##### 15:17:34 INFO - ##### Finished run-tests step (success) 15:17:34 INFO - ##### 15:17:34 INFO - Running post-run listener: _resource_record_post_run 15:17:34 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 286720; Write bytes: 357388288; Read time: 32; Write time: 219768 15:17:34 INFO - TinderboxPrint: CPU usage
13.1% 15:17:34 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 32 15:17:34 INFO - TinderboxPrint: I/O write bytes / time
357,388,288 / 219,768 15:17:34 INFO - TinderboxPrint: CPU idle
8,249.6 (86.9%) 15:17:34 INFO - TinderboxPrint: CPU user
1,196.8 (12.6%) 15:17:34 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103477248; Read time: 0; Write time: 66176 15:17:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 253911040; Read time: 16; Write time: 153592 15:17:35 INFO - Running post-run listener: _upload_blobber_files 15:17:35 INFO - Blob upload gear active. 15:17:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:35 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 15:17:35 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'] 15:17:35 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 15:17:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:39 INFO - (blobuploader) - INFO - Done attempting. 15:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:17:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:39 INFO - (blobuploader) - INFO - Done attempting. 15:17:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:17:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:17:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:40 INFO - (blobuploader) - INFO - Done attempting. 15:17:40 INFO - (blobuploader) - INFO - Iteration through files over. 15:17:40 INFO - Return code: 0 15:17:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:17:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:17:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c126d47104b5a88d626ab1025a3f9d2905bc78de2bb63c31223c5fe790958715b2b0ddcbb689e334b6a99d47bf08bc89532a1056d51bad9ca14e369b1901081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/364c57b4658d49b05eaf916325417805a90bb1567935750c4a5c2dd6826700b6ad0ad6e96e72ec4950146d624b1aa81e9e3628d094bc244181e325fa68a27ddf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242c5e516997558129fd759f466cd460d14035918013c218c48c2e6f3685db3c50aff57c142c1045cf2aa906546face350842eb8b3aed9a3135ea2a8ec6b606d"} 15:17:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:17:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:17:40 INFO - Contents: 15:17:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c126d47104b5a88d626ab1025a3f9d2905bc78de2bb63c31223c5fe790958715b2b0ddcbb689e334b6a99d47bf08bc89532a1056d51bad9ca14e369b1901081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/364c57b4658d49b05eaf916325417805a90bb1567935750c4a5c2dd6826700b6ad0ad6e96e72ec4950146d624b1aa81e9e3628d094bc244181e325fa68a27ddf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242c5e516997558129fd759f466cd460d14035918013c218c48c2e6f3685db3c50aff57c142c1045cf2aa906546face350842eb8b3aed9a3135ea2a8ec6b606d"} 15:17:40 INFO - Running post-run listener: copy_logs_to_upload_dir 15:17:40 INFO - Copying logs to upload dir... 15:17:40 INFO - mkdir: /builds/slave/test/build/upload/logs 15:17:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.059560 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-09 15:17:39.966467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 15:17:39.969988) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c126d47104b5a88d626ab1025a3f9d2905bc78de2bb63c31223c5fe790958715b2b0ddcbb689e334b6a99d47bf08bc89532a1056d51bad9ca14e369b1901081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/364c57b4658d49b05eaf916325417805a90bb1567935750c4a5c2dd6826700b6ad0ad6e96e72ec4950146d624b1aa81e9e3628d094bc244181e325fa68a27ddf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242c5e516997558129fd759f466cd460d14035918013c218c48c2e6f3685db3c50aff57c142c1045cf2aa906546face350842eb8b3aed9a3135ea2a8ec6b606d"} build_url:https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011114 build_url: 'https://queue.taskcluster.net/v1/task/B29I-zWjSGKK5lObJhZaWA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7c126d47104b5a88d626ab1025a3f9d2905bc78de2bb63c31223c5fe790958715b2b0ddcbb689e334b6a99d47bf08bc89532a1056d51bad9ca14e369b1901081", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/364c57b4658d49b05eaf916325417805a90bb1567935750c4a5c2dd6826700b6ad0ad6e96e72ec4950146d624b1aa81e9e3628d094bc244181e325fa68a27ddf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/242c5e516997558129fd759f466cd460d14035918013c218c48c2e6f3685db3c50aff57c142c1045cf2aa906546face350842eb8b3aed9a3135ea2a8ec6b606d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 15:17:39.995375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 15:17:39.995722) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468099555.777016-783861379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 15:17:40.077627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 15:17:40.077944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 15:17:40.078289) ========= ========= Total master_lag: 0.23 =========