builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1468477368.09 results: success (0) buildid: 20160713152443 builduid: fb5f9fc9a81843ef95c1b9ce84958adb revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.088006) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.088435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.088729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.102885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.103150) ========= 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-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 23:22:48-- 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% 9.41M=0.001s 2016-07-13 23:22:48 (9.41 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.261205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.261522) ========= 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-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016328 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:48.311352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:48.311710) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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 709652b674013b136627e45fd90b4e9063906a19 --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-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 23:22:48,971 truncating revision to first 12 chars 2016-07-13 23:22:48,971 Setting DEBUG logging. 2016-07-13 23:22:48,971 attempt 1/10 2016-07-13 23:22:48,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 23:22:49,710 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=1.077676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 23:22:49.403404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:49.403817) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:49.404224) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:49.404516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 23:22:49.415372) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:22:49.415683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:22:50 INFO - MultiFileLogger online at 20160713 23:22:50 in /builds/slave/test 23:22:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:22:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:22:50 INFO - {'append_to_log': False, 23:22:50 INFO - 'base_work_dir': '/builds/slave/test', 23:22:50 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:22:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:22:50 INFO - 'branch': 'Mozilla-Aurora', 23:22:50 INFO - 'buildbot_json_path': 'buildprops.json', 23:22:50 INFO - 'config_files': ('talos/linux_config.py',), 23:22:50 INFO - 'default_actions': ('clobber', 23:22:50 INFO - 'read-buildbot-config', 23:22:50 INFO - 'download-and-extract', 23:22:50 INFO - 'populate-webroot', 23:22:50 INFO - 'create-virtualenv', 23:22:50 INFO - 'install', 23:22:50 INFO - 'run-tests'), 23:22:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:22:50 INFO - 'download_minidump_stackwalk': True, 23:22:50 INFO - 'download_symbols': 'ondemand', 23:22:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:22:50 INFO - 'tooltool.py': '/tools/tooltool.py', 23:22:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:22:50 INFO - '/tools/misc-python/virtualenv.py')}, 23:22:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:22:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:22:50 INFO - 'installer_path': 'installer.exe', 23:22:50 INFO - 'log_level': 'info', 23:22:50 INFO - 'log_name': 'talos', 23:22:50 INFO - 'log_to_console': True, 23:22:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:22:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:22:50 INFO - 'opt_config_files': (), 23:22:50 INFO - 'pip_index': False, 23:22:50 INFO - 'sps_profile': False, 23:22:50 INFO - 'sps_profile_interval': 0, 23:22:50 INFO - 'suite': 'dromaeojs-e10s', 23:22:50 INFO - 'system_bits': '32', 23:22:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:22:50 INFO - 'title': 'talos-linux64-ix-040', 23:22:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:22:50 INFO - 'use_talos_json': True, 23:22:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:22:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:22:50 INFO - 'work_dir': 'build'} 23:22:50 INFO - ##### 23:22:50 INFO - ##### Running clobber step. 23:22:50 INFO - ##### 23:22:50 INFO - Running pre-action listener: _resource_record_pre_action 23:22:50 INFO - Running main action method: clobber 23:22:50 INFO - rmtree: /builds/slave/test/build 23:22:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:22:50 INFO - Running post-action listener: _resource_record_post_action 23:22:50 INFO - ##### 23:22:50 INFO - ##### Finished clobber step (success) 23:22:50 INFO - ##### 23:22:50 INFO - ##### 23:22:50 INFO - ##### Running read-buildbot-config step. 23:22:50 INFO - ##### 23:22:50 INFO - Running pre-action listener: _resource_record_pre_action 23:22:50 INFO - Running main action method: read_buildbot_config 23:22:50 INFO - Using buildbot properties: 23:22:50 INFO - { 23:22:50 INFO - "project": "", 23:22:50 INFO - "product": "firefox", 23:22:50 INFO - "script_repo_revision": "production", 23:22:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 23:22:50 INFO - "repository": "", 23:22:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 23:22:50 INFO - "buildid": "20160713152443", 23:22:50 INFO - "pgo_build": "True", 23:22:50 INFO - "basedir": "/builds/slave/test", 23:22:50 INFO - "buildnumber": 417, 23:22:50 INFO - "slavename": "talos-linux64-ix-040", 23:22:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:22:50 INFO - "platform": "ubuntu64_hw", 23:22:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:22:50 INFO - "branch": "mozilla-aurora", 23:22:50 INFO - "repo_path": "releases/mozilla-aurora", 23:22:50 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 23:22:50 INFO - "stage_platform": "linux64-pgo", 23:22:50 INFO - "builduid": "fb5f9fc9a81843ef95c1b9ce84958adb", 23:22:50 INFO - "slavebuilddir": "test" 23:22:50 INFO - } 23:22:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:22:50 INFO - Running post-action listener: _resource_record_post_action 23:22:50 INFO - ##### 23:22:50 INFO - ##### Finished read-buildbot-config step (success) 23:22:50 INFO - ##### 23:22:50 INFO - ##### 23:22:50 INFO - ##### Running download-and-extract step. 23:22:50 INFO - ##### 23:22:50 INFO - Running pre-action listener: _resource_record_pre_action 23:22:50 INFO - Running main action method: download_and_extract 23:22:50 INFO - mkdir: /builds/slave/test/build/tests 23:22:50 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')]} 23:22:50 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:22:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:51 INFO - Downloaded 1361 bytes. 23:22:51 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:22:51 INFO - Using the following test package requirements: 23:22:51 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:51 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:22:51 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:22:51 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'jsshell-linux-x86_64.zip'], 23:22:51 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:22:51 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:22:51 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:22:51 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:22:51 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:22:51 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:22:51 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:22:51 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:22:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:51 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:52 INFO - Downloaded 24491003 bytes. 23:22:52 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'] 23:22:52 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 23:22:53 INFO - Return code: 0 23:22:53 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 23:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:53 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:22:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:22:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:54 INFO - Downloaded 24491003 bytes. 23:22:54 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'] 23:22:54 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 23:22:56 INFO - Return code: 0 23:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:22:56 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:22:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:22:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:57 INFO - Downloaded 10833369 bytes. 23:22:57 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'] 23:22:57 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 23:22:57 INFO - Return code: 0 23:22:57 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')]} 23:22:57 INFO - https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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 23:22:58 INFO - Downloaded 63642548 bytes. 23:22:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:58 INFO - mkdir: /builds/slave/test/properties 23:22:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:22:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:22:58 INFO - Contents: 23:22:58 INFO - build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:22:59 INFO - Running post-action listener: _resource_record_post_action 23:22:59 INFO - Running post-action listener: set_extra_try_arguments 23:22:59 INFO - ##### 23:22:59 INFO - ##### Finished download-and-extract step (success) 23:22:59 INFO - ##### 23:22:59 INFO - ##### 23:22:59 INFO - ##### Running populate-webroot step. 23:22:59 INFO - ##### 23:22:59 INFO - Running pre-action listener: _resource_record_pre_action 23:22:59 INFO - Running main action method: populate_webroot 23:22:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:22:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:22:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:22:59 INFO - '--tppagecycles', 23:22:59 INFO - '7'], 23:22:59 INFO - 'tests': ['tsvgm']}}, 23:22:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:22:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:22:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:22:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:22:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['damp', 'tps']}, 23:22:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'tests': ['damp', 'tps']}, 23:22:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['dromaeo_dom']}, 23:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:22:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['a11yr', 23:22:59 INFO - 'ts_paint', 23:22:59 INFO - 'tpaint', 23:22:59 INFO - 'sessionrestore', 23:22:59 INFO - 'sessionrestore_no_auto_restore', 23:22:59 INFO - 'tabpaint']}, 23:22:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['tsvgx', 23:22:59 INFO - 'tsvgr_opacity', 23:22:59 INFO - 'tart', 23:22:59 INFO - 'tscrollx', 23:22:59 INFO - 'cart']}, 23:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:22:59 INFO - 'tsvgr_opacity', 23:22:59 INFO - 'tart', 23:22:59 INFO - 'tscrollx', 23:22:59 INFO - 'cart']}, 23:22:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'talos_options': ['--disable-e10s'], 23:22:59 INFO - 'tests': ['tp5o']}, 23:22:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'tests': ['tp5o']}, 23:22:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'talos_options': ['--disable-e10s', 23:22:59 INFO - '--xperf_path', 23:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:59 INFO - 'tests': ['tp5n']}, 23:22:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:22:59 INFO - 'talos_options': ['--xperf_path', 23:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:22:59 INFO - 'tests': ['tp5n']}}, 23:22:59 INFO - 'talos.zip': {'path': '', 23:22:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:22:59 INFO - Running post-action listener: _resource_record_post_action 23:22:59 INFO - ##### 23:22:59 INFO - ##### Finished populate-webroot step (success) 23:22:59 INFO - ##### 23:22:59 INFO - ##### 23:22:59 INFO - ##### Running create-virtualenv step. 23:22:59 INFO - ##### 23:22:59 INFO - Running pre-action listener: _resource_record_pre_action 23:22:59 INFO - Running main action method: create_virtualenv 23:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:22:59 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 23:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:22:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:22:59 INFO - Using real prefix '/usr' 23:22:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:22:59 INFO - Installing distribute.............................................................................................................................................................................................done. 23:23:01 INFO - Installing pip.................done. 23:23:01 INFO - Return code: 0 23:23:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:01 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:01 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 23:23:01 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 23:23:01 INFO - Using env: {'DISPLAY': ':0', 23:23:01 INFO - 'HOME': '/home/cltbld', 23:23:01 INFO - 'LANG': 'en_US.UTF-8', 23:23:01 INFO - 'LANGUAGE': 'en_US:en', 23:23:01 INFO - 'LOGNAME': 'cltbld', 23:23:01 INFO - 'MAIL': '/var/mail/cltbld', 23:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:01 INFO - 'MOZ_NO_REMOTE': '1', 23:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:01 INFO - 'NO_EM_RESTART': '1', 23:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:01 INFO - 'PWD': '/builds/slave/test', 23:23:01 INFO - 'SHELL': '/bin/bash', 23:23:01 INFO - 'SHLVL': '1', 23:23:01 INFO - 'TERM': 'linux', 23:23:01 INFO - 'TMOUT': '86400', 23:23:01 INFO - 'USER': 'cltbld', 23:23:01 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:01 INFO - '_': '/tools/buildbot/bin/python'} 23:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:02 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 23:23:02 INFO - Cleaning up... 23:23:02 INFO - Return code: 0 23:23:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:23:02 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')]} 23:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:02 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')]} 23:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:02 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:02 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 23:23:02 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 23:23:02 INFO - Using env: {'DISPLAY': ':0', 23:23:02 INFO - 'HOME': '/home/cltbld', 23:23:02 INFO - 'LANG': 'en_US.UTF-8', 23:23:02 INFO - 'LANGUAGE': 'en_US:en', 23:23:02 INFO - 'LOGNAME': 'cltbld', 23:23:02 INFO - 'MAIL': '/var/mail/cltbld', 23:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:02 INFO - 'MOZ_NO_REMOTE': '1', 23:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:02 INFO - 'NO_EM_RESTART': '1', 23:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:02 INFO - 'PWD': '/builds/slave/test', 23:23:02 INFO - 'SHELL': '/bin/bash', 23:23:02 INFO - 'SHLVL': '1', 23:23:02 INFO - 'TERM': 'linux', 23:23:02 INFO - 'TMOUT': '86400', 23:23:02 INFO - 'USER': 'cltbld', 23:23:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:02 INFO - '_': '/tools/buildbot/bin/python'} 23:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:02 INFO - Downloading/unpacking psutil>=3.1.1 23:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:04 INFO - Installing collected packages: psutil 23:23:04 INFO - Running setup.py install for psutil 23:23:04 INFO - building 'psutil._psutil_linux' extension 23:23:04 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 23:23:04 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 23:23:04 INFO - building 'psutil._psutil_posix' extension 23:23:04 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 23:23:04 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 23:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:04 INFO - Successfully installed psutil 23:23:04 INFO - Cleaning up... 23:23:04 INFO - Return code: 0 23:23:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:04 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:04 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 23:23:04 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 23:23:04 INFO - Using env: {'DISPLAY': ':0', 23:23:04 INFO - 'HOME': '/home/cltbld', 23:23:04 INFO - 'LANG': 'en_US.UTF-8', 23:23:04 INFO - 'LANGUAGE': 'en_US:en', 23:23:04 INFO - 'LOGNAME': 'cltbld', 23:23:04 INFO - 'MAIL': '/var/mail/cltbld', 23:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:04 INFO - 'MOZ_NO_REMOTE': '1', 23:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:04 INFO - 'NO_EM_RESTART': '1', 23:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:04 INFO - 'PWD': '/builds/slave/test', 23:23:04 INFO - 'SHELL': '/bin/bash', 23:23:04 INFO - 'SHLVL': '1', 23:23:04 INFO - 'TERM': 'linux', 23:23:04 INFO - 'TMOUT': '86400', 23:23:04 INFO - 'USER': 'cltbld', 23:23:04 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:04 INFO - '_': '/tools/buildbot/bin/python'} 23:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:05 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 23:23:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:23:07 INFO - Installing collected packages: mozsystemmonitor 23:23:07 INFO - Running setup.py install for mozsystemmonitor 23:23:07 INFO - Successfully installed mozsystemmonitor 23:23:07 INFO - Cleaning up... 23:23:07 INFO - Return code: 0 23:23:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:07 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:07 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 23:23:07 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 23:23:07 INFO - Using env: {'DISPLAY': ':0', 23:23:07 INFO - 'HOME': '/home/cltbld', 23:23:07 INFO - 'LANG': 'en_US.UTF-8', 23:23:07 INFO - 'LANGUAGE': 'en_US:en', 23:23:07 INFO - 'LOGNAME': 'cltbld', 23:23:07 INFO - 'MAIL': '/var/mail/cltbld', 23:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:07 INFO - 'MOZ_NO_REMOTE': '1', 23:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:07 INFO - 'NO_EM_RESTART': '1', 23:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:07 INFO - 'PWD': '/builds/slave/test', 23:23:07 INFO - 'SHELL': '/bin/bash', 23:23:07 INFO - 'SHLVL': '1', 23:23:07 INFO - 'TERM': 'linux', 23:23:07 INFO - 'TMOUT': '86400', 23:23:07 INFO - 'USER': 'cltbld', 23:23:07 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:07 INFO - '_': '/tools/buildbot/bin/python'} 23:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:07 INFO - Downloading/unpacking jsonschema==2.5.1 23:23:07 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 23:23:07 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 23:23:07 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 23:23:07 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 23:23:07 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 23:23:07 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 23:23:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:23:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:23:09 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 23:23:09 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 23:23:09 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 23:23:09 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 23:23:09 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 23:23:09 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 23:23:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:23:09 INFO - warning: no files found matching '*.txt' 23:23:09 INFO - no previously-included directories found matching 'build' 23:23:09 INFO - no previously-included directories found matching 'dist' 23:23:09 INFO - no previously-included directories found matching '.git*' 23:23:09 INFO - Installing collected packages: jsonschema, functools32 23:23:09 INFO - Running setup.py install for functools32 23:23:09 INFO - warning: no files found matching '*.txt' 23:23:09 INFO - no previously-included directories found matching 'build' 23:23:09 INFO - no previously-included directories found matching 'dist' 23:23:09 INFO - no previously-included directories found matching '.git*' 23:23:09 INFO - Successfully installed jsonschema functools32 23:23:09 INFO - Cleaning up... 23:23:09 INFO - Return code: 0 23:23:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23:09 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')]} 23:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:09 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')]} 23:23:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:09 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:09 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 23:23:09 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 23:23:09 INFO - Using env: {'DISPLAY': ':0', 23:23:09 INFO - 'HOME': '/home/cltbld', 23:23:09 INFO - 'LANG': 'en_US.UTF-8', 23:23:09 INFO - 'LANGUAGE': 'en_US:en', 23:23:09 INFO - 'LOGNAME': 'cltbld', 23:23:09 INFO - 'MAIL': '/var/mail/cltbld', 23:23:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:09 INFO - 'MOZ_NO_REMOTE': '1', 23:23:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:09 INFO - 'NO_EM_RESTART': '1', 23:23:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:09 INFO - 'PWD': '/builds/slave/test', 23:23:09 INFO - 'SHELL': '/bin/bash', 23:23:09 INFO - 'SHLVL': '1', 23:23:09 INFO - 'TERM': 'linux', 23:23:09 INFO - 'TMOUT': '86400', 23:23:09 INFO - 'USER': 'cltbld', 23:23:09 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:09 INFO - '_': '/tools/buildbot/bin/python'} 23:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:10 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 23:23:11 INFO - Downloading blobuploader-1.2.4.tar.gz 23:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:23:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:23:11 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 23:23:11 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 23:23:11 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 23:23:11 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 23:23:11 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 23:23:11 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 23:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:23:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:23:12 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 23:23:12 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 23:23:12 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 23:23:12 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 23:23:12 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 23:23:12 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 23:23:12 INFO - Downloading docopt-0.6.1.tar.gz 23:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:23:12 INFO - Installing collected packages: blobuploader, requests, docopt 23:23:12 INFO - Running setup.py install for blobuploader 23:23:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:23:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:23:12 INFO - Running setup.py install for requests 23:23:13 INFO - Running setup.py install for docopt 23:23:13 INFO - Successfully installed blobuploader requests docopt 23:23:13 INFO - Cleaning up... 23:23:13 INFO - Return code: 0 23:23:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:13 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:13 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 23:23:13 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 23:23:13 INFO - Using env: {'DISPLAY': ':0', 23:23:13 INFO - 'HOME': '/home/cltbld', 23:23:13 INFO - 'LANG': 'en_US.UTF-8', 23:23:13 INFO - 'LANGUAGE': 'en_US:en', 23:23:13 INFO - 'LOGNAME': 'cltbld', 23:23:13 INFO - 'MAIL': '/var/mail/cltbld', 23:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:13 INFO - 'MOZ_NO_REMOTE': '1', 23:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:13 INFO - 'NO_EM_RESTART': '1', 23:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:13 INFO - 'PWD': '/builds/slave/test', 23:23:13 INFO - 'SHELL': '/bin/bash', 23:23:13 INFO - 'SHLVL': '1', 23:23:13 INFO - 'TERM': 'linux', 23:23:13 INFO - 'TMOUT': '86400', 23:23:13 INFO - 'USER': 'cltbld', 23:23:13 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:13 INFO - '_': '/tools/buildbot/bin/python'} 23:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:13 INFO - Running setup.py (path:/tmp/pip-RM_oEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:13 INFO - Running setup.py (path:/tmp/pip-Zks6GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:13 INFO - Running setup.py (path:/tmp/pip-InA6qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:13 INFO - Running setup.py (path:/tmp/pip-8aNPD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:13 INFO - Running setup.py (path:/tmp/pip-AOgoUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:13 INFO - Running setup.py (path:/tmp/pip-W8WV0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:13 INFO - Running setup.py (path:/tmp/pip-fZaCtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:14 INFO - Running setup.py (path:/tmp/pip-uVxAgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:14 INFO - Running setup.py (path:/tmp/pip-wLaL4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:14 INFO - Running setup.py (path:/tmp/pip-NwDYwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:14 INFO - Running setup.py (path:/tmp/pip-6p42Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:14 INFO - Running setup.py (path:/tmp/pip-e6Nqhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:14 INFO - Running setup.py (path:/tmp/pip-FeW547-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:14 INFO - Running setup.py (path:/tmp/pip-9zhf8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:14 INFO - Running setup.py (path:/tmp/pip-tCt5Dg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:14 INFO - Running setup.py (path:/tmp/pip-R3sqxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:14 INFO - Running setup.py (path:/tmp/pip-4F006a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:23:14 INFO - Running setup.py install for manifestparser 23:23:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:23:14 INFO - Running setup.py install for mozcrash 23:23:14 INFO - Running setup.py install for mozdebug 23:23:15 INFO - Running setup.py install for mozdevice 23:23:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for mozfile 23:23:15 INFO - Running setup.py install for mozhttpd 23:23:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for mozinfo 23:23:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for mozInstall 23:23:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for mozleak 23:23:15 INFO - Running setup.py install for mozlog 23:23:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for moznetwork 23:23:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:23:15 INFO - Running setup.py install for mozprocess 23:23:15 INFO - Running setup.py install for mozprofile 23:23:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:23:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:23:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:23:16 INFO - Running setup.py install for mozrunner 23:23:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:23:16 INFO - Running setup.py install for mozscreenshot 23:23:16 INFO - Running setup.py install for moztest 23:23:16 INFO - Running setup.py install for mozversion 23:23:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:23:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:23:16 INFO - Cleaning up... 23:23:16 INFO - Return code: 0 23:23:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:16 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:16 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 23:23:16 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 23:23:16 INFO - Using env: {'DISPLAY': ':0', 23:23:16 INFO - 'HOME': '/home/cltbld', 23:23:16 INFO - 'LANG': 'en_US.UTF-8', 23:23:16 INFO - 'LANGUAGE': 'en_US:en', 23:23:16 INFO - 'LOGNAME': 'cltbld', 23:23:16 INFO - 'MAIL': '/var/mail/cltbld', 23:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:16 INFO - 'MOZ_NO_REMOTE': '1', 23:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:16 INFO - 'NO_EM_RESTART': '1', 23:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:16 INFO - 'PWD': '/builds/slave/test', 23:23:16 INFO - 'SHELL': '/bin/bash', 23:23:16 INFO - 'SHLVL': '1', 23:23:16 INFO - 'TERM': 'linux', 23:23:16 INFO - 'TMOUT': '86400', 23:23:16 INFO - 'USER': 'cltbld', 23:23:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:16 INFO - '_': '/tools/buildbot/bin/python'} 23:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:23:16 INFO - Running setup.py (path:/tmp/pip-DmEM4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:23:16 INFO - Running setup.py (path:/tmp/pip-i4ZRjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:23:16 INFO - Running setup.py (path:/tmp/pip-yL0idt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:23:16 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)) 23:23:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:23:16 INFO - Running setup.py (path:/tmp/pip-Spre3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:23:17 INFO - Running setup.py (path:/tmp/pip-1iFkfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:23:17 INFO - Running setup.py (path:/tmp/pip-arljD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:23:17 INFO - Running setup.py (path:/tmp/pip-97eXpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:23:17 INFO - Running setup.py (path:/tmp/pip-HMG4P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:23:17 INFO - Running setup.py (path:/tmp/pip-rkBFhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:23:17 INFO - Running setup.py (path:/tmp/pip-quqp6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:23:17 INFO - Running setup.py (path:/tmp/pip-agDD8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:23:17 INFO - Running setup.py (path:/tmp/pip-9GPgae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:23:17 INFO - Running setup.py (path:/tmp/pip-lNjiEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:23:17 INFO - Running setup.py (path:/tmp/pip-5Qq8g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:17 INFO - Running setup.py (path:/tmp/pip-avLRdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:23:17 INFO - Running setup.py (path:/tmp/pip-Nb1qOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:23:17 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)) 23:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:23:17 INFO - Running setup.py (path:/tmp/pip-Mm9cGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:23:17 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)) 23:23:17 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)) 23:23:17 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)) 23:23:17 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)) 23:23:17 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)) 23:23:17 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)) 23:23:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:19 INFO - Downloading blessings-1.6.tar.gz 23:23:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:23:19 INFO - Installing collected packages: blessings 23:23:19 INFO - Running setup.py install for blessings 23:23:20 INFO - Successfully installed blessings 23:23:20 INFO - Cleaning up... 23:23:20 INFO - Return code: 0 23:23:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:23:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:20 INFO - Reading from file tmpfile_stdout 23:23:20 INFO - Current package versions: 23:23:20 INFO - argparse == 1.2.1 23:23:20 INFO - blessings == 1.6 23:23:20 INFO - blobuploader == 1.2.4 23:23:20 INFO - docopt == 0.6.1 23:23:20 INFO - functools32 == 3.2.3-2 23:23:20 INFO - jsonschema == 2.5.1 23:23:20 INFO - manifestparser == 1.1 23:23:20 INFO - mozInstall == 1.12 23:23:20 INFO - mozcrash == 0.17 23:23:20 INFO - mozdebug == 0.1 23:23:20 INFO - mozdevice == 0.48 23:23:20 INFO - mozfile == 1.2 23:23:20 INFO - mozhttpd == 0.7 23:23:20 INFO - mozinfo == 0.9 23:23:20 INFO - mozleak == 0.1 23:23:20 INFO - mozlog == 3.2 23:23:20 INFO - moznetwork == 0.27 23:23:20 INFO - mozprocess == 0.23 23:23:20 INFO - mozprofile == 0.28 23:23:20 INFO - mozrunner == 6.12 23:23:20 INFO - mozscreenshot == 0.1 23:23:20 INFO - mozsystemmonitor == 0.3 23:23:20 INFO - moztest == 0.7 23:23:20 INFO - mozversion == 1.4 23:23:20 INFO - psutil == 3.1.1 23:23:20 INFO - requests == 1.2.3 23:23:20 INFO - wsgiref == 0.1.2 23:23:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:20 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 23:23:20 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 23:23:20 INFO - Using env: {'DISPLAY': ':0', 23:23:20 INFO - 'HOME': '/home/cltbld', 23:23:20 INFO - 'LANG': 'en_US.UTF-8', 23:23:20 INFO - 'LANGUAGE': 'en_US:en', 23:23:20 INFO - 'LOGNAME': 'cltbld', 23:23:20 INFO - 'MAIL': '/var/mail/cltbld', 23:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:20 INFO - 'MOZ_NO_REMOTE': '1', 23:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:20 INFO - 'NO_EM_RESTART': '1', 23:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:20 INFO - 'PWD': '/builds/slave/test', 23:23:20 INFO - 'SHELL': '/bin/bash', 23:23:20 INFO - 'SHLVL': '1', 23:23:20 INFO - 'TERM': 'linux', 23:23:20 INFO - 'TMOUT': '86400', 23:23:20 INFO - 'USER': 'cltbld', 23:23:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:20 INFO - '_': '/tools/buildbot/bin/python'} 23:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 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)) 23:23:20 INFO - Cleaning up... 23:23:20 INFO - Return code: 0 23:23:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:20 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 23:23:20 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 23:23:20 INFO - Using env: {'DISPLAY': ':0', 23:23:20 INFO - 'HOME': '/home/cltbld', 23:23:20 INFO - 'LANG': 'en_US.UTF-8', 23:23:20 INFO - 'LANGUAGE': 'en_US:en', 23:23:20 INFO - 'LOGNAME': 'cltbld', 23:23:20 INFO - 'MAIL': '/var/mail/cltbld', 23:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:20 INFO - 'MOZ_NO_REMOTE': '1', 23:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:20 INFO - 'NO_EM_RESTART': '1', 23:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:20 INFO - 'PWD': '/builds/slave/test', 23:23:20 INFO - 'SHELL': '/bin/bash', 23:23:20 INFO - 'SHLVL': '1', 23:23:20 INFO - 'TERM': 'linux', 23:23:20 INFO - 'TMOUT': '86400', 23:23:20 INFO - 'USER': 'cltbld', 23:23:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:20 INFO - '_': '/tools/buildbot/bin/python'} 23:23:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:23:20 INFO - Cleaning up... 23:23:20 INFO - Return code: 0 23:23:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:20 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 0x7f07b3ff5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xece350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, '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-1468477367.903359-296499436', '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 23:23:20 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 23:23:20 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 23:23:20 INFO - Using env: {'DISPLAY': ':0', 23:23:20 INFO - 'HOME': '/home/cltbld', 23:23:20 INFO - 'LANG': 'en_US.UTF-8', 23:23:20 INFO - 'LANGUAGE': 'en_US:en', 23:23:20 INFO - 'LOGNAME': 'cltbld', 23:23:20 INFO - 'MAIL': '/var/mail/cltbld', 23:23:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:20 INFO - 'MOZ_NO_REMOTE': '1', 23:23:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:20 INFO - 'NO_EM_RESTART': '1', 23:23:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:20 INFO - 'PWD': '/builds/slave/test', 23:23:20 INFO - 'SHELL': '/bin/bash', 23:23:20 INFO - 'SHLVL': '1', 23:23:20 INFO - 'TERM': 'linux', 23:23:20 INFO - 'TMOUT': '86400', 23:23:20 INFO - 'USER': 'cltbld', 23:23:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:20 INFO - '_': '/tools/buildbot/bin/python'} 23:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:21 INFO - Downloading/unpacking flake8 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:23:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:23:22 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 23:23:22 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 23:23:22 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 23:23:22 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 23:23:22 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 23:23:22 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 23:23:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:23:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:23 INFO - no previously-included directories found matching 'docs/_build' 23:23:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:23:23 INFO - Running setup.py install for pep8 23:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:23:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:23:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:23:23 INFO - no previously-included directories found matching 'docs/_build' 23:23:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:23:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:23:23 INFO - Cleaning up... 23:23:23 INFO - Return code: 0 23:23:23 INFO - Running post-action listener: _resource_record_post_action 23:23:23 INFO - Running post-action listener: _start_resource_monitoring 23:23:23 INFO - Starting resource monitoring. 23:23:23 INFO - ##### 23:23:23 INFO - ##### Finished create-virtualenv step (success) 23:23:23 INFO - ##### 23:23:23 INFO - ##### 23:23:23 INFO - ##### Running install step. 23:23:23 INFO - ##### 23:23:23 INFO - Running pre-action listener: _resource_record_pre_action 23:23:23 INFO - Running main action method: install 23:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:23:24 INFO - Reading from file tmpfile_stdout 23:23:24 INFO - Detecting whether we're running mozinstall >=1.0... 23:23:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:23:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:23:24 INFO - Reading from file tmpfile_stdout 23:23:24 INFO - Output received: 23:23:24 INFO - Usage: mozinstall [options] installer 23:23:24 INFO - Options: 23:23:24 INFO - -h, --help show this help message and exit 23:23:24 INFO - -d DEST, --destination=DEST 23:23:24 INFO - Directory to install application into. [default: 23:23:24 INFO - "/builds/slave/test"] 23:23:24 INFO - --app=APP Application being installed. [default: firefox] 23:23:24 INFO - mkdir: /builds/slave/test/build/application 23:23:24 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'] 23:23:24 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 23:23:40 INFO - Reading from file tmpfile_stdout 23:23:40 INFO - Output received: 23:23:40 INFO - /builds/slave/test/build/application/firefox/firefox 23:23:40 INFO - Running post-action listener: _resource_record_post_action 23:23:40 INFO - ##### 23:23:40 INFO - ##### Finished install step (success) 23:23:40 INFO - ##### 23:23:40 INFO - ##### 23:23:40 INFO - ##### Running run-tests step. 23:23:40 INFO - ##### 23:23:40 INFO - Running pre-action listener: _resource_record_pre_action 23:23:40 INFO - Running main action method: run_tests 23:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:23:40 INFO - Python 2.7.3 23:23:40 INFO - Return code: 0 23:23:40 INFO - grabbing minidump binary from tooltool 23:23:40 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')]} 23:23:40 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 0xf5d1c0>, '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 0xf5e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:23:40 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 23:23:40 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 23:23:40 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 23:23:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:23:40 INFO - Return code: 0 23:23:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:23:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:23:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:23:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:23:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:23:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:23:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:23:41 INFO - Return code: 0 23:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:23:41 INFO - Using env: {'DISPLAY': ':0', 23:23:41 INFO - 'HOME': '/home/cltbld', 23:23:41 INFO - 'LANG': 'en_US.UTF-8', 23:23:41 INFO - 'LANGUAGE': 'en_US:en', 23:23:41 INFO - 'LOGNAME': 'cltbld', 23:23:41 INFO - 'MAIL': '/var/mail/cltbld', 23:23:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:23:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:41 INFO - 'MOZ_NO_REMOTE': '1', 23:23:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:41 INFO - 'NO_EM_RESTART': '1', 23:23:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:41 INFO - 'PWD': '/builds/slave/test', 23:23:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:23:41 INFO - 'SHELL': '/bin/bash', 23:23:41 INFO - 'SHLVL': '1', 23:23:41 INFO - 'TERM': 'linux', 23:23:41 INFO - 'TMOUT': '86400', 23:23:41 INFO - 'USER': 'cltbld', 23:23:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468477367.903359-296499436', 23:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:41 INFO - '_': '/tools/buildbot/bin/python'} 23:23:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:23:41 INFO - mozversion application_buildid: 20160713152443 23:23:41 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:23:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:23:41 INFO - mozversion application_name: Firefox 23:23:41 INFO - mozversion application_remotingname: firefox-dev 23:23:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:41 INFO - mozversion application_vendor: Mozilla 23:23:41 INFO - mozversion application_version: 49.0a2 23:23:41 INFO - mozversion platform_buildid: 20160713152443 23:23:41 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 23:23:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:23:41 INFO - mozversion platform_version: 49.0a2 23:23:41 INFO - using testdate: 1468477421 23:23:41 INFO - actual date: 1468477421 23:23:41 INFO - starting webserver on 'localhost:59459' 23:23:41 INFO - SUITE-START | Running 2 tests 23:23:41 INFO - TEST-START | dromaeo_css 23:23:41 INFO - operating with platform_type : linux_ 23:23:41 INFO - Initialising browser for dromaeo_css test... 23:23:41 INFO - TEST-INFO | started process 7103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1OKIJn/profile http://localhost:59459/getInfo.html) 23:23:45 INFO - PROCESS | 7103 | __metrics Screen width/height:1600/1200 23:23:45 INFO - PROCESS | 7103 | colorDepth:24 23:23:45 INFO - PROCESS | 7103 | Browser inner width/height: 1024/697 23:23:45 INFO - PROCESS | 7103 | __metrics 23:23:46 ERROR - PROCESS | 7103 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:23:47 INFO - TEST-INFO | 7103: exit 0 23:23:47 INFO - Browser initialized. 23:23:47 INFO - Running cycle 1/1 for dromaeo_css test... 23:23:47 INFO - TEST-INFO | started process 7231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1OKIJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:23:59 INFO - PROCESS | 7231 | RSS: Main: 155971584 23:23:59 INFO - PROCESS | 7231 | 23:24:48 INFO - PROCESS | 7231 | 1468477488836 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] 23:26:56 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59459/tests/dromaeo/cssquery-ext.html) 23:26:57 INFO - PROCESS | 7231 | RSS: Main: 159170560 23:26:57 INFO - PROCESS | 7231 | 23:29:59 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-ext.html (next: http://localhost:59459/tests/dromaeo/cssquery-jquery.html) 23:30:00 INFO - PROCESS | 7231 | RSS: Main: 157577216 23:30:00 INFO - PROCESS | 7231 | 23:33:02 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59459/tests/dromaeo/cssquery-mootools.html) 23:33:02 INFO - PROCESS | 7231 | RSS: Main: 157630464 23:33:02 INFO - PROCESS | 7231 | 23:36:04 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59459/tests/dromaeo/cssquery-prototype.html) 23:36:05 INFO - PROCESS | 7231 | RSS: Main: 157032448 23:36:05 INFO - PROCESS | 7231 | 23:39:07 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59459/tests/dromaeo/cssquery-yui.html) 23:39:08 INFO - PROCESS | 7231 | RSS: Main: 158531584 23:39:08 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | Cycle 1(1): loaded http://localhost:59459/tests/dromaeo/cssquery-yui.html (next: http://localhost:59459/tests/dromaeo/cssquery-dojo.html) 23:42:10 INFO - PROCESS | 7231 | RSS: Main: 159133696 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | __start_tp_report 23:42:10 INFO - PROCESS | 7231 | _x_x_mozilla_page_load 23:42:10 INFO - PROCESS | 7231 | _x_x_mozilla_page_load_details 23:42:10 INFO - PROCESS | 7231 | |i|pagename|runs| 23:42:10 INFO - PROCESS | 7231 | |0;dojo.html;3319.7012268895796;3319.8008119512833;3335.5830521184853;3353.2119951811337;3363.7645364824457;5577.52591029763;5577.581681373903;5581.190727344532;5588.916166257504;5592.189132575784;5581.469760372768;5600.887982240352;5649.152627105926;5649.46330098641;5679.176519404684;5091.43994160643;5147.665401748893;5196.480351964811;5204.42751297357;5207;5152.278680984647;5153.665011774241;5215.426303106655;5219.373675158986;5229.3201883755055;5115.795368185287;5118.513741194581;5156.303898973628;5166.354205724285;5186.844394668166;5192.974035129819;5204.869878253036;5233.450487698813;5234.42421333653;5264.92102618461;4982.975085124587;5082.974585127087;5141.485851414866;5197.610179236573;5217.73911304437;5427.701476418795;5436.320459942507;5478.150886612581;5512.944870551283;5540.944590554083;5923.703814809242;5963.045912653998;5974.910376344358;5977.790777322773;5983.222181116427;5847.649141051551;5898.056310990221;6019.969900150515;6032.849178770522;6041;5562.694051827148;5620.213170156181;5624.746886390122;5640.351359593658;5684.033714268584;6123.785667501616;6130.386961303923;6157;6160.44555989963;6177.536684748572;5710;5811.82564523065;5835.824925252165;5836.124581312837;5880;6035.39646035393;6040.214772079689;6056.273247210363;6057.303410107894;6084.5132389408745;5928.081147422156;5978.3124940631515;5983.640981541122;6019.247594050744;6045.909311360333;5825.0679891217205;5960.195373624505;5984.3417224105315;6002.729877155539;6008.609440386361;4641.559051890065;4643.86068417948;4645.976770116128;4646.558576935186;4661.627069834473;4146.150039241948;4149.37759336102;4151.667866570728;4168.874933751992;4184.163167366539;5673.687947162863;5749.741261643236;5757.798477053283;5793.362730099686;5863.120531920161;5973.402659734079;5996.070609055603;6031.9396806032255;6032.3967603239325;6037.0642550404755;5795.768169273182;5830.475257226785;5837.182794408786;5847.356790753014;5854.912176317359;5017.7491125443585;5126.461721519261;5175.689458632494;5202.03762303975;5202.791888324425;6263.31103578606;6281.654509001957;6309.747610095636;6336.366363363719;6340.619562826245;6032.487238584682;6055.455009049207;6070.3019152798;6080.209572755513;6082.422169893853;6081.118237855575;6120.569035656853;6168.629882207082;6198.473129784019;6300.873982520232;5939.851503712442;5940.049592065422;5944.881102377842;5958.463738263577;5976.9103463448955;5961.135635332939;6009.87980240384;6013.218281623361;6030.095485677183;6039.486643635164;5712.34308054579;5809.9419005809405;5831.446012628963;5855.882882342415;5886.175935368966;5821.476067153807;5854.385289544536;5865.824025279248;5869.589128760946;5889.175515427758;5651.180578816131;5778.624389414675;5780.161876527964;5788.334341550775;5791.739371728198;5835.066389377679;5848;5864.618799778001;5933.792317268875;5953.255843019622;5750.281214848144;5786.132080188006;5798.710064496674;5807.738651760596;5848.678322692293 23:42:10 INFO - PROCESS | 7231 | |1;ext.html;642.370476932606;658.3811217455591;663.5885750834482;676.7834293026227;688.2773088257328;38230.61769382306;40038.598649047286;43459;43528.347074793906;43601.563984360146;44126.55873441265;44859.77570112153;45135.774321128345;45225.77387113068;45356;8694.47833130011;8942.776430589221;9006.819863602725;9010.098990101003;9029.142231488031;8766.430182038148;8773;8833.46999180048;8854.955725221365;8900.154485323885;8882.689105881296;8924.107589241057;8938.821223575556;8940.19538241558;8946.284297256236;8885.289176865836;8893.066228046058;8920.687775927876;8922.241609463172;8931.464112153259;8721.476711397336;8810.118988101203;8818.470891746452;8823.205911467998;8856.822863542757;35660.465093023624;41588.58411415877;42274;42406.57593424057;42439.1512169758;3534.9823250883837;3684.521012268415;3790.469334293201;3819.312523745725;3859.3053250414914;31994.200144996328;32735.345293094004;32907.341853162805;33187;33510.329793403995;4207.873763787091;4211.873643790691;4229.2598795210715;4238.131183107455;4257.40396344512;307840;312347;313241;313729;315462;37919.62080379216;38175.80912095422;38298;38342.80828595839;38535.229295413934;38224.42663360052;40211.79894100511;40370.394444083366;40408.79795601003;40594.391084133764;15294.770578441332;15452.381904723685;15484.5354639361;15505;15519.37922483088;12526.185797923106;12565.748685026248;12588.181768185039;12657.43041563132;12721.04592155592;9188.770280742901;9226.677066302782;9226.769330766785;9278.443293402417;9283.814323713488;3539.964600354015;3579.588347340037;3603.549556305462;3633.0372451300427;3662.1760103976394;1095.90684791792;1106.9557217711201;1118.429600903545;1164.7495788405533;1203.7050922524038;33240.501392479135;33606.49590256148;33611.83194084063;33703.83148084244;33787.15532111717;1159.4898244772442;1210.8002179640262;1210.9455074521668;1230;1242.7079636285466;17433;17498;17661.558461038578;17731.202095905715;17828.643427131385;570880;575982;592202.0779792147;621351;915100;57322.42677573254;63529.682351587944;63575.682121589096;63657.36342636607;63750;1461.0722191408531;1487.7098965701584;1489.4637930345068;1489.649932265895;1494.6039299585618;32180.83909580437;32547.349053018334;32606.722068697338;32732.836335818167;33511.49732753962;54039;54342.456575435324;54842;54965.450345496036;55018.449815502936;416001;416759;417766;418336;418552;45875.77062114668;47122.76438617785;47281;47722.52277477181;47859.28211076767;47740;51311.486885132166;51424;52352;52719;43273.78363108164;43371.56628433801;44057.339139912285;44165.11669766651;45937.081258375314;43034;44245.336319954586;44812.32781508345;44921;45158.54841451543;44994.1001179968;45114;45131.54868451405;45295.773521132185;45633.087338252386;37747;38611;38648.42027369535;39346.213075738895;39676.80161599174;29436.264093397836;29858.552121718625;30155;30330.545041824833;30444.84777576098 23:42:10 INFO - PROCESS | 7231 | |2;jquery.html;429.23167530121066;429.76792532032704;430.7286409561976;436.33458975063047;444.40671703276126;19598.804011959877;19631.116599753008;20626;20646;20767.169313227452;16719;16830.57923551912;17582.736258956127;17640.206190721416;17797.7330340045;5493.23094766732;5691.146328050784;5840.649561026331;5845.415458454163;5845.620034697752;5684.630499017571;5711.371749107595;5754.712264386785;5756.251687280647;5769.04810706233;5729.427057294258;5826.854328641775;5842.0652695568715;5854.297484301868;5882.794102206423;5620.634658747168;5808.796692115798;5839.182514447981;5850.561207909403;5867.618604790697;5254.527092561688;5258.789648414059;5261.289725886994;5281.287026251445;5297.788088476456;23605.00439683425;23615;23749;23839.523209535713;24570.262892113264;2531;2618.4108575570344;2675.598660200966;2742.4515096980485;3020.4412183746076;10282.280240383176;10529.894701052968;10543.261971661987;10909.618163364245;10924.836127458095;2081.2715549557533;2099.3806826985924;2152.9569408611897;2186.7703891091364;2195.692603035576;60417.6979115106;82531.5873420635;82709;83246.16753832505;85365;9802.46086465237;9957.950210248902;10277.794444111076;10547;11928.761424771455;14303.78544321836;14373.64065898361;14461.855381446261;14504;14534.563963081124;7999.120096789348;8120.3503719702285;8140.877886831702;8249.968753905761;8278.668853245803;8039.839203215903;8092.109867914524;8122.431429799857;8201.179882011871;8225.218604232588;4447.755373454426;4455.598996090367;4487.753173575485;4611.838585649486;4614.561616646413;2089.0884840371195;2105.5473073289318;2113.524456997194;2135.978640213609;2163.945901352479;980.8234517786724;990.7027891632481;996.7109538233976;1016.1362841584742;1092.0771947704177;19087.809121908882;20196.79803201949;20218.393448196577;20306.492337691678;20581.38255852327;1025.1747343388495;1051.7002654243504;1064.8722153341648;1095.3592148593161;1112.9816218160292;10985.231033827555;11240.213185076966;11354.26197297173;11492.253003554742;11531.077513798877;341861;342551;344566;472225;484405;76756.2324376749;99771;101227.49386253022;104637;106137;1049.5959055763585;1110.655696734015;1116.3023110556064;1125.178619607691;1130.463030060731;16987.63470228922;17133.485995420157;17477.912610436866;17510;17542.73685894738;30880;37264;44328.7783561093;44567.33149002703;44863;60408.69795651169;60851;60863;61944.69027654833;62486;5753.8561535961935;6951.096357473496;8000.119986801564;8080.2727754502375;8803.779905502413;11608.825867612162;13651;13853.238071905738;14076.225807580682;14086.436542538184;11979.341136237243;12093;12154.331511766937;12281.877181228074;12457.065720071212;11960.162788604714;12012.579559715718;12258;12416.565420210249;12529.436175371948;10991.945040274748;12270;12482.875171248534;12528.436220369922;12847.807282890577;8021.558814265038;8542.829143416973;8696.478211307342;8770.079141690287;8857.778555535906;12264.202826816228;12351.93824030874;12423.44094515767;12426.502939882303;12447.377631118588 23:42:10 INFO - PROCESS | 7231 | |3;mootools.html;1574.6535762132335;1598.512453701621;1842.9447116586507;1936.9128389222483;1942.786293507713;8758.562071896411;9390.295727820416;9438.103380178889;9998.10017098461;10119.949400253006;9540.236781057516;9785.266105042132;9818.656347027856;9873.456959867204;9891.703248902526;2490.3276115448816;2556.5398228318895;2556.75710807473;2557.884895179712;2558.9488210235786;2500.437401584647;2546.732593077728;2572.6526918865993;2573.691157061155;2574.5108429398356;2540.491901619674;2549.7960163186995;2564.871756412181;2573.5367633825904;2576;2505.2734706934966;2508.8118391120647;2510.6736124303907;2519.433127546306;2545.6945166579944;2400.9039638414442;2412.8311018228733;2431.756824317572;2435.342457536473;2488.9875550622314;9568.952155239249;9682.854757178648;9703.563339649732;9744.90255097447;9774.51127443625;5341.893162136775;5399.217113518518;5416.8104116355735;5507.421720719307;5518.834434966958;3608.170120872188;3635.745497815154;3729.664330210294;3811.6760075393627;3866.5553461352024;1239.2254840724547;1256.108163204117;1282.3588205897051;1282.5767496726057;1305.549585393038;13326.600201993859;13350.26573538455;13402.865971340358;13405.329733513383;13439;4912.263160525949;4978.5270399312;5007.148784706608;5050.621203409759;5063.544281014726;11215.66353009411;11227.943860280646;11300.604478843201;11302.604408845651;11307.660770176908;5456.672599644034;5468.097763868917;5503.642263252876;5505.779768809283;5506.531944784738;4476.462824461086;4893.7063776173545;4926.989967056745;5038;5039.143345631252;4444.644428445717;4454.22051141049;4520.028193938319;4548.204064288736;4670.673052886334;1375.312343828086;1391.7355702416507;1408.6971301170297;1425.8788003019858;1426.2440906319666;1068.823644098715;1070.839374093892;1076.2627600093804;1094.9452527373599;1113.8273567597034;6576.210854697371;6596.538242323088;6722.1261236039;6759.425448836806;6859.657017149123;486.7420267258359;487.8536439068265;491.4765774450199;1016.6746641074785;1163.4822503985815;4647.697899636512;4675.4155730533685;4755.429348478205;4804.495527969582;4838.250071238964;11862.169648124722;12396.75206495865;12514.561990330294;12546.309952952675;12587.559435419716;12164.330961797186;12357.135000549875;12424.813627795591;12548.937255313665;12609.180403273758;8836.381453298207;8874.334424918157;8960.775980600538;8968.192862642394;9029.819403611891;6592.472602191718;6676.365745254193;6707.8323041922395;6781.355771201728;6856.588604683735;11153.553857845594;11421.885781142082;11505.769884602429;11575.652730418102;11589.188756786943;11530.250533715282;11700.47347869365;11855.288682679067;11899.750526194624;12008;7770.261825126604;8436.198561136682;8570.228679418882;8813.206811387006;8965.686200982935;9471.384360016576;9526.142647161789;9578.521073946415;9613.471259080818;9616.711498655051;8304.128066553167;8543.0602633709;8582.699605513777;8680.175383338572;8709.869351959853;8021.879671805044;8077.959610201911;8365.372597055368;8415.45299555527;8424.11546787603;7675.270849269311;8034.35725141999;8080.797980050311;8200.05699344583;8212.958935205286;5733.885322293614;5895.29256489224;5949.494292985145;5991.221141251784;6016.368281330398;5197.792088316576;5395.541378982673;5672.4894759471845;5738.741756620879;5756.625819321731 23:42:10 INFO - PROCESS | 7231 | |4;prototype.html;346.4664416798131;349.03491845048427;350.5320397269645;351.4043695935389;354.6506690909453;5800.622959507635;5819.584872278005;5823.242978412811;5835.649861008343;5863.325717542484;5647.43525647435;5662;5671.234383358245;5671.291088613923;5695.345035320939;4008.51897772267;4428.689991700582;4443.888902777424;4446.510883802779;4473.172463094322;4453.755043472608;4480.148771733377;4489.214387482194;4489.371487991683;4508.436445444319;4429.047754732732;4454.420925279709;4468.530804265554;4473.843415480459;4482.282834746441;4305.827766889321;4440.289553671397;4462.866114016585;4470.41884555009;4486.192485352652;3885.9611403885883;3947.960520394788;3970.920581588352;3982.0841206522664;3983.183447393277;5408.4050754416985;5466.125419932791;5481.177823326493;5501.312335958005;5523.834284971457;4799.568038876483;5023.648344615878;5041.269015992697;5049.722265275408;5066.341375621182;5890.587658863881;5922.733476993502;5929.407059294036;5931.406859314077;5937.584369094165;4223.767692776896;4246.617804397619;4264.7227930184745;4286.721363111419;4290.227759003378;6021.277446706379;6109.175261339751;6120.387961203888;6131.049687298476;6171.228596425447;4314.713202002943;4329.610335069859;4349.521552629209;4376.40918476008;4390.692651514363;4385.583369579885;4400.69195156336;4425.955740442554;4429;4429.977850110793;4861.737226421952;5025.14572522672;5030.264558727234;5044.9495505045215;5068.594512438996;5931.56805709657;5943.771085842809;6045.3652366501765;6066.423689749467;6079.422454866781;1499.9175045372392;1502.9173395463135;1516.4237589715838;1518.4685360123867;1525.5804653720315;972.7227740094039;1012.291396022787;1041.8645576075062;1042.3172821801732;1051.101308381323;5667.1782591524;5759.827205183851;5784;5836.299644042742;5845.743165219498;6022.909656355158;6052.852516691296;6079.270487541523;6136.447719705248;6142.385761423822;5523.978064058162;5718.7426565804635;5721.971390143022;5781.150031989807;5790.768369265266;3245.3184831185717;3266.4610339294227;3269.9182520436702;3297.994111795925;3307.851146698404;6232.501399887998;6303;6333.556651034475;6354.17395738551;6392.20097487814;6196.597221180609;6213.720382582795;6227.470664993436;6264.154339164154;6270.49836013127;6101.024093405269;6355.3009168991375;6357.523185761086;6358.300586935434;6369.5222858285815;6070.423309785563;6083.300420451705;6129.161251624584;6134.355892631388;6152.507799376129;6041.879162416639;6053.243344581927;6055.2430946131735;6079.696015199311;6096.298925623432;6077.361877002851;6331.2085989251345;6333.176687030841;6342.936570634419;6343.746250150127;4331.2636851735915;4369.43197384338;4372.781360932005;4387.8244870204835;4392.231359512009;5900.763969441175;6016.796640671796;6090.573659843769;6111.908321375094;6152.78465253714;5838.1826544282985;5903.527717782653;5923.49650279731;5943.4948029416255;5949.345571986992;5863.912041319299;5881.911771323348;5882.7058647066615;5937.168796368598;5950.137230101524;5645.475721555239;5717.342505611741;5925.229720136354;5934.643921364732;5955.612885162451;5987.161797348462;6058;6061.181455682891;6098.237720284965;6104.145419641165;5618.831435056954;5868.765249389977;5935.198748168942;5943.970280148572;5961.880762384815 23:42:10 INFO - PROCESS | 7231 | |5;yui.html;802.4783890471197;831.185438270495;844.809917768502;870.695256660169;895.2703546609517;15144.621384465394;16022.359105635775;16183.35266589335;16379.59051023725;16603.91698041511;15458.381664733426;15577.688446231068;15588.688226235468;15646.530604081867;15660;697.069412334534;816.8856360109589;845.0450990380891;853.9444936079166;855.1961156512889;847.190932659312;848.2154007543029;848.4612271207797;854.974350769478;855.9899318803809;864.1747131489444;880.8458519759016;882.4176043811086;882.5410786391105;885.0132102705502;876.4960147914943;881.8897637795276;882.9293656507464;883.4522595990463;883.8055627761883;650.5738741124524;651.9706613202417;652.7128063651978;652.9967350163218;657.947364210862;14950.925245373703;14962.251887405695;15001.174935378549;15134.848651513454;15219.086854788748;13886;14162.71674566503;14329.928350358286;14522.564323070324;16054;14238.359273832702;14322.212278324689;14363.784543231859;14493.92753036228;14864.851351486455;4644.256918892961;4718.315844202606;4728.739919304437;4782.30656554801;4806.399200099988;71154.28845711528;80071.19928800754;80535.59732201361;80563;80842;11051.226414150933;11207.775844483065;11223.607173749044;11385.08919286455;11510.539578416938;21530.892345538174;21688.674669879965;21711;21721.13115475363;21722.34832955014;9110.908890911138;9236.445813251226;9407.717768466957;9477.715668529818;9837.360571562825;4975.129352363322;5065.11360511909;5090.669106508065;5128.410232823273;5251.842444726664;3815.0653089992575;3944.2505923874373;3944.3491823849317;3953.189596132786;3962.821673024721;663.8904580744123;679.6873438218474;685.2701872505766;691.498663468991;701.9649017549102;711.1430725975188;715.6171448275148;759.40007394158;779.5907148746953;784.2862994674932;10445.32105413161;10958.506867190836;11021.779564408667;11127.833082503768;11134.220604557604;614.3181069013392;668.7258224128084;738.985220295591;744.036472767767;762.1273641680245;4905.3623029006;4950.9009819803405;5020.924686129711;5065.240213967934;5068.037072956126;69454.30545694579;69493;69595.3040469599;69728.65135674289;104191;96100.51949740347;96324.51837740766;96436.51781741047;96863.51568242254;97792;88286.55856720675;89532;89814;90061.54969224981;90548.09451905396;10000.499975001076;10040.347377420445;10090.2432317575;10142.442165680959;10302.124319432933;48351.75824120857;51125;52539;53085.20372194498;53233.46766532285;63891;77587;77609;79625.60187199026;80188;12880.548108430072;13875.514356997457;13921.651958700708;14194.290285485891;14351.210683412513;15226;15405.922970385076;15962.760558591399;16422.17889105564;16786.160691965597;13989.370478328703;14240.643983900485;14284.785728214292;14310.49913253031;14593.416263349347;13669.794953075512;13722.65693357674;13855;14110.647233819236;15016.023958442665;14229.359678814271;14451.421943122157;14597.197154156624;15029.624259393166;15159.848401516285;11299.09607231403;11427.314361138358;11724.787935909722;11736.589219377282;11949.283043017447;12318.568850090203;12528.561500347445;12531.624051278477;12762;12784.936075319563 23:42:10 INFO - PROCESS | 7231 | __end_tp_report 23:42:10 INFO - PROCESS | 7231 | __start_cc_report 23:42:10 INFO - PROCESS | 7231 | _x_x_mozilla_cycle_collect,331 23:42:10 INFO - PROCESS | 7231 | __end_cc_report 23:42:10 INFO - PROCESS | 7231 | __startTimestamp1468478530674__endTimestamp 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | ------- Summary: start ------- 23:42:10 INFO - PROCESS | 7231 | Number of tests: 6 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#0] dojo.html Cycles:165 Average:5594.51 Median:5811.83 stddev:611.24 (10.5%) stddev-sans-first:586.49 23:42:10 INFO - PROCESS | 7231 | Values: 3319.7 3319.8 3335.6 3353.2 3363.8 5577.5 5577.6 5581.2 5588.9 5592.2 5581.5 5600.9 5649.2 5649.5 5679.2 5091.4 5147.7 5196.5 5204.4 5207.0 5152.3 5153.7 5215.4 5219.4 5229.3 5115.8 5118.5 5156.3 5166.4 5186.8 5193.0 5204.9 5233.5 5234.4 5264.9 4983.0 5083.0 5141.5 5197.6 5217.7 5427.7 5436.3 5478.2 5512.9 5540.9 5923.7 5963.0 5974.9 5977.8 5983.2 5847.6 5898.1 6020.0 6032.8 6041.0 5562.7 5620.2 5624.7 5640.4 5684.0 6123.8 6130.4 6157.0 6160.4 6177.5 5710.0 5811.8 5835.8 5836.1 5880.0 6035.4 6040.2 6056.3 6057.3 6084.5 5928.1 5978.3 5983.6 6019.2 6045.9 5825.1 5960.2 5984.3 6002.7 6008.6 4641.6 4643.9 4646.0 4646.6 4661.6 4146.2 4149.4 4151.7 4168.9 4184.2 5673.7 5749.7 5757.8 5793.4 5863.1 5973.4 5996.1 6031.9 6032.4 6037.1 5795.8 5830.5 5837.2 5847.4 5854.9 5017.7 5126.5 5175.7 5202.0 5202.8 6263.3 6281.7 6309.7 6336.4 6340.6 6032.5 6055.5 6070.3 6080.2 6082.4 6081.1 6120.6 6168.6 6198.5 6300.9 5939.9 5940.0 5944.9 5958.5 5976.9 5961.1 6009.9 6013.2 6030.1 6039.5 5712.3 5809.9 5831.4 5855.9 5886.2 5821.5 5854.4 5865.8 5869.6 5889.2 5651.2 5778.6 5780.2 5788.3 5791.7 5835.1 5848.0 5864.6 5933.8 5953.3 5750.3 5786.1 5798.7 5807.7 5848.7 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#1] ext.html Cycles:180 Average:61762.88 Median:23242.94 stddev:130976.48 (563.5%) stddev-sans-first:131263.51 23:42:10 INFO - PROCESS | 7231 | Values: 642.4 658.4 663.6 676.8 688.3 38230.6 40038.6 43459.0 43528.3 43601.6 44126.6 44859.8 45135.8 45225.8 45356.0 8694.5 8942.8 9006.8 9010.1 9029.1 8766.4 8773.0 8833.5 8855.0 8900.2 8882.7 8924.1 8938.8 8940.2 8946.3 8885.3 8893.1 8920.7 8922.2 8931.5 8721.5 8810.1 8818.5 8823.2 8856.8 35660.5 41588.6 42274.0 42406.6 42439.2 3535.0 3684.5 3790.5 3819.3 3859.3 31994.2 32735.3 32907.3 33187.0 33510.3 4207.9 4211.9 4229.3 4238.1 4257.4 307840.0 312347.0 313241.0 313729.0 315462.0 37919.6 38175.8 38298.0 38342.8 38535.2 38224.4 40211.8 40370.4 40408.8 40594.4 15294.8 15452.4 15484.5 15505.0 15519.4 12526.2 12565.7 12588.2 12657.4 12721.0 9188.8 9226.7 9226.8 9278.4 9283.8 3540.0 3579.6 3603.5 3633.0 3662.2 1095.9 1107.0 1118.4 1164.7 1203.7 33240.5 33606.5 33611.8 33703.8 33787.2 1159.5 1210.8 1210.9 1230.0 1242.7 17433.0 17498.0 17661.6 17731.2 17828.6 570880.0 575982.0 592202.1 621351.0 915100.0 57322.4 63529.7 63575.7 63657.4 63750.0 1461.1 1487.7 1489.5 1489.6 1494.6 32180.8 32547.3 32606.7 32732.8 33511.5 54039.0 54342.5 54842.0 54965.5 55018.4 416001.0 416759.0 417766.0 418336.0 418552.0 45875.8 47122.8 47281.0 47722.5 47859.3 47740.0 51311.5 51424.0 52352.0 52719.0 43273.8 43371.6 44057.3 44165.1 45937.1 43034.0 44245.3 44812.3 44921.0 45158.5 44994.1 45114.0 45131.5 45295.8 45633.1 37747.0 38611.0 38648.4 39346.2 39676.8 29436.3 29858.6 30155.0 30330.5 30444.8 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#2] jquery.html Cycles:180 Average:26652.97 Median:23794.26 stddev:67211.64 (282.5%) stddev-sans-first:67371.35 23:42:10 INFO - PROCESS | 7231 | Values: 429.2 429.8 430.7 436.3 444.4 19598.8 19631.1 20626.0 20646.0 20767.2 16719.0 16830.6 17582.7 17640.2 17797.7 5493.2 5691.1 5840.6 5845.4 5845.6 5684.6 5711.4 5754.7 5756.3 5769.0 5729.4 5826.9 5842.1 5854.3 5882.8 5620.6 5808.8 5839.2 5850.6 5867.6 5254.5 5258.8 5261.3 5281.3 5297.8 23605.0 23615.0 23749.0 23839.5 24570.3 2531.0 2618.4 2675.6 2742.5 3020.4 10282.3 10529.9 10543.3 10909.6 10924.8 2081.3 2099.4 2153.0 2186.8 2195.7 60417.7 82531.6 82709.0 83246.2 85365.0 9802.5 9958.0 10277.8 10547.0 11928.8 14303.8 14373.6 14461.9 14504.0 14534.6 7999.1 8120.4 8140.9 8250.0 8278.7 8039.8 8092.1 8122.4 8201.2 8225.2 4447.8 4455.6 4487.8 4611.8 4614.6 2089.1 2105.5 2113.5 2136.0 2163.9 980.8 990.7 996.7 1016.1 1092.1 19087.8 20196.8 20218.4 20306.5 20581.4 1025.2 1051.7 1064.9 1095.4 1113.0 10985.2 11240.2 11354.3 11492.3 11531.1 341861.0 342551.0 344566.0 472225.0 484405.0 76756.2 99771.0 101227.5 104637.0 106137.0 1049.6 1110.7 1116.3 1125.2 1130.5 16987.6 17133.5 17477.9 17510.0 17542.7 30880.0 37264.0 44328.8 44567.3 44863.0 60408.7 60851.0 60863.0 61944.7 62486.0 5753.9 6951.1 8000.1 8080.3 8803.8 11608.8 13651.0 13853.2 14076.2 14086.4 11979.3 12093.0 12154.3 12281.9 12457.1 11960.2 12012.6 12258.0 12416.6 12529.4 10991.9 12270.0 12482.9 12528.4 12847.8 8021.6 8542.8 8696.5 8770.1 8857.8 12264.2 12351.9 12423.4 12426.5 12447.4 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#3] mootools.html Cycles:180 Average:6421.61 Median:4715.42 stddev:3709.92 (78.7%) stddev-sans-first:3702.45 23:42:10 INFO - PROCESS | 7231 | Values: 1574.7 1598.5 1842.9 1936.9 1942.8 8758.6 9390.3 9438.1 9998.1 10119.9 9540.2 9785.3 9818.7 9873.5 9891.7 2490.3 2556.5 2556.8 2557.9 2558.9 2500.4 2546.7 2572.7 2573.7 2574.5 2540.5 2549.8 2564.9 2573.5 2576.0 2505.3 2508.8 2510.7 2519.4 2545.7 2400.9 2412.8 2431.8 2435.3 2489.0 9569.0 9682.9 9703.6 9744.9 9774.5 5341.9 5399.2 5416.8 5507.4 5518.8 3608.2 3635.7 3729.7 3811.7 3866.6 1239.2 1256.1 1282.4 1282.6 1305.5 13326.6 13350.3 13402.9 13405.3 13439.0 4912.3 4978.5 5007.1 5050.6 5063.5 11215.7 11227.9 11300.6 11302.6 11307.7 5456.7 5468.1 5503.6 5505.8 5506.5 4476.5 4893.7 4927.0 5038.0 5039.1 4444.6 4454.2 4520.0 4548.2 4670.7 1375.3 1391.7 1408.7 1425.9 1426.2 1068.8 1070.8 1076.3 1094.9 1113.8 6576.2 6596.5 6722.1 6759.4 6859.7 486.7 487.9 491.5 1016.7 1163.5 4647.7 4675.4 4755.4 4804.5 4838.3 11862.2 12396.8 12514.6 12546.3 12587.6 12164.3 12357.1 12424.8 12548.9 12609.2 8836.4 8874.3 8960.8 8968.2 9029.8 6592.5 6676.4 6707.8 6781.4 6856.6 11153.6 11421.9 11505.8 11575.7 11589.2 11530.3 11700.5 11855.3 11899.8 12008.0 7770.3 8436.2 8570.2 8813.2 8965.7 9471.4 9526.1 9578.5 9613.5 9616.7 8304.1 8543.1 8582.7 8680.2 8709.9 8021.9 8078.0 8365.4 8415.5 8424.1 7675.3 8034.4 8080.8 8200.1 8213.0 5733.9 5895.3 5949.5 5991.2 6016.4 5197.8 5395.5 5672.5 5738.7 5756.6 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#4] prototype.html Cycles:180 Average:5022.67 Median:5740.90 stddev:1474.95 (25.7%) stddev-sans-first:1436.72 23:42:10 INFO - PROCESS | 7231 | Values: 346.5 349.0 350.5 351.4 354.7 5800.6 5819.6 5823.2 5835.6 5863.3 5647.4 5662.0 5671.2 5671.3 5695.3 4008.5 4428.7 4443.9 4446.5 4473.2 4453.8 4480.1 4489.2 4489.4 4508.4 4429.0 4454.4 4468.5 4473.8 4482.3 4305.8 4440.3 4462.9 4470.4 4486.2 3886.0 3948.0 3970.9 3982.1 3983.2 5408.4 5466.1 5481.2 5501.3 5523.8 4799.6 5023.6 5041.3 5049.7 5066.3 5890.6 5922.7 5929.4 5931.4 5937.6 4223.8 4246.6 4264.7 4286.7 4290.2 6021.3 6109.2 6120.4 6131.0 6171.2 4314.7 4329.6 4349.5 4376.4 4390.7 4385.6 4400.7 4426.0 4429.0 4430.0 4861.7 5025.1 5030.3 5044.9 5068.6 5931.6 5943.8 6045.4 6066.4 6079.4 1499.9 1502.9 1516.4 1518.5 1525.6 972.7 1012.3 1041.9 1042.3 1051.1 5667.2 5759.8 5784.0 5836.3 5845.7 6022.9 6052.9 6079.3 6136.4 6142.4 5524.0 5718.7 5722.0 5781.2 5790.8 3245.3 3266.5 3269.9 3298.0 3307.9 6232.5 6303.0 6333.6 6354.2 6392.2 6196.6 6213.7 6227.5 6264.2 6270.5 6101.0 6355.3 6357.5 6358.3 6369.5 6070.4 6083.3 6129.2 6134.4 6152.5 6041.9 6053.2 6055.2 6079.7 6096.3 6077.4 6331.2 6333.2 6342.9 6343.7 4331.3 4369.4 4372.8 4387.8 4392.2 5900.8 6016.8 6090.6 6111.9 6152.8 5838.2 5903.5 5923.5 5943.5 5949.3 5863.9 5881.9 5882.7 5937.2 5950.1 5645.5 5717.3 5925.2 5934.6 5955.6 5987.2 6058.0 6061.2 6098.2 6104.1 5618.8 5868.8 5935.2 5944.0 5961.9 23:42:10 INFO - PROCESS | 7231 | 23:42:10 INFO - PROCESS | 7231 | [#5] yui.html Cycles:180 Average:20305.49 Median:26579.08 stddev:27334.99 (102.8%) stddev-sans-first:27372.44 23:42:10 INFO - PROCESS | 7231 | Values: 802.5 831.2 844.8 870.7 895.3 15144.6 16022.4 16183.4 16379.6 16603.9 15458.4 15577.7 15588.7 15646.5 15660.0 697.1 816.9 845.0 853.9 855.2 847.2 848.2 848.5 855.0 856.0 864.2 880.8 882.4 882.5 885.0 876.5 881.9 882.9 883.5 883.8 650.6 652.0 652.7 653.0 657.9 14950.9 14962.3 15001.2 15134.8 15219.1 13886.0 14162.7 14329.9 14522.6 16054.0 14238.4 14322.2 14363.8 14493.9 14864.9 4644.3 4718.3 4728.7 4782.3 4806.4 71154.3 80071.2 80535.6 80563.0 80842.0 11051.2 11207.8 11223.6 11385.1 11510.5 21530.9 21688.7 21711.0 21721.1 21722.3 9110.9 9236.4 9407.7 9477.7 9837.4 4975.1 5065.1 5090.7 5128.4 5251.8 3815.1 3944.3 3944.3 3953.2 3962.8 663.9 679.7 685.3 691.5 702.0 711.1 715.6 759.4 779.6 784.3 10445.3 10958.5 11021.8 11127.8 11134.2 614.3 668.7 739.0 744.0 762.1 4905.4 4950.9 5020.9 5065.2 5068.0 69454.3 69493.0 69595.3 69728.7 104191.0 96100.5 96324.5 96436.5 96863.5 97792.0 88286.6 89532.0 89814.0 90061.5 90548.1 10000.5 10040.3 10090.2 10142.4 10302.1 48351.8 51125.0 52539.0 53085.2 53233.5 63891.0 77587.0 77609.0 79625.6 80188.0 12880.5 13875.5 13921.7 14194.3 14351.2 15226.0 15405.9 15962.8 16422.2 16786.2 13989.4 14240.6 14284.8 14310.5 14593.4 13669.8 13722.7 13855.0 14110.6 15016.0 14229.4 14451.4 14597.2 15029.6 15159.8 11299.1 11427.3 11724.8 11736.6 11949.3 12318.6 12528.6 12531.6 12762.0 12784.9 23:42:10 INFO - PROCESS | 7231 | -------- Summary: end -------- 23:42:10 INFO - PROCESS | 7231 | 23:42:11 INFO - TEST-INFO | 7231: exit 0 23:42:11 INFO - TEST-OK | dromaeo_css | took 1110061ms 23:42:11 INFO - TEST-START | kraken 23:42:11 INFO - operating with platform_type : linux_ 23:42:11 INFO - Initialising browser for kraken test... 23:42:11 INFO - TEST-INFO | started process 7473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVpdce/profile http://localhost:59459/getInfo.html) 23:42:15 INFO - PROCESS | 7473 | __metrics Screen width/height:1600/1200 23:42:15 INFO - PROCESS | 7473 | colorDepth:24 23:42:15 INFO - PROCESS | 7473 | Browser inner width/height: 1024/697 23:42:15 INFO - PROCESS | 7473 | __metrics 23:42:16 ERROR - PROCESS | 7473 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:42:17 INFO - TEST-INFO | 7473: exit 0 23:42:17 INFO - Browser initialized. 23:42:17 INFO - Running cycle 1/1 for kraken test... 23:42:17 INFO - TEST-INFO | started process 7601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKVpdce/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:29 INFO - PROCESS | 7601 | RSS: Main: 156254208 23:42:29 INFO - PROCESS | 7601 | 23:42:31 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59459/tests/kraken/driver.html?testName=audio-beat-detection) 23:42:32 INFO - PROCESS | 7601 | RSS: Main: 161587200 23:42:32 INFO - PROCESS | 7601 | 23:42:35 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59459/tests/kraken/driver.html?testName=audio-dft) 23:42:35 INFO - PROCESS | 7601 | RSS: Main: 160583680 23:42:35 INFO - PROCESS | 7601 | 23:42:38 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59459/tests/kraken/driver.html?testName=audio-fft) 23:42:39 INFO - PROCESS | 7601 | RSS: Main: 161529856 23:42:39 INFO - PROCESS | 7601 | 23:42:41 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59459/tests/kraken/driver.html?testName=audio-oscillator) 23:42:42 INFO - PROCESS | 7601 | RSS: Main: 161071104 23:42:42 INFO - PROCESS | 7601 | 23:42:44 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:42:44 INFO - PROCESS | 7601 | RSS: Main: 160899072 23:42:44 INFO - PROCESS | 7601 | 23:42:47 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59459/tests/kraken/driver.html?testName=imaging-darkroom) 23:42:48 INFO - PROCESS | 7601 | RSS: Main: 160550912 23:42:48 INFO - PROCESS | 7601 | 23:42:51 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59459/tests/kraken/driver.html?testName=imaging-desaturate) 23:42:52 INFO - PROCESS | 7601 | RSS: Main: 161112064 23:42:52 INFO - PROCESS | 7601 | 23:42:55 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59459/tests/kraken/driver.html?testName=json-parse-financial) 23:42:55 INFO - PROCESS | 7601 | RSS: Main: 160796672 23:42:55 INFO - PROCESS | 7601 | 23:42:57 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:42:58 INFO - PROCESS | 7601 | RSS: Main: 160878592 23:42:58 INFO - PROCESS | 7601 | 23:42:59 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:43:00 INFO - PROCESS | 7601 | RSS: Main: 160935936 23:43:00 INFO - PROCESS | 7601 | 23:43:02 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:43:03 INFO - PROCESS | 7601 | RSS: Main: 161906688 23:43:03 INFO - PROCESS | 7601 | 23:43:05 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:43:06 INFO - PROCESS | 7601 | RSS: Main: 162025472 23:43:06 INFO - PROCESS | 7601 | 23:43:09 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:43:09 INFO - PROCESS | 7601 | RSS: Main: 161861632 23:43:09 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | Cycle 1(1): loaded http://localhost:59459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59459/tests/kraken/driver.html?testName=ai-astar) 23:43:11 INFO - PROCESS | 7601 | RSS: Main: 162328576 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | __start_tp_report 23:43:11 INFO - PROCESS | 7601 | _x_x_mozilla_page_load 23:43:11 INFO - PROCESS | 7601 | _x_x_mozilla_page_load_details 23:43:11 INFO - PROCESS | 7601 | |i|pagename|runs| 23:43:11 INFO - PROCESS | 7601 | |0;ai-astar;111;103;110;110;112;112;109;110;111;111 23:43:11 INFO - PROCESS | 7601 | |1;audio-beat-detection;153;134;157;181;126;152;152;130;186;128 23:43:11 INFO - PROCESS | 7601 | |2;audio-dft;162;163;164;163;163;161;163;163;161;163 23:43:11 INFO - PROCESS | 7601 | |3;audio-fft;76;78;76;174;75;75;74;75;169;75 23:43:11 INFO - PROCESS | 7601 | |4;audio-oscillator;84;84;154;84;85;84;138;85;85;142 23:43:11 INFO - PROCESS | 7601 | |5;imaging-gaussian-blur;117;117;117;118;119;117;117;116;117;117 23:43:11 INFO - PROCESS | 7601 | |6;imaging-darkroom;147;149;147;147;147;148;148;146;147;147 23:43:11 INFO - PROCESS | 7601 | |7;imaging-desaturate;95;95;98;96;95;95;95;95;95;96 23:43:11 INFO - PROCESS | 7601 | |8;json-parse-financial;52;52;53;53;54;54;53;56;52;53 23:43:11 INFO - PROCESS | 7601 | |9;json-stringify-tinderbox;59;60;59;60;60;60;60;59;61;60 23:43:11 INFO - PROCESS | 7601 | |10;stanford-crypto-aes;75;78;76;76;78;77;78;80;118;83 23:43:11 INFO - PROCESS | 7601 | |11;stanford-crypto-ccm;121;119;120;122;132;122;144;130;136;123 23:43:11 INFO - PROCESS | 7601 | |12;stanford-crypto-pbkdf2;154;154;157;155;160;153;153;156;155;158 23:43:11 INFO - PROCESS | 7601 | |13;stanford-crypto-sha256-iterative;64;63;62;63;61;60;60;62;61;65 23:43:11 INFO - PROCESS | 7601 | __end_tp_report 23:43:11 INFO - PROCESS | 7601 | __start_cc_report 23:43:11 INFO - PROCESS | 7601 | _x_x_mozilla_cycle_collect,886 23:43:11 INFO - PROCESS | 7601 | __end_cc_report 23:43:11 INFO - PROCESS | 7601 | __startTimestamp1468478591604__endTimestamp 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | ------- Summary: start ------- 23:43:11 INFO - PROCESS | 7601 | Number of tests: 14 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:2.73 23:43:11 INFO - PROCESS | 7601 | Values: 111.0 103.0 110.0 110.0 112.0 112.0 109.0 110.0 111.0 111.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:152.50 stddev:21.18 (13.9%) stddev-sans-first:22.44 23:43:11 INFO - PROCESS | 7601 | Values: 153.0 134.0 157.0 181.0 126.0 152.0 152.0 130.0 186.0 128.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 23:43:11 INFO - PROCESS | 7601 | Values: 162.0 163.0 164.0 163.0 163.0 161.0 163.0 163.0 161.0 163.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:40.51 (54.0%) stddev-sans-first:42.40 23:43:11 INFO - PROCESS | 7601 | Values: 76.0 78.0 76.0 174.0 75.0 75.0 74.0 75.0 169.0 75.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.36 (35.0%) stddev-sans-first:30.37 23:43:11 INFO - PROCESS | 7601 | Values: 84.0 84.0 154.0 84.0 85.0 84.0 138.0 85.0 85.0 142.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 23:43:11 INFO - PROCESS | 7601 | Values: 117.0 117.0 117.0 118.0 119.0 117.0 117.0 116.0 117.0 117.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 23:43:11 INFO - PROCESS | 7601 | Values: 147.0 149.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 147.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 23:43:11 INFO - PROCESS | 7601 | Values: 95.0 95.0 98.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.22 23:43:11 INFO - PROCESS | 7601 | Values: 52.0 52.0 53.0 53.0 54.0 54.0 53.0 56.0 52.0 53.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 23:43:11 INFO - PROCESS | 7601 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 60.0 59.0 61.0 60.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.00 stddev:12.89 (16.5%) stddev-sans-first:13.43 23:43:11 INFO - PROCESS | 7601 | Values: 75.0 78.0 76.0 76.0 78.0 77.0 78.0 80.0 118.0 83.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:126.50 stddev:8.29 (6.6%) stddev-sans-first:8.52 23:43:11 INFO - PROCESS | 7601 | Values: 121.0 119.0 120.0 122.0 132.0 122.0 144.0 130.0 136.0 123.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.50 stddev:2.27 (1.5%) stddev-sans-first:2.35 23:43:11 INFO - PROCESS | 7601 | Values: 154.0 154.0 157.0 155.0 160.0 153.0 153.0 156.0 155.0 158.0 23:43:11 INFO - PROCESS | 7601 | 23:43:11 INFO - PROCESS | 7601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.66 (2.7%) stddev-sans-first:1.62 23:43:11 INFO - PROCESS | 7601 | Values: 64.0 63.0 62.0 63.0 61.0 60.0 60.0 62.0 61.0 65.0 23:43:11 INFO - PROCESS | 7601 | -------- Summary: end -------- 23:43:11 INFO - PROCESS | 7601 | 23:43:12 INFO - TEST-INFO | 7601: exit 0 23:43:12 INFO - TEST-OK | kraken | took 61203ms 23:43:12 INFO - SUITE-END | took 1171s 23:43:12 INFO - Completed test suite (00:19:31) 23:43:12 INFO - javascript benchmark 23:43:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7563.546523681798, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.7012268895796, 3319.8008119512833, 3335.5830521184853, 3353.2119951811337, 3363.7645364824457, 5577.52591029763, 5577.581681373903, 5581.190727344532, 5588.916166257504, 5592.189132575784, 5581.469760372768, 5600.887982240352, 5649.152627105926, 5649.46330098641, 5679.176519404684, 5091.43994160643, 5147.665401748893, 5196.480351964811, 5204.42751297357, 5207.0, 5152.278680984647, 5153.665011774241, 5215.426303106655, 5219.373675158986, 5229.3201883755055, 5115.795368185287, 5118.513741194581, 5156.303898973628, 5166.354205724285, 5186.844394668166, 5192.974035129819, 5204.869878253036, 5233.450487698813, 5234.42421333653, 5264.92102618461, 4982.975085124587, 5082.974585127087, 5141.485851414866, 5197.610179236573, 5217.73911304437, 5427.701476418795, 5436.320459942507, 5478.150886612581, 5512.944870551283, 5540.944590554083, 5923.703814809242, 5963.045912653998, 5974.910376344358, 5977.790777322773, 5983.222181116427, 5847.649141051551, 5898.056310990221, 6019.969900150515, 6032.849178770522, 6041.0, 5562.694051827148, 5620.213170156181, 5624.746886390122, 5640.351359593658, 5684.033714268584, 6123.785667501616, 6130.386961303923, 6157.0, 6160.44555989963, 6177.536684748572, 5710.0, 5811.82564523065, 5835.824925252165, 5836.124581312837, 5880.0, 6035.39646035393, 6040.214772079689, 6056.273247210363, 6057.303410107894, 6084.5132389408745, 5928.081147422156, 5978.3124940631515, 5983.640981541122, 6019.247594050744, 6045.909311360333, 5825.0679891217205, 5960.195373624505, 5984.3417224105315, 6002.729877155539, 6008.609440386361, 4641.559051890065, 4643.86068417948, 4645.976770116128, 4646.558576935186, 4661.627069834473, 4146.150039241948, 4149.37759336102, 4151.667866570728, 4168.874933751992, 4184.163167366539, 5673.687947162863, 5749.741261643236, 5757.798477053283, 5793.362730099686, 5863.120531920161, 5973.402659734079, 5996.070609055603, 6031.9396806032255, 6032.3967603239325, 6037.0642550404755, 5795.768169273182, 5830.475257226785, 5837.182794408786, 5847.356790753014, 5854.912176317359, 5017.7491125443585, 5126.461721519261, 5175.689458632494, 5202.03762303975, 5202.791888324425, 6263.31103578606, 6281.654509001957, 6309.747610095636, 6336.366363363719, 6340.619562826245, 6032.487238584682, 6055.455009049207, 6070.3019152798, 6080.209572755513, 6082.422169893853, 6081.118237855575, 6120.569035656853, 6168.629882207082, 6198.473129784019, 6300.873982520232, 5939.851503712442, 5940.049592065422, 5944.881102377842, 5958.463738263577, 5976.9103463448955, 5961.135635332939, 6009.87980240384, 6013.218281623361, 6030.095485677183, 6039.486643635164, 5712.34308054579, 5809.9419005809405, 5831.446012628963, 5855.882882342415, 5886.175935368966, 5821.476067153807, 5854.385289544536, 5865.824025279248, 5869.589128760946, 5889.175515427758, 5651.180578816131, 5778.624389414675, 5780.161876527964, 5788.334341550775, 5791.739371728198, 5835.066389377679, 5848.0, 5864.618799778001, 5933.792317268875, 5953.255843019622, 5750.281214848144, 5786.132080188006, 5798.710064496674, 5807.738651760596, 5848.678322692293], "value": 5555.034793149906, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.370476932606, 658.3811217455591, 663.5885750834482, 676.7834293026227, 688.2773088257328, 38230.61769382306, 40038.598649047286, 43459.0, 43528.347074793906, 43601.563984360146, 44126.55873441265, 44859.77570112153, 45135.774321128345, 45225.77387113068, 45356.0, 8694.47833130011, 8942.776430589221, 9006.819863602725, 9010.098990101003, 9029.142231488031, 8766.430182038148, 8773.0, 8833.46999180048, 8854.955725221365, 8900.154485323885, 8882.689105881296, 8924.107589241057, 8938.821223575556, 8940.19538241558, 8946.284297256236, 8885.289176865836, 8893.066228046058, 8920.687775927876, 8922.241609463172, 8931.464112153259, 8721.476711397336, 8810.118988101203, 8818.470891746452, 8823.205911467998, 8856.822863542757, 35660.465093023624, 41588.58411415877, 42274.0, 42406.57593424057, 42439.1512169758, 3534.9823250883837, 3684.521012268415, 3790.469334293201, 3819.312523745725, 3859.3053250414914, 31994.200144996328, 32735.345293094004, 32907.341853162805, 33187.0, 33510.329793403995, 4207.873763787091, 4211.873643790691, 4229.2598795210715, 4238.131183107455, 4257.40396344512, 307840.0, 312347.0, 313241.0, 313729.0, 315462.0, 37919.62080379216, 38175.80912095422, 38298.0, 38342.80828595839, 38535.229295413934, 38224.42663360052, 40211.79894100511, 40370.394444083366, 40408.79795601003, 40594.391084133764, 15294.770578441332, 15452.381904723685, 15484.5354639361, 15505.0, 15519.37922483088, 12526.185797923106, 12565.748685026248, 12588.181768185039, 12657.43041563132, 12721.04592155592, 9188.770280742901, 9226.677066302782, 9226.769330766785, 9278.443293402417, 9283.814323713488, 3539.964600354015, 3579.588347340037, 3603.549556305462, 3633.0372451300427, 3662.1760103976394, 1095.90684791792, 1106.9557217711201, 1118.429600903545, 1164.7495788405533, 1203.7050922524038, 33240.501392479135, 33606.49590256148, 33611.83194084063, 33703.83148084244, 33787.15532111717, 1159.4898244772442, 1210.8002179640262, 1210.9455074521668, 1230.0, 1242.7079636285466, 17433.0, 17498.0, 17661.558461038578, 17731.202095905715, 17828.643427131385, 570880.0, 575982.0, 592202.0779792147, 621351.0, 915100.0, 57322.42677573254, 63529.682351587944, 63575.682121589096, 63657.36342636607, 63750.0, 1461.0722191408531, 1487.7098965701584, 1489.4637930345068, 1489.649932265895, 1494.6039299585618, 32180.83909580437, 32547.349053018334, 32606.722068697338, 32732.836335818167, 33511.49732753962, 54039.0, 54342.456575435324, 54842.0, 54965.450345496036, 55018.449815502936, 416001.0, 416759.0, 417766.0, 418336.0, 418552.0, 45875.77062114668, 47122.76438617785, 47281.0, 47722.52277477181, 47859.28211076767, 47740.0, 51311.486885132166, 51424.0, 52352.0, 52719.0, 43273.78363108164, 43371.56628433801, 44057.339139912285, 44165.11669766651, 45937.081258375314, 43034.0, 44245.336319954586, 44812.32781508345, 44921.0, 45158.54841451543, 44994.1001179968, 45114.0, 45131.54868451405, 45295.773521132185, 45633.087338252386, 37747.0, 38611.0, 38648.42027369535, 39346.213075738895, 39676.80161599174, 29436.264093397836, 29858.552121718625, 30155.0, 30330.545041824833, 30444.84777576098], "value": 19729.197423945716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.23167530121066, 429.76792532032704, 430.7286409561976, 436.33458975063047, 444.40671703276126, 19598.804011959877, 19631.116599753008, 20626.0, 20646.0, 20767.169313227452, 16719.0, 16830.57923551912, 17582.736258956127, 17640.206190721416, 17797.7330340045, 5493.23094766732, 5691.146328050784, 5840.649561026331, 5845.415458454163, 5845.620034697752, 5684.630499017571, 5711.371749107595, 5754.712264386785, 5756.251687280647, 5769.04810706233, 5729.427057294258, 5826.854328641775, 5842.0652695568715, 5854.297484301868, 5882.794102206423, 5620.634658747168, 5808.796692115798, 5839.182514447981, 5850.561207909403, 5867.618604790697, 5254.527092561688, 5258.789648414059, 5261.289725886994, 5281.287026251445, 5297.788088476456, 23605.00439683425, 23615.0, 23749.0, 23839.523209535713, 24570.262892113264, 2531.0, 2618.4108575570344, 2675.598660200966, 2742.4515096980485, 3020.4412183746076, 10282.280240383176, 10529.894701052968, 10543.261971661987, 10909.618163364245, 10924.836127458095, 2081.2715549557533, 2099.3806826985924, 2152.9569408611897, 2186.7703891091364, 2195.692603035576, 60417.6979115106, 82531.5873420635, 82709.0, 83246.16753832505, 85365.0, 9802.46086465237, 9957.950210248902, 10277.794444111076, 10547.0, 11928.761424771455, 14303.78544321836, 14373.64065898361, 14461.855381446261, 14504.0, 14534.563963081124, 7999.120096789348, 8120.3503719702285, 8140.877886831702, 8249.968753905761, 8278.668853245803, 8039.839203215903, 8092.109867914524, 8122.431429799857, 8201.179882011871, 8225.218604232588, 4447.755373454426, 4455.598996090367, 4487.753173575485, 4611.838585649486, 4614.561616646413, 2089.0884840371195, 2105.5473073289318, 2113.524456997194, 2135.978640213609, 2163.945901352479, 980.8234517786724, 990.7027891632481, 996.7109538233976, 1016.1362841584742, 1092.0771947704177, 19087.809121908882, 20196.79803201949, 20218.393448196577, 20306.492337691678, 20581.38255852327, 1025.1747343388495, 1051.7002654243504, 1064.8722153341648, 1095.3592148593161, 1112.9816218160292, 10985.231033827555, 11240.213185076966, 11354.26197297173, 11492.253003554742, 11531.077513798877, 341861.0, 342551.0, 344566.0, 472225.0, 484405.0, 76756.2324376749, 99771.0, 101227.49386253022, 104637.0, 106137.0, 1049.5959055763585, 1110.655696734015, 1116.3023110556064, 1125.178619607691, 1130.463030060731, 16987.63470228922, 17133.485995420157, 17477.912610436866, 17510.0, 17542.73685894738, 30880.0, 37264.0, 44328.7783561093, 44567.33149002703, 44863.0, 60408.69795651169, 60851.0, 60863.0, 61944.69027654833, 62486.0, 5753.8561535961935, 6951.096357473496, 8000.119986801564, 8080.2727754502375, 8803.779905502413, 11608.825867612162, 13651.0, 13853.238071905738, 14076.225807580682, 14086.436542538184, 11979.341136237243, 12093.0, 12154.331511766937, 12281.877181228074, 12457.065720071212, 11960.162788604714, 12012.579559715718, 12258.0, 12416.565420210249, 12529.436175371948, 10991.945040274748, 12270.0, 12482.875171248534, 12528.436220369922, 12847.807282890577, 8021.558814265038, 8542.829143416973, 8696.478211307342, 8770.079141690287, 8857.778555535906, 12264.202826816228, 12351.93824030874, 12423.44094515767, 12426.502939882303, 12447.377631118588], "value": 9353.320421549357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1574.6535762132335, 1598.512453701621, 1842.9447116586507, 1936.9128389222483, 1942.786293507713, 8758.562071896411, 9390.295727820416, 9438.103380178889, 9998.10017098461, 10119.949400253006, 9540.236781057516, 9785.266105042132, 9818.656347027856, 9873.456959867204, 9891.703248902526, 2490.3276115448816, 2556.5398228318895, 2556.75710807473, 2557.884895179712, 2558.9488210235786, 2500.437401584647, 2546.732593077728, 2572.6526918865993, 2573.691157061155, 2574.5108429398356, 2540.491901619674, 2549.7960163186995, 2564.871756412181, 2573.5367633825904, 2576.0, 2505.2734706934966, 2508.8118391120647, 2510.6736124303907, 2519.433127546306, 2545.6945166579944, 2400.9039638414442, 2412.8311018228733, 2431.756824317572, 2435.342457536473, 2488.9875550622314, 9568.952155239249, 9682.854757178648, 9703.563339649732, 9744.90255097447, 9774.51127443625, 5341.893162136775, 5399.217113518518, 5416.8104116355735, 5507.421720719307, 5518.834434966958, 3608.170120872188, 3635.745497815154, 3729.664330210294, 3811.6760075393627, 3866.5553461352024, 1239.2254840724547, 1256.108163204117, 1282.3588205897051, 1282.5767496726057, 1305.549585393038, 13326.600201993859, 13350.26573538455, 13402.865971340358, 13405.329733513383, 13439.0, 4912.263160525949, 4978.5270399312, 5007.148784706608, 5050.621203409759, 5063.544281014726, 11215.66353009411, 11227.943860280646, 11300.604478843201, 11302.604408845651, 11307.660770176908, 5456.672599644034, 5468.097763868917, 5503.642263252876, 5505.779768809283, 5506.531944784738, 4476.462824461086, 4893.7063776173545, 4926.989967056745, 5038.0, 5039.143345631252, 4444.644428445717, 4454.22051141049, 4520.028193938319, 4548.204064288736, 4670.673052886334, 1375.312343828086, 1391.7355702416507, 1408.6971301170297, 1425.8788003019858, 1426.2440906319666, 1068.823644098715, 1070.839374093892, 1076.2627600093804, 1094.9452527373599, 1113.8273567597034, 6576.210854697371, 6596.538242323088, 6722.1261236039, 6759.425448836806, 6859.657017149123, 486.7420267258359, 487.8536439068265, 491.4765774450199, 1016.6746641074785, 1163.4822503985815, 4647.697899636512, 4675.4155730533685, 4755.429348478205, 4804.495527969582, 4838.250071238964, 11862.169648124722, 12396.75206495865, 12514.561990330294, 12546.309952952675, 12587.559435419716, 12164.330961797186, 12357.135000549875, 12424.813627795591, 12548.937255313665, 12609.180403273758, 8836.381453298207, 8874.334424918157, 8960.775980600538, 8968.192862642394, 9029.819403611891, 6592.472602191718, 6676.365745254193, 6707.8323041922395, 6781.355771201728, 6856.588604683735, 11153.553857845594, 11421.885781142082, 11505.769884602429, 11575.652730418102, 11589.188756786943, 11530.250533715282, 11700.47347869365, 11855.288682679067, 11899.750526194624, 12008.0, 7770.261825126604, 8436.198561136682, 8570.228679418882, 8813.206811387006, 8965.686200982935, 9471.384360016576, 9526.142647161789, 9578.521073946415, 9613.471259080818, 9616.711498655051, 8304.128066553167, 8543.0602633709, 8582.699605513777, 8680.175383338572, 8709.869351959853, 8021.879671805044, 8077.959610201911, 8365.372597055368, 8415.45299555527, 8424.11546787603, 7675.270849269311, 8034.35725141999, 8080.797980050311, 8200.05699344583, 8212.958935205286, 5733.885322293614, 5895.29256489224, 5949.494292985145, 5991.221141251784, 6016.368281330398, 5197.792088316576, 5395.541378982673, 5672.4894759471845, 5738.741756620879, 5756.625819321731], "value": 5081.672508365105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.4664416798131, 349.03491845048427, 350.5320397269645, 351.4043695935389, 354.6506690909453, 5800.622959507635, 5819.584872278005, 5823.242978412811, 5835.649861008343, 5863.325717542484, 5647.43525647435, 5662.0, 5671.234383358245, 5671.291088613923, 5695.345035320939, 4008.51897772267, 4428.689991700582, 4443.888902777424, 4446.510883802779, 4473.172463094322, 4453.755043472608, 4480.148771733377, 4489.214387482194, 4489.371487991683, 4508.436445444319, 4429.047754732732, 4454.420925279709, 4468.530804265554, 4473.843415480459, 4482.282834746441, 4305.827766889321, 4440.289553671397, 4462.866114016585, 4470.41884555009, 4486.192485352652, 3885.9611403885883, 3947.960520394788, 3970.920581588352, 3982.0841206522664, 3983.183447393277, 5408.4050754416985, 5466.125419932791, 5481.177823326493, 5501.312335958005, 5523.834284971457, 4799.568038876483, 5023.648344615878, 5041.269015992697, 5049.722265275408, 5066.341375621182, 5890.587658863881, 5922.733476993502, 5929.407059294036, 5931.406859314077, 5937.584369094165, 4223.767692776896, 4246.617804397619, 4264.7227930184745, 4286.721363111419, 4290.227759003378, 6021.277446706379, 6109.175261339751, 6120.387961203888, 6131.049687298476, 6171.228596425447, 4314.713202002943, 4329.610335069859, 4349.521552629209, 4376.40918476008, 4390.692651514363, 4385.583369579885, 4400.69195156336, 4425.955740442554, 4429.0, 4429.977850110793, 4861.737226421952, 5025.14572522672, 5030.264558727234, 5044.9495505045215, 5068.594512438996, 5931.56805709657, 5943.771085842809, 6045.3652366501765, 6066.423689749467, 6079.422454866781, 1499.9175045372392, 1502.9173395463135, 1516.4237589715838, 1518.4685360123867, 1525.5804653720315, 972.7227740094039, 1012.291396022787, 1041.8645576075062, 1042.3172821801732, 1051.101308381323, 5667.1782591524, 5759.827205183851, 5784.0, 5836.299644042742, 5845.743165219498, 6022.909656355158, 6052.852516691296, 6079.270487541523, 6136.447719705248, 6142.385761423822, 5523.978064058162, 5718.7426565804635, 5721.971390143022, 5781.150031989807, 5790.768369265266, 3245.3184831185717, 3266.4610339294227, 3269.9182520436702, 3297.994111795925, 3307.851146698404, 6232.501399887998, 6303.0, 6333.556651034475, 6354.17395738551, 6392.20097487814, 6196.597221180609, 6213.720382582795, 6227.470664993436, 6264.154339164154, 6270.49836013127, 6101.024093405269, 6355.3009168991375, 6357.523185761086, 6358.300586935434, 6369.5222858285815, 6070.423309785563, 6083.300420451705, 6129.161251624584, 6134.355892631388, 6152.507799376129, 6041.879162416639, 6053.243344581927, 6055.2430946131735, 6079.696015199311, 6096.298925623432, 6077.361877002851, 6331.2085989251345, 6333.176687030841, 6342.936570634419, 6343.746250150127, 4331.2636851735915, 4369.43197384338, 4372.781360932005, 4387.8244870204835, 4392.231359512009, 5900.763969441175, 6016.796640671796, 6090.573659843769, 6111.908321375094, 6152.78465253714, 5838.1826544282985, 5903.527717782653, 5923.49650279731, 5943.4948029416255, 5949.345571986992, 5863.912041319299, 5881.911771323348, 5882.7058647066615, 5937.168796368598, 5950.137230101524, 5645.475721555239, 5717.342505611741, 5925.229720136354, 5934.643921364732, 5955.612885162451, 5987.161797348462, 6058.0, 6061.181455682891, 6098.237720284965, 6104.145419641165, 5618.831435056954, 5868.765249389977, 5935.198748168942, 5943.970280148572, 5961.880762384815], "value": 4550.678162173041, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.4783890471197, 831.185438270495, 844.809917768502, 870.695256660169, 895.2703546609517, 15144.621384465394, 16022.359105635775, 16183.35266589335, 16379.59051023725, 16603.91698041511, 15458.381664733426, 15577.688446231068, 15588.688226235468, 15646.530604081867, 15660.0, 697.069412334534, 816.8856360109589, 845.0450990380891, 853.9444936079166, 855.1961156512889, 847.190932659312, 848.2154007543029, 848.4612271207797, 854.974350769478, 855.9899318803809, 864.1747131489444, 880.8458519759016, 882.4176043811086, 882.5410786391105, 885.0132102705502, 876.4960147914943, 881.8897637795276, 882.9293656507464, 883.4522595990463, 883.8055627761883, 650.5738741124524, 651.9706613202417, 652.7128063651978, 652.9967350163218, 657.947364210862, 14950.925245373703, 14962.251887405695, 15001.174935378549, 15134.848651513454, 15219.086854788748, 13886.0, 14162.71674566503, 14329.928350358286, 14522.564323070324, 16054.0, 14238.359273832702, 14322.212278324689, 14363.784543231859, 14493.92753036228, 14864.851351486455, 4644.256918892961, 4718.315844202606, 4728.739919304437, 4782.30656554801, 4806.399200099988, 71154.28845711528, 80071.19928800754, 80535.59732201361, 80563.0, 80842.0, 11051.226414150933, 11207.775844483065, 11223.607173749044, 11385.08919286455, 11510.539578416938, 21530.892345538174, 21688.674669879965, 21711.0, 21721.13115475363, 21722.34832955014, 9110.908890911138, 9236.445813251226, 9407.717768466957, 9477.715668529818, 9837.360571562825, 4975.129352363322, 5065.11360511909, 5090.669106508065, 5128.410232823273, 5251.842444726664, 3815.0653089992575, 3944.2505923874373, 3944.3491823849317, 3953.189596132786, 3962.821673024721, 663.8904580744123, 679.6873438218474, 685.2701872505766, 691.498663468991, 701.9649017549102, 711.1430725975188, 715.6171448275148, 759.40007394158, 779.5907148746953, 784.2862994674932, 10445.32105413161, 10958.506867190836, 11021.779564408667, 11127.833082503768, 11134.220604557604, 614.3181069013392, 668.7258224128084, 738.985220295591, 744.036472767767, 762.1273641680245, 4905.3623029006, 4950.9009819803405, 5020.924686129711, 5065.240213967934, 5068.037072956126, 69454.30545694579, 69493.0, 69595.3040469599, 69728.65135674289, 104191.0, 96100.51949740347, 96324.51837740766, 96436.51781741047, 96863.51568242254, 97792.0, 88286.55856720675, 89532.0, 89814.0, 90061.54969224981, 90548.09451905396, 10000.499975001076, 10040.347377420445, 10090.2432317575, 10142.442165680959, 10302.124319432933, 48351.75824120857, 51125.0, 52539.0, 53085.20372194498, 53233.46766532285, 63891.0, 77587.0, 77609.0, 79625.60187199026, 80188.0, 12880.548108430072, 13875.514356997457, 13921.651958700708, 14194.290285485891, 14351.210683412513, 15226.0, 15405.922970385076, 15962.760558591399, 16422.17889105564, 16786.160691965597, 13989.370478328703, 14240.643983900485, 14284.785728214292, 14310.49913253031, 14593.416263349347, 13669.794953075512, 13722.65693357674, 13855.0, 14110.647233819236, 15016.023958442665, 14229.359678814271, 14451.421943122157, 14597.197154156624, 15029.624259393166, 15159.848401516285, 11299.09607231403, 11427.314361138358, 11724.787935909722, 11736.589219377282, 11949.283043017447, 12318.568850090203, 12528.561500347445, 12531.624051278477, 12762.0, 12784.936075319563], "value": 7897.144687029215, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 110.0, 110.0, 112.0, 112.0, 109.0, 110.0, 111.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 134.0, 157.0, 181.0, 126.0, 152.0, 152.0, 130.0, 186.0, 128.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 163.0, 161.0, 163.0, 163.0, 161.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 174.0, 75.0, 75.0, 74.0, 75.0, 169.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 154.0, 84.0, 85.0, 84.0, 138.0, 85.0, 85.0, 142.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 98.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 54.0, 54.0, 53.0, 56.0, 52.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 76.0, 78.0, 77.0, 78.0, 80.0, 118.0, 83.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 120.0, 122.0, 132.0, 122.0, 144.0, 130.0, 136.0, 123.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 157.0, 155.0, 160.0, 153.0, 153.0, 156.0, 155.0, 158.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 61.0, 60.0, 60.0, 62.0, 61.0, 65.0], "value": 62.1, "unit": "score"}]}]} 23:43:12 INFO - Return code: 0 23:43:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:43:12 ERROR - # TBPL SUCCESS # 23:43:12 INFO - Running post-action listener: _resource_record_post_action 23:43:12 INFO - ##### 23:43:12 INFO - ##### Finished run-tests step (success) 23:43:12 INFO - ##### 23:43:12 INFO - Running post-run listener: _resource_record_post_run 23:43:12 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505241600; Read time: 20; Write time: 398204 23:43:12 INFO - TinderboxPrint: CPU usage
13.4% 23:43:12 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 23:43:12 INFO - TinderboxPrint: I/O write bytes / time
505,241,600 / 398,204 23:43:12 INFO - TinderboxPrint: CPU idle
8,211.9 (86.6%) 23:43:12 INFO - TinderboxPrint: CPU user
1,212.0 (12.8%) 23:43:12 INFO - TinderboxPrint: Swap in / out
0 / 0 23:43:12 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252727296; Read time: 0; Write time: 261388 23:43:13 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245833728; Read time: 20; Write time: 135936 23:43:13 INFO - Running post-run listener: _upload_blobber_files 23:43:13 INFO - Blob upload gear active. 23:43:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:43:13 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 23:43:13 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'] 23:43:13 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 23:43:13 INFO - (blobuploader) - INFO - Open directory for files ... 23:43:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:43:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:43:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:14 INFO - (blobuploader) - INFO - Done attempting. 23:43:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:43:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:43:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:20 INFO - (blobuploader) - INFO - Done attempting. 23:43:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:43:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:43:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:43:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:43:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:43:21 INFO - (blobuploader) - INFO - Done attempting. 23:43:21 INFO - (blobuploader) - INFO - Iteration through files over. 23:43:21 INFO - Return code: 0 23:43:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:43:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:43:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/975d08464a4e27de35ff21c340c0925ec43913e03a1d1921c2ad43662d38332544b4638aca05725f8069dc0de1f2dd2ccf56bd7afc4f2c309f860c03eb4d190c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa7d940386ba5e1f4e0c3e462a72d280cba7738064d3221b00058c7273d9bb7ce5914529f48dcd817dac401fae59d761d3e90c3015cd164aea73fa540471b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/013710a4293308770dec4c60ad7ae64f8bd5d28655262c32ac66e5824243666f67dd7c13488078ff891be888734425c12d5b43c967ef246d5bd4bc2f2e4fb680"} 23:43:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:43:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:43:21 INFO - Contents: 23:43:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/975d08464a4e27de35ff21c340c0925ec43913e03a1d1921c2ad43662d38332544b4638aca05725f8069dc0de1f2dd2ccf56bd7afc4f2c309f860c03eb4d190c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa7d940386ba5e1f4e0c3e462a72d280cba7738064d3221b00058c7273d9bb7ce5914529f48dcd817dac401fae59d761d3e90c3015cd164aea73fa540471b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/013710a4293308770dec4c60ad7ae64f8bd5d28655262c32ac66e5824243666f67dd7c13488078ff891be888734425c12d5b43c967ef246d5bd4bc2f2e4fb680"} 23:43:21 INFO - Running post-run listener: copy_logs_to_upload_dir 23:43:21 INFO - Copying logs to upload dir... 23:43:21 INFO - mkdir: /builds/slave/test/build/upload/logs 23:43:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.728277 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-13 23:43:21.191477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:21.199983) ========= 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-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/975d08464a4e27de35ff21c340c0925ec43913e03a1d1921c2ad43662d38332544b4638aca05725f8069dc0de1f2dd2ccf56bd7afc4f2c309f860c03eb4d190c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa7d940386ba5e1f4e0c3e462a72d280cba7738064d3221b00058c7273d9bb7ce5914529f48dcd817dac401fae59d761d3e90c3015cd164aea73fa540471b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/013710a4293308770dec4c60ad7ae64f8bd5d28655262c32ac66e5824243666f67dd7c13488078ff891be888734425c12d5b43c967ef246d5bd4bc2f2e4fb680"} build_url:https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/RR6beNKfSs6_OtV5vVK4-Q/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/975d08464a4e27de35ff21c340c0925ec43913e03a1d1921c2ad43662d38332544b4638aca05725f8069dc0de1f2dd2ccf56bd7afc4f2c309f860c03eb4d190c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eaa7d940386ba5e1f4e0c3e462a72d280cba7738064d3221b00058c7273d9bb7ce5914529f48dcd817dac401fae59d761d3e90c3015cd164aea73fa540471b9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/013710a4293308770dec4c60ad7ae64f8bd5d28655262c32ac66e5824243666f67dd7c13488078ff891be888734425c12d5b43c967ef246d5bd4bc2f2e4fb680"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:21.233980) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:21.234346) ========= 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-1468477367.903359-296499436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 23:43:21.318274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:21.320674) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 23:43:21.321027) ========= ========= Total master_lag: 0.21 =========