builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1465136117.7 results: success (0) buildid: 20160605043005 builduid: fbda51f85e554f00bc7eed972d025b06 revision: b9213f375a3fa9570893c23eef9ef4be4cc83226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.704653) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.705148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.705434) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.726700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.726972) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 07:15:18-- 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% 46.4M=0s 2016-06-05 07:15:18 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.890504) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.890785) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018309 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.945279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:17.945605) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b9213f375a3fa9570893c23eef9ef4be4cc83226 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b9213f375a3fa9570893c23eef9ef4be4cc83226 --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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 07:15:18,434 truncating revision to first 12 chars 2016-06-05 07:15:18,434 Setting DEBUG logging. 2016-06-05 07:15:18,434 attempt 1/10 2016-06-05 07:15:18,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b9213f375a3f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 07:15:18,865 unpacking tar archive at: mozilla-inbound-b9213f375a3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:18.704435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:18.704818) ========= script_repo_revision: b9213f375a3fa9570893c23eef9ef4be4cc83226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:18.705242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:18.705847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 07:15:18.714948) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-05 07:15:18.715363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:19 INFO - MultiFileLogger online at 20160605 07:15:19 in /builds/slave/test 07:15:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:15:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:19 INFO - {'append_to_log': False, 07:15:19 INFO - 'base_work_dir': '/builds/slave/test', 07:15:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:15:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:19 INFO - 'branch': 'Mozilla-Inbound', 07:15:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:19 INFO - 'config_files': ('talos/linux_config.py',), 07:15:19 INFO - 'default_actions': ('clobber', 07:15:19 INFO - 'read-buildbot-config', 07:15:19 INFO - 'download-and-extract', 07:15:19 INFO - 'populate-webroot', 07:15:19 INFO - 'create-virtualenv', 07:15:19 INFO - 'install', 07:15:19 INFO - 'run-tests'), 07:15:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:19 INFO - 'download_minidump_stackwalk': True, 07:15:19 INFO - 'download_symbols': 'ondemand', 07:15:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:19 INFO - 'installer_path': 'installer.exe', 07:15:19 INFO - 'log_level': 'info', 07:15:19 INFO - 'log_name': 'talos', 07:15:19 INFO - 'log_to_console': True, 07:15:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:19 INFO - 'opt_config_files': (), 07:15:19 INFO - 'pip_index': False, 07:15:19 INFO - 'sps_profile': False, 07:15:19 INFO - 'sps_profile_interval': 0, 07:15:19 INFO - 'suite': 'dromaeojs', 07:15:19 INFO - 'system_bits': '32', 07:15:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:19 INFO - 'title': 'talos-linux64-ix-060', 07:15:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:19 INFO - 'use_talos_json': True, 07:15:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:19 INFO - 'work_dir': 'build'} 07:15:19 INFO - ##### 07:15:19 INFO - ##### Running clobber step. 07:15:19 INFO - ##### 07:15:19 INFO - Running pre-action listener: _resource_record_pre_action 07:15:19 INFO - Running main action method: clobber 07:15:19 INFO - rmtree: /builds/slave/test/build 07:15:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:20 INFO - Running post-action listener: _resource_record_post_action 07:15:20 INFO - ##### 07:15:20 INFO - ##### Finished clobber step (success) 07:15:20 INFO - ##### 07:15:20 INFO - ##### 07:15:20 INFO - ##### Running read-buildbot-config step. 07:15:20 INFO - ##### 07:15:20 INFO - Running pre-action listener: _resource_record_pre_action 07:15:20 INFO - Running main action method: read_buildbot_config 07:15:20 INFO - Using buildbot properties: 07:15:20 INFO - { 07:15:20 INFO - "project": "", 07:15:20 INFO - "product": "firefox", 07:15:20 INFO - "script_repo_revision": "production", 07:15:20 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:15:20 INFO - "repository": "", 07:15:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:15:20 INFO - "buildid": "20160605043005", 07:15:20 INFO - "pgo_build": "True", 07:15:20 INFO - "basedir": "/builds/slave/test", 07:15:20 INFO - "buildnumber": 1052, 07:15:20 INFO - "slavename": "talos-linux64-ix-060", 07:15:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:15:20 INFO - "platform": "ubuntu64_hw", 07:15:20 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:15:20 INFO - "branch": "mozilla-inbound", 07:15:20 INFO - "repo_path": "integration/mozilla-inbound", 07:15:20 INFO - "revision": "b9213f375a3fa9570893c23eef9ef4be4cc83226", 07:15:20 INFO - "stage_platform": "linux64-pgo", 07:15:20 INFO - "builduid": "fbda51f85e554f00bc7eed972d025b06", 07:15:20 INFO - "slavebuilddir": "test" 07:15:20 INFO - } 07:15:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:15:20 INFO - Running post-action listener: _resource_record_post_action 07:15:20 INFO - ##### 07:15:20 INFO - ##### Finished read-buildbot-config step (success) 07:15:20 INFO - ##### 07:15:20 INFO - ##### 07:15:20 INFO - ##### Running download-and-extract step. 07:15:20 INFO - ##### 07:15:20 INFO - Running pre-action listener: _resource_record_pre_action 07:15:20 INFO - Running main action method: download_and_extract 07:15:20 INFO - mkdir: /builds/slave/test/build/tests 07:15: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')]} 07:15:20 INFO - https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:15:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:15:22 INFO - Downloaded 1361 bytes. 07:15:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:15:22 INFO - Using the following test package requirements: 07:15:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:15:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:15:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'jsshell-linux-x86_64.zip'], 07:15:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:15:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:15:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:15:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:15:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:15:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:15:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:15:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:22 INFO - https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:15:25 INFO - Downloaded 24442611 bytes. 07:15:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:15:26 INFO - Return code: 0 07:15:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:15:26 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')]} 07:15:26 INFO - https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:15:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:15:28 INFO - Downloaded 24442611 bytes. 07:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:15:29 INFO - Return code: 0 07:15:29 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')]} 07:15:29 INFO - https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:15:30 INFO - Downloaded 10833369 bytes. 07:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:15:30 INFO - Return code: 0 07:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:30 INFO - https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:15:32 INFO - Downloaded 59173081 bytes. 07:15:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:32 INFO - mkdir: /builds/slave/test/properties 07:15:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:32 INFO - Contents: 07:15:32 INFO - build_url:https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:33 INFO - Running post-action listener: _resource_record_post_action 07:15:33 INFO - Running post-action listener: set_extra_try_arguments 07:15:33 INFO - ##### 07:15:33 INFO - ##### Finished download-and-extract step (success) 07:15:33 INFO - ##### 07:15:33 INFO - ##### 07:15:33 INFO - ##### Running populate-webroot step. 07:15:33 INFO - ##### 07:15:33 INFO - Running pre-action listener: _resource_record_pre_action 07:15:33 INFO - Running main action method: populate_webroot 07:15:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:33 INFO - '--tppagecycles', 07:15:33 INFO - '7'], 07:15:33 INFO - 'tests': ['tsvgm']}}, 07:15:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['damp', 'tps']}, 07:15:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'tests': ['damp', 'tps']}, 07:15:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['dromaeo_dom']}, 07:15:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['a11yr', 07:15:33 INFO - 'ts_paint', 07:15:33 INFO - 'tpaint', 07:15:33 INFO - 'sessionrestore', 07:15:33 INFO - 'sessionrestore_no_auto_restore', 07:15:33 INFO - 'tabpaint']}, 07:15:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['tsvgx', 07:15:33 INFO - 'tsvgr_opacity', 07:15:33 INFO - 'tart', 07:15:33 INFO - 'tscrollx', 07:15:33 INFO - 'cart']}, 07:15:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:33 INFO - 'tsvgr_opacity', 07:15:33 INFO - 'tart', 07:15:33 INFO - 'tscrollx', 07:15:33 INFO - 'cart']}, 07:15:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'talos_options': ['--disable-e10s'], 07:15:33 INFO - 'tests': ['tp5o']}, 07:15:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'tests': ['tp5o']}, 07:15:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'talos_options': ['--disable-e10s', 07:15:33 INFO - '--xperf_path', 07:15:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:33 INFO - 'tests': ['tp5n']}, 07:15:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:33 INFO - 'talos_options': ['--xperf_path', 07:15:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:33 INFO - 'tests': ['tp5n']}}, 07:15:33 INFO - 'talos.zip': {'path': '', 07:15:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:33 INFO - Running post-action listener: _resource_record_post_action 07:15:33 INFO - ##### 07:15:33 INFO - ##### Finished populate-webroot step (success) 07:15:33 INFO - ##### 07:15:33 INFO - ##### 07:15:33 INFO - ##### Running create-virtualenv step. 07:15:33 INFO - ##### 07:15:33 INFO - Running pre-action listener: _resource_record_pre_action 07:15:33 INFO - Running main action method: create_virtualenv 07:15:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:33 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 07:15:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:33 INFO - Using real prefix '/usr' 07:15:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:35 INFO - Installing pip.................done. 07:15:35 INFO - Return code: 0 07:15:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:15:35 INFO - Using env: {'DISPLAY': ':0', 07:15:35 INFO - 'HOME': '/home/cltbld', 07:15:35 INFO - 'LANG': 'en_US.UTF-8', 07:15:35 INFO - 'LANGUAGE': 'en_US:en', 07:15:35 INFO - 'LOGNAME': 'cltbld', 07:15:35 INFO - 'MAIL': '/var/mail/cltbld', 07:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:35 INFO - 'MOZ_NO_REMOTE': '1', 07:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:35 INFO - 'NO_EM_RESTART': '1', 07:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:35 INFO - 'PWD': '/builds/slave/test', 07:15:35 INFO - 'SHELL': '/bin/bash', 07:15:35 INFO - 'SHLVL': '1', 07:15:35 INFO - 'TERM': 'linux', 07:15:35 INFO - 'TMOUT': '86400', 07:15:35 INFO - 'USER': 'cltbld', 07:15:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:35 INFO - '_': '/tools/buildbot/bin/python'} 07:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:35 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 07:15:35 INFO - Cleaning up... 07:15:35 INFO - Return code: 0 07:15:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:15:35 INFO - Using env: {'DISPLAY': ':0', 07:15:35 INFO - 'HOME': '/home/cltbld', 07:15:35 INFO - 'LANG': 'en_US.UTF-8', 07:15:35 INFO - 'LANGUAGE': 'en_US:en', 07:15:35 INFO - 'LOGNAME': 'cltbld', 07:15:35 INFO - 'MAIL': '/var/mail/cltbld', 07:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:35 INFO - 'MOZ_NO_REMOTE': '1', 07:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:35 INFO - 'NO_EM_RESTART': '1', 07:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:35 INFO - 'PWD': '/builds/slave/test', 07:15:35 INFO - 'SHELL': '/bin/bash', 07:15:35 INFO - 'SHLVL': '1', 07:15:35 INFO - 'TERM': 'linux', 07:15:35 INFO - 'TMOUT': '86400', 07:15:35 INFO - 'USER': 'cltbld', 07:15:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:35 INFO - '_': '/tools/buildbot/bin/python'} 07:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:36 INFO - Downloading/unpacking psutil>=3.1.1 07:15:36 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 07:15:36 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 07:15:36 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 07:15:36 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 07:15:36 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 07:15:36 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 07:15:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:38 INFO - Installing collected packages: psutil 07:15:38 INFO - Running setup.py install for psutil 07:15:38 INFO - building 'psutil._psutil_linux' extension 07:15:38 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 07:15:38 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 07:15:38 INFO - building 'psutil._psutil_posix' extension 07:15:38 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 07:15:38 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 07:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:38 INFO - Successfully installed psutil 07:15:38 INFO - Cleaning up... 07:15:38 INFO - Return code: 0 07:15:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:15:38 INFO - Using env: {'DISPLAY': ':0', 07:15:38 INFO - 'HOME': '/home/cltbld', 07:15:38 INFO - 'LANG': 'en_US.UTF-8', 07:15:38 INFO - 'LANGUAGE': 'en_US:en', 07:15:38 INFO - 'LOGNAME': 'cltbld', 07:15:38 INFO - 'MAIL': '/var/mail/cltbld', 07:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:38 INFO - 'MOZ_NO_REMOTE': '1', 07:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:38 INFO - 'NO_EM_RESTART': '1', 07:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:38 INFO - 'PWD': '/builds/slave/test', 07:15:38 INFO - 'SHELL': '/bin/bash', 07:15:38 INFO - 'SHLVL': '1', 07:15:38 INFO - 'TERM': 'linux', 07:15:38 INFO - 'TMOUT': '86400', 07:15:38 INFO - 'USER': 'cltbld', 07:15:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:38 INFO - '_': '/tools/buildbot/bin/python'} 07:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:40 INFO - Installing collected packages: mozsystemmonitor 07:15:40 INFO - Running setup.py install for mozsystemmonitor 07:15:40 INFO - Successfully installed mozsystemmonitor 07:15:40 INFO - Cleaning up... 07:15:40 INFO - Return code: 0 07:15:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:40 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:40 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 07:15:40 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 07:15:40 INFO - Using env: {'DISPLAY': ':0', 07:15:40 INFO - 'HOME': '/home/cltbld', 07:15:40 INFO - 'LANG': 'en_US.UTF-8', 07:15:40 INFO - 'LANGUAGE': 'en_US:en', 07:15:40 INFO - 'LOGNAME': 'cltbld', 07:15:40 INFO - 'MAIL': '/var/mail/cltbld', 07:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:40 INFO - 'MOZ_NO_REMOTE': '1', 07:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:40 INFO - 'NO_EM_RESTART': '1', 07:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:40 INFO - 'PWD': '/builds/slave/test', 07:15:40 INFO - 'SHELL': '/bin/bash', 07:15:40 INFO - 'SHLVL': '1', 07:15:40 INFO - 'TERM': 'linux', 07:15:40 INFO - 'TMOUT': '86400', 07:15:40 INFO - 'USER': 'cltbld', 07:15:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:40 INFO - '_': '/tools/buildbot/bin/python'} 07:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:43 INFO - warning: no files found matching '*.txt' 07:15:43 INFO - no previously-included directories found matching 'build' 07:15:43 INFO - no previously-included directories found matching 'dist' 07:15:43 INFO - no previously-included directories found matching '.git*' 07:15:43 INFO - Installing collected packages: jsonschema, functools32 07:15:43 INFO - Running setup.py install for functools32 07:15:43 INFO - warning: no files found matching '*.txt' 07:15:43 INFO - no previously-included directories found matching 'build' 07:15:43 INFO - no previously-included directories found matching 'dist' 07:15:43 INFO - no previously-included directories found matching '.git*' 07:15:43 INFO - Successfully installed jsonschema functools32 07:15:43 INFO - Cleaning up... 07:15:43 INFO - Return code: 0 07:15:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:43 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')]} 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 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')]} 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:43 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 07:15:43 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 07:15:43 INFO - Using env: {'DISPLAY': ':0', 07:15:43 INFO - 'HOME': '/home/cltbld', 07:15:43 INFO - 'LANG': 'en_US.UTF-8', 07:15:43 INFO - 'LANGUAGE': 'en_US:en', 07:15:43 INFO - 'LOGNAME': 'cltbld', 07:15:43 INFO - 'MAIL': '/var/mail/cltbld', 07:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:43 INFO - 'MOZ_NO_REMOTE': '1', 07:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:43 INFO - 'NO_EM_RESTART': '1', 07:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:43 INFO - 'PWD': '/builds/slave/test', 07:15:43 INFO - 'SHELL': '/bin/bash', 07:15:43 INFO - 'SHLVL': '1', 07:15:43 INFO - 'TERM': 'linux', 07:15:43 INFO - 'TMOUT': '86400', 07:15:43 INFO - 'USER': 'cltbld', 07:15:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:43 INFO - '_': '/tools/buildbot/bin/python'} 07:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:45 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 07:15:45 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 07:15:45 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 07:15:45 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 07:15:45 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 07:15:45 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 07:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:46 INFO - Downloading docopt-0.6.1.tar.gz 07:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:46 INFO - Running setup.py install for blobuploader 07:15:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:46 INFO - Running setup.py install for requests 07:15:46 INFO - Running setup.py install for docopt 07:15:46 INFO - Successfully installed blobuploader requests docopt 07:15:46 INFO - Cleaning up... 07:15:47 INFO - Return code: 0 07:15:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:47 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')]} 07:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 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')]} 07:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:47 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:47 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 07:15:47 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 07:15:47 INFO - Using env: {'DISPLAY': ':0', 07:15:47 INFO - 'HOME': '/home/cltbld', 07:15:47 INFO - 'LANG': 'en_US.UTF-8', 07:15:47 INFO - 'LANGUAGE': 'en_US:en', 07:15:47 INFO - 'LOGNAME': 'cltbld', 07:15:47 INFO - 'MAIL': '/var/mail/cltbld', 07:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:47 INFO - 'MOZ_NO_REMOTE': '1', 07:15:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:47 INFO - 'NO_EM_RESTART': '1', 07:15:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:47 INFO - 'PWD': '/builds/slave/test', 07:15:47 INFO - 'SHELL': '/bin/bash', 07:15:47 INFO - 'SHLVL': '1', 07:15:47 INFO - 'TERM': 'linux', 07:15:47 INFO - 'TMOUT': '86400', 07:15:47 INFO - 'USER': 'cltbld', 07:15:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:47 INFO - '_': '/tools/buildbot/bin/python'} 07:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:47 INFO - Running setup.py (path:/tmp/pip-rrrt4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:47 INFO - Running setup.py (path:/tmp/pip-BzzmjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:47 INFO - Running setup.py (path:/tmp/pip-7TSikb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 INFO - Running setup.py (path:/tmp/pip-YWrT7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Running setup.py (path:/tmp/pip-xpyN9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Running setup.py (path:/tmp/pip-VIy_Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Running setup.py (path:/tmp/pip-wK1YqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Running setup.py (path:/tmp/pip-Pk730Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Running setup.py (path:/tmp/pip-GIDGaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Running setup.py (path:/tmp/pip-MoKU6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Running setup.py (path:/tmp/pip-YUcTVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:48 INFO - Running setup.py (path:/tmp/pip-pwL5qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:48 INFO - Running setup.py (path:/tmp/pip-i0GBtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:48 INFO - Running setup.py (path:/tmp/pip-uphB66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:48 INFO - Running setup.py (path:/tmp/pip-bkQsX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:48 INFO - Running setup.py (path:/tmp/pip-uQBBrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:48 INFO - Running setup.py (path:/tmp/pip-f2rdd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:48 INFO - Running setup.py install for manifestparser 07:15:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozcrash 07:15:48 INFO - Running setup.py install for mozdebug 07:15:48 INFO - Running setup.py install for mozdevice 07:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:48 INFO - Running setup.py install for mozfile 07:15:49 INFO - Running setup.py install for mozhttpd 07:15:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozinfo 07:15:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozInstall 07:15:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozleak 07:15:49 INFO - Running setup.py install for mozlog 07:15:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for moznetwork 07:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozprocess 07:15:49 INFO - Running setup.py install for mozprofile 07:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozrunner 07:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:49 INFO - Running setup.py install for mozscreenshot 07:15:50 INFO - Running setup.py install for moztest 07:15:50 INFO - Running setup.py install for mozversion 07:15:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:50 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 07:15:50 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 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:50 INFO - Running setup.py (path:/tmp/pip-3ZfN9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:50 INFO - Running setup.py (path:/tmp/pip-sEVlWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:50 INFO - Running setup.py (path:/tmp/pip-fXWtU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:50 INFO - Running setup.py (path:/tmp/pip-9QW_xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:50 INFO - Running setup.py (path:/tmp/pip-m2V4VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:50 INFO - Running setup.py (path:/tmp/pip-mLcG5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:50 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)) 07:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:50 INFO - Running setup.py (path:/tmp/pip-VQpaxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 INFO - Running setup.py (path:/tmp/pip-glRfhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:51 INFO - Running setup.py (path:/tmp/pip-HAI9Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:51 INFO - Running setup.py (path:/tmp/pip-OU1TM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 INFO - Running setup.py (path:/tmp/pip-aZkfNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 INFO - Running setup.py (path:/tmp/pip-t2gSUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 INFO - Running setup.py (path:/tmp/pip-qdfENs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:51 INFO - Running setup.py (path:/tmp/pip-o8LXLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:51 INFO - Running setup.py (path:/tmp/pip-sCXKF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:51 INFO - Running setup.py (path:/tmp/pip-x7lbno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:51 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)) 07:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:51 INFO - Running setup.py (path:/tmp/pip-OyDFPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:51 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)) 07:15:51 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)) 07:15:51 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)) 07:15:51 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)) 07:15:51 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)) 07:15:51 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)) 07:15:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:53 INFO - Downloading blessings-1.6.tar.gz 07:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:53 INFO - Installing collected packages: blessings 07:15:53 INFO - Running setup.py install for blessings 07:15:53 INFO - Successfully installed blessings 07:15:53 INFO - Cleaning up... 07:15:53 INFO - Return code: 0 07:15:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:54 INFO - Reading from file tmpfile_stdout 07:15:54 INFO - Current package versions: 07:15:54 INFO - argparse == 1.2.1 07:15:54 INFO - blessings == 1.6 07:15:54 INFO - blobuploader == 1.2.4 07:15:54 INFO - docopt == 0.6.1 07:15:54 INFO - functools32 == 3.2.3-2 07:15:54 INFO - jsonschema == 2.5.1 07:15:54 INFO - manifestparser == 1.1 07:15:54 INFO - mozInstall == 1.12 07:15:54 INFO - mozcrash == 0.17 07:15:54 INFO - mozdebug == 0.1 07:15:54 INFO - mozdevice == 0.48 07:15:54 INFO - mozfile == 1.2 07:15:54 INFO - mozhttpd == 0.7 07:15:54 INFO - mozinfo == 0.9 07:15:54 INFO - mozleak == 0.1 07:15:54 INFO - mozlog == 3.2 07:15:54 INFO - moznetwork == 0.27 07:15:54 INFO - mozprocess == 0.22 07:15:54 INFO - mozprofile == 0.28 07:15:54 INFO - mozrunner == 6.11 07:15:54 INFO - mozscreenshot == 0.1 07:15:54 INFO - mozsystemmonitor == 0.3 07:15:54 INFO - moztest == 0.7 07:15:54 INFO - mozversion == 1.4 07:15:54 INFO - psutil == 3.1.1 07:15:54 INFO - requests == 1.2.3 07:15:54 INFO - wsgiref == 0.1.2 07:15:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:54 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')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:54 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 07:15:54 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 07:15:54 INFO - Using env: {'DISPLAY': ':0', 07:15:54 INFO - 'HOME': '/home/cltbld', 07:15:54 INFO - 'LANG': 'en_US.UTF-8', 07:15:54 INFO - 'LANGUAGE': 'en_US:en', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MAIL': '/var/mail/cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SHLVL': '1', 07:15:54 INFO - 'TERM': 'linux', 07:15:54 INFO - 'TMOUT': '86400', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - '_': '/tools/buildbot/bin/python'} 07:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 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)) 07:15:54 INFO - Cleaning up... 07:15:54 INFO - Return code: 0 07:15:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:54 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')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:54 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 07:15:54 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 07:15:54 INFO - Using env: {'DISPLAY': ':0', 07:15:54 INFO - 'HOME': '/home/cltbld', 07:15:54 INFO - 'LANG': 'en_US.UTF-8', 07:15:54 INFO - 'LANGUAGE': 'en_US:en', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MAIL': '/var/mail/cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SHLVL': '1', 07:15:54 INFO - 'TERM': 'linux', 07:15:54 INFO - 'TMOUT': '86400', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - '_': '/tools/buildbot/bin/python'} 07:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:54 INFO - Cleaning up... 07:15:54 INFO - Return code: 0 07:15:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15:54 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')]} 07:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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')]} 07:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:54 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 0x7f27d9138f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f4d350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, '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': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', '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 07:15:54 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 07:15:54 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 07:15:54 INFO - Using env: {'DISPLAY': ':0', 07:15:54 INFO - 'HOME': '/home/cltbld', 07:15:54 INFO - 'LANG': 'en_US.UTF-8', 07:15:54 INFO - 'LANGUAGE': 'en_US:en', 07:15:54 INFO - 'LOGNAME': 'cltbld', 07:15:54 INFO - 'MAIL': '/var/mail/cltbld', 07:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:54 INFO - 'MOZ_NO_REMOTE': '1', 07:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:54 INFO - 'NO_EM_RESTART': '1', 07:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:54 INFO - 'PWD': '/builds/slave/test', 07:15:54 INFO - 'SHELL': '/bin/bash', 07:15:54 INFO - 'SHLVL': '1', 07:15:54 INFO - 'TERM': 'linux', 07:15:54 INFO - 'TMOUT': '86400', 07:15:54 INFO - 'USER': 'cltbld', 07:15:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:54 INFO - '_': '/tools/buildbot/bin/python'} 07:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:54 INFO - Downloading/unpacking flake8 07:15:54 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 07:15:54 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 07:15:54 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 07:15:54 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 07:15:54 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 07:15:54 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 07:15:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:56 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 07:15:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 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 07:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:57 INFO - no previously-included directories found matching 'docs/_build' 07:15:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:57 INFO - Running setup.py install for pep8 07:15:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:57 INFO - no previously-included directories found matching 'docs/_build' 07:15:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:15:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:57 INFO - Cleaning up... 07:15:57 INFO - Return code: 0 07:15:57 INFO - Running post-action listener: _resource_record_post_action 07:15:57 INFO - Running post-action listener: _start_resource_monitoring 07:15:57 INFO - Starting resource monitoring. 07:15:57 INFO - ##### 07:15:57 INFO - ##### Finished create-virtualenv step (success) 07:15:57 INFO - ##### 07:15:57 INFO - ##### 07:15:57 INFO - ##### Running install step. 07:15:57 INFO - ##### 07:15:57 INFO - Running pre-action listener: _resource_record_pre_action 07:15:57 INFO - Running main action method: install 07:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:57 INFO - Reading from file tmpfile_stdout 07:15:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:57 INFO - Reading from file tmpfile_stdout 07:15:57 INFO - Output received: 07:15:57 INFO - Usage: mozinstall [options] installer 07:15:57 INFO - Options: 07:15:57 INFO - -h, --help show this help message and exit 07:15:57 INFO - -d DEST, --destination=DEST 07:15:57 INFO - Directory to install application into. [default: 07:15:57 INFO - "/builds/slave/test"] 07:15:57 INFO - --app=APP Application being installed. [default: firefox] 07:15:57 INFO - mkdir: /builds/slave/test/build/application 07:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:16:14 INFO - Reading from file tmpfile_stdout 07:16:14 INFO - Output received: 07:16:14 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:14 INFO - Running post-action listener: _resource_record_post_action 07:16:14 INFO - ##### 07:16:14 INFO - ##### Finished install step (success) 07:16:14 INFO - ##### 07:16:14 INFO - ##### 07:16:14 INFO - ##### Running run-tests step. 07:16:14 INFO - ##### 07:16:14 INFO - Running pre-action listener: _resource_record_pre_action 07:16:14 INFO - Running main action method: run_tests 07:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:14 INFO - Python 2.7.3 07:16:14 INFO - Return code: 0 07:16:14 INFO - grabbing minidump binary from tooltool 07:16:14 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')]} 07:16:14 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 0x1fdc1c0>, '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 0x1fdd0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fdd550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:14 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 07:16:14 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 07:16:14 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 07:16:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:14 INFO - Return code: 0 07:16:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:16:15 INFO - Return code: 0 07:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:16:15 INFO - Using env: {'DISPLAY': ':0', 07:16:15 INFO - 'HOME': '/home/cltbld', 07:16:15 INFO - 'LANG': 'en_US.UTF-8', 07:16:15 INFO - 'LANGUAGE': 'en_US:en', 07:16:15 INFO - 'LOGNAME': 'cltbld', 07:16:15 INFO - 'MAIL': '/var/mail/cltbld', 07:16:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:15 INFO - 'MOZ_NO_REMOTE': '1', 07:16:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:15 INFO - 'NO_EM_RESTART': '1', 07:16:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:15 INFO - 'PWD': '/builds/slave/test', 07:16:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:15 INFO - 'SHELL': '/bin/bash', 07:16:15 INFO - 'SHLVL': '1', 07:16:15 INFO - 'TERM': 'linux', 07:16:15 INFO - 'TMOUT': '86400', 07:16:15 INFO - 'USER': 'cltbld', 07:16:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915', 07:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:15 INFO - '_': '/tools/buildbot/bin/python'} 07:16:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:16:15 INFO - mozversion application_buildid: 20160605043005 07:16:15 INFO - mozversion application_changeset: b9213f375a3fa9570893c23eef9ef4be4cc83226 07:16:15 INFO - mozversion application_display_name: Nightly 07:16:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:15 INFO - mozversion application_name: Firefox 07:16:15 INFO - mozversion application_remotingname: firefox 07:16:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:16:15 INFO - mozversion application_vendor: Mozilla 07:16:15 INFO - mozversion application_version: 49.0a1 07:16:15 INFO - mozversion platform_buildid: 20160605043005 07:16:15 INFO - mozversion platform_changeset: b9213f375a3fa9570893c23eef9ef4be4cc83226 07:16:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:16:15 INFO - mozversion platform_version: 49.0a1 07:16:15 INFO - using testdate: 1465136175 07:16:15 INFO - actual date: 1465136175 07:16:15 INFO - starting webserver on 'localhost:47872' 07:16:15 INFO - SUITE-START | Running 2 tests 07:16:15 INFO - TEST-START | dromaeo_css 07:16:15 INFO - operating with platform_type : linux_ 07:16:15 INFO - Initialising browser for dromaeo_css test... 07:16:15 INFO - TEST-INFO | started process 21568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNRQVr/profile http://localhost:47872/getInfo.html) 07:16:20 INFO - PROCESS | 21568 | __metrics Screen width/height:1600/1200 07:16:20 INFO - PROCESS | 21568 | colorDepth:24 07:16:20 INFO - PROCESS | 21568 | Browser inner width/height: 1024/697 07:16:20 INFO - PROCESS | 21568 | __metrics 07:16:21 ERROR - PROCESS | 21568 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:16:22 INFO - TEST-INFO | 21568: exit 0 07:16:22 INFO - Browser initialized. 07:16:22 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:22 INFO - TEST-INFO | started process 21650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplNRQVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:33 INFO - PROCESS | 21650 | RSS: Main: 156049408 07:16:33 INFO - PROCESS | 21650 | 07:17:24 INFO - PROCESS | 21650 | 1465136244938 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] 07:19:32 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47872/tests/dromaeo/cssquery-ext.html) 07:19:33 INFO - PROCESS | 21650 | RSS: Main: 259874816 07:19:33 INFO - PROCESS | 21650 | 07:22:36 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-ext.html (next: http://localhost:47872/tests/dromaeo/cssquery-jquery.html) 07:22:36 INFO - PROCESS | 21650 | RSS: Main: 241295360 07:22:36 INFO - PROCESS | 21650 | 07:25:39 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47872/tests/dromaeo/cssquery-mootools.html) 07:25:39 INFO - PROCESS | 21650 | RSS: Main: 250507264 07:25:39 INFO - PROCESS | 21650 | 07:28:41 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47872/tests/dromaeo/cssquery-prototype.html) 07:28:42 INFO - PROCESS | 21650 | RSS: Main: 241688576 07:28:42 INFO - PROCESS | 21650 | 07:31:44 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47872/tests/dromaeo/cssquery-yui.html) 07:31:45 INFO - PROCESS | 21650 | RSS: Main: 229629952 07:31:45 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | Cycle 1(1): loaded http://localhost:47872/tests/dromaeo/cssquery-yui.html (next: http://localhost:47872/tests/dromaeo/cssquery-dojo.html) 07:34:48 INFO - PROCESS | 21650 | RSS: Main: 313143296 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | __start_tp_report 07:34:48 INFO - PROCESS | 21650 | _x_x_mozilla_page_load 07:34:48 INFO - PROCESS | 21650 | _x_x_mozilla_page_load_details 07:34:48 INFO - PROCESS | 21650 | |i|pagename|runs| 07:34:48 INFO - PROCESS | 21650 | |0;dojo.html;3128.4681604127304;3150.2439414540518;3163.1143279881626;3197.456432406491;3202.887898923537;5273.18265668821;5364.168553874146;5456.781728730851;5573.414791446896;5596.692181929992;5388.326459192601;5403.621746477748;5446.863828404292;5471.316085489314;5526.917096243559;4860.125177468063;4935.975320123394;4944.085344211315;4949.678270912397;5181.145111056671;5031.84904452867;5053.065182941149;5089;5116.232565115244;5124.385073791151;4812.783424745895;4919.532644398776;4985.5513003829465;5002.424721157077;5005.849824505271;4967.677100988461;4983.277424773388;4986.301917731521;5066.06277838601;5111.335526381584;4993.275974983607;5029.597632189416;5039.521245481674;5043;5080.187170052811;5193.37679478465;5345.492178243061;5428.782848686048;5498.560115190775;5523.917141242885;5948;5968.7910923117915;6014.1580178775;6014.518838492954;6025.126356678257;5680.971595141998;5881.264841894763;5990.341062483123;6050.304215015286;6056.242969628796;5466.234727138204;5561.860953476155;5583.469570390806;5588.6646801191655;5588.804391846266;6147;6183.81448556544;6184.5052395808225;6185.257769067651;6188.226471691039;5601.663900166003;5763.394843541451;5852;5868.794592189253;5900.203472531153;6004.609700369462;6006.069059295816;6006.279246490361;6045.153678485016;6067.544934129958;5961.672108034013;5979.222701048923;5979.790707325223;5980.850478738066;5986.580939334205;5606.55147588192;5797.391273916178;5804.506616937608;5807.82576522705;5924.20023296858;4415.359772832921;4481.910361792746;4487.282034874404;4489.842855500107;4520.389747384127;3939.2712348215673;3986.980065099714;3994.8601798936897;4001.394561211241;4026.939595906064;5346.823698786261;5356.866078348073;5487.122060470386;5532.640378375393;5533;5973.133895585116;5986.491148252448;6000.549958753024;6005.249343832021;6048.334683184846;5504.779808807683;5518.972405138029;5569.248151499577;5570.470805273492;5585.553155747531;4713.622910167179;4796.400449943757;4852.684575502581;4863.927041094386;4889.046635906036;6056.364081771439;6062.272527296753;6062.484688801413;6065.423784740443;6068.120122582289;5720.6853623049465;5878.853028674317;5889.970550147222;5890.1164825276555;5895.145203945318;5980.491658208927;6041.667708276087;6065.72704228302;6085.817425477243;6108.17539632144;5784.305883294031;5802.970985145047;5814.331351894586;5817.563682723728;5820.388859169896;5618.88762224745;5858.443447872445;5895.086261629454;5915.822525324247;5921.3782552831335;5743.62666426681;5807.535397168301;5828.708564571839;5848.678322692293;5881;5816.098504731774;5821.679807610452;5830.2420685310635;5833.095870140135;5835.94164058354;5462.672239665632;5631.971840140773;5696.8006119785605;5751.137329400456;5757.625754325955;5908.320543137423;5942.346341902474;5951.940480595139;5952.642841429528;5953.970230148995;5761.769529218952;5766.826995190151;5772.624779389326;5774.04728219839;5778.537716982715 07:34:48 INFO - PROCESS | 21650 | |1;ext.html;558.6340946679924;601.8615718384772;611.1932249430752;617.9752809887605;619.2692622705206;33243.50134747981;36155.63844361556;36200.818995905014;36228.818855905716;42843;42241.57758422415;43119.353209701876;43139.56860431395;43214.567854321525;43238;8583.87124193136;8813.867791983093;8814.779630509256;8825.691100811473;8827.117288271185;8629.784255393633;8778.56107194641;8778.956105219466;8789.64841406343;8790.956045219766;8519.616617252239;8527.44571602847;8541.572921353938;8548.059713431518;8548.914510854875;8656.826863462727;8701.347398945041;8707.390482666216;8713.259372953307;8745.125487451267;8604.612792424356;8658.567071646456;8676.175763302539;8718.34612404066;8724.607392667345;38852.41721374181;39186.80406597977;39248.60751392507;39322;39348;3485.8777261351256;3640.799756013418;3692.7968961707097;3983.661388781928;4303.483581970152;30384.696153038407;32107.83946080278;32145.1963700907;32176.517352239734;32230;4307.8492252771;4315.697901146921;4533.138703646297;4635.582797548203;4644.744539050351;395406.99999999715;397259;400419;400429;401396;61642.383576163666;62053;62419.6879015602;62454.687726561075;62541;65379.67310163419;65756.34243657599;65843.34156658468;66008.66995665088;66037.66981165159;17468.388606398716;17696.29214831392;17719.025453600178;17731.29074836992;17737.556561086076;12956.352182390843;12961.935190323988;12965.935170324088;12970.740585188243;12976.15654982423;18422.184847655306;19382.040521770792;19579.11986889974;19580.70628940567;19624.803751962583;7186.8203294917;7190.7483238086415;7253.927460725326;7279.927200728031;7446.478746487694;1038.771470276538;1112.8831472695413;1158.7045303447567;1169.181572898974;1192.022541515966;31937.361252774816;32771.67228327734;33032.174195645304;33079.60199004975;33490.16274593106;1139.9715007124723;1141.2823700330948;1175.6884425627215;1176.1590462819127;1196.730735584504;17132.229049692545;17354.652906941792;17357.13214339278;17408.82591174072;17424.82575174232;607392;614184;618863;620854;621895;59408.40591594029;59882.70058649766;59952.40047599556;59963.100553491735;59977.400225998055;1262.50762202741;1293.618382577142;1382.4124746982693;1388.7361401333715;1403.3404299978993;30511.237219069702;32256.193595160308;34104.31791364109;34209.82895085509;34358.82820585881;52301.215481768566;53269;53337;53338.73330633322;53343.199852003025;519571;538944;539167;539364;540005;37963;44017.559824401345;44717.55282447134;45424.77287613541;48623.27065094097;49187.75406122946;49510;49591.75204123956;50215.24677129919;51003.48996509987;40244.3963340556;41178.38232426456;41939.37090943699;42761.14477710366;43136.13727725491;41144.588554114074;41761.79119104385;41810.163796724504;42098.57901420946;42228.155436890476;40823.18353632851;41986.58013419949;42416.1516769669;42458.363124553776;42606;35417;37331.06672333214;37927.81036094802;38185.80907095447;38279.92586058208;28912.710872891003;29026.830603813538;29096.854515727286;29172;29340 07:34:48 INFO - PROCESS | 21650 | |2;jquery.html;384.97112716546246;391.27223364541953;392.92341952245454;395.4463750748951;409.58836369448716;14263;18064.729029064576;19426.805731942677;20112.094955726992;20113.497162570926;15815.683686326267;18014;18825.90587047063;18834.34079807207;19120.808791912077;5661.773529058843;5810.622309549865;5834.066549352105;5843.152742852284;5846.298444186704;4137.627613514783;5725.885482290351;5782.3639399666;6058.485028772559;6434.7104380303;6322.209723784527;6341.239051313849;6367.076773867786;6387.93612063878;6401.391867772554;6228.5017198624;6258.186435763344;6374.203224596926;6424.229092508882;6424.871502569946;5031.84904452867;5519.972400138014;5523.889522209573;5526.336839579236;5550.27846379972;12604.68488287791;12805.80791288122;12809.551665691655;12819.16675416095;12821.358932053454;2226.7773222677765;2259.570681570496;2326.4649130700036;2445.437549363656;2704.878280477383;9424.575894084783;9863.852042219372;10116.797664046679;10822.67531974042;14808.777868331983;1819.217736373359;1841.6777064013877;1856.795752467241;1857.3963461874944;1859.6466671332403;78857.60571197107;81029;83066.58466707688;84417.57791211066;86044;10935.453227338601;10967.232293739362;10994.120470362352;11221.438928053565;11250.774984500264;15527.611809704847;15585.06489610627;15799.526014219591;15889.602759930864;15903.840961590467;8301.543415112226;8383.8323233535;8390.28682561989;8584.957075214585;8622.698205562776;7100.076989991371;8176;8231.176882311722;8249.628766705513;8342.541160236124;4494.797734101973;4545.159145558082;4730.905381892343;4866.78099485524;4938.827141050046;1855.1188185611727;1882.6234753049446;1916.7795703493998;1982.4250967219634;2034.6032523657746;874.2568816506047;980.152168374351;1008.7528555503949;1010.888802231754;1049.338916482611;18348.63302733938;19762.11070501831;20056.799432005493;20130.094145763476;20488;991.5984026469291;995.1938929467154;1005.9209903839999;1032.8347464405658;1038.314712289885;10966.890331096587;11155.386453744959;11228.27329118159;11243.313502974619;11277.154213434025;162523;162804.18597906936;459797;526080;539844;74768;90895.54552227329;95189;95309.52345238229;95528.52235738777;1006.2101250518308;1009.6769033909226;1014.2899970021015;1020.4081632653043;1029.5933106422922;17494;17525.649487010443;17790.91104544469;17924.820751792315;18150.364737234133;39608.60391396049;40643.7967810159;40948.181036379705;42517.362239567046;42581.574184259;57806.132908007254;58324.416755831895;58333;58831;59363.70318148382;8211.384146189179;8278.172182781915;8568.057513673615;8606.096359882122;8708.56457177126;9110.590023448829;12776.552820651232;12919.289439080942;13083.345832708135;13563.254021028939;11474.25417347903;11485.138614603771;11514.251573647685;11652.708682283012;11670.533178672758;10835.945820270848;11217.775644486901;11386.658400248005;11424.82862757076;11701.76596468083;11465.541378344773;11502.654920352403;11566.30602163873;11629.302241865515;12107.576234831738;7946.8807967879375;8027.076886157933;8043.557604331584;8251.669933202606;8443.704470343508;8338;11412.48643811014;11489.770204596029;11494.942525287655;11654.70863228426 07:34:48 INFO - PROCESS | 21650 | |3;mootools.html;1323.708784067505;1475.926203689816;1508.992455037725;1665.775120358751;1833.9174737136827;8348.79128021799;8629.654813807449;8639.827203455927;8910.688125915594;8917.777055573613;8612.267957223628;8813.691520796774;8819.867701984474;8821.19165571058;8821.779455513599;2392.712874455068;2417.190241269177;2419.5160967806423;2421.6367544868235;2423.1761201191593;2402.8197885158597;2424.599941009731;2476.1209770531473;2488.278399264211;2493.1772515069983;2381.130887226159;2397.6043952747777;2413.81896357773;2414.843035202715;2428.0530593068715;2316.93049208524;2347.201951336554;2353.082297903819;2353.4351755578623;2394.2697477269426;2269.5574362999223;2315.780000899912;2316.420894776306;2320.640300753386;2321.651752237161;7530.322270995582;7758.806029849243;8875.73372798817;8930.821383572356;8939.910600893973;4692.601128904047;4801.903961920742;4824.927626085611;5234.26720259164;5407.594430417695;3196.7602429817625;3350.3299340131825;3395.1681837949614;3402.5406570113214;3526.1008442847165;1128.7798879218556;1136.1308598921833;1136.2614300704527;1149.1725957310723;1153.6077733570626;12086;12257.325847078408;12290.385480726018;12297.200681955645;12303.815442768366;4496.6177874881005;4607.9308810367875;4638.721676699409;4730.148573256778;4754.573627911613;10236.436995965145;10242.590296388062;10256.282060255711;10261.589536418609;10264.846027309597;5293.814716484904;5293.920591191135;5299.6290259681455;5305.920411193835;5308.336457942757;4816.133096042746;4818.7831547580445;4907.043126590352;4929.309896614477;4947.579455746302;3838.9424158637644;3971.900702482403;3973.4834471518516;3982.4424580558743;4063.329550624173;1247.2017908538542;1265.1649911058657;1271.211848653822;1273.0579371265196;1275.8262398593317;908.5094049213351;976.1897624971257;976.5751897924425;1012.9696109116738;1015.2842246216547;5918.970405147947;6056.121862330026;6126.785562505291;6146.661933593606;6293.465055470337;460.4635599526581;473.2121018504152;479.6690283704233;482.63078744760287;483.41023950779993;3859.7877116758846;3924.4898163238595;3955.248502784462;3993.281209382281;4055.0065234017857;11121.443927803577;11462.713432164095;11602.129840262014;11610.535578576762;11617.302961822317;11305.773884522263;11367.976882080653;11412.543498259976;11442.771144577062;11454.255473394203;7963.124056353797;8210.384221183316;8220.753377398687;8258.174182581814;8424.663013479514;6014.939850601438;6155.384461553809;6169.6915154241215;6258.718357674006;6333.904991425225;10404.323718958243;10564.947175264075;10750.677479675622;10760.623378181726;10764.784704306026;10788.29876058085;11036.668899933014;11062.225644205151;11132.88867111351;11161.330320180816;8281.130481299619;8303.709370172015;8373.874391884005;8384.53885036329;8386;8830.116988301375;8881;8919.643214271617;8948.060453652533;8985.865212021956;7861;8002.03975522941;8028.43800933929;8033.477823941425;8238.176182381714;7962.920370796218;7995.800104997422;8024.759257222293;8068.394870384627;8072.4349295548745;7207.459440542085;7325.304096110861;7330.120385553554;7335.816604584928;7339.1926888043345;3892.552356479041;5058.131132672578;5263.814643447209;5331.653442526223;5366.543843773323;5194.53249207558;5403.8108666196495;5435.918461223006;5453.863653408696;5557.055300598989 07:34:48 INFO - PROCESS | 21650 | |4;prototype.html;322.9854656540455;329.6308134888924;336.8029702623965;338.48550203690394;340.97613167078316;5309.398394786551;5323.307969963904;5337.11937530307;5337.665583604099;5385.81149659762;5039.193729003351;5067.226470735241;5216.669749213955;5239.711815850127;5311;4106.79466026699;4139.337705967046;4155.937660935088;4177.979110104453;4187.1625674865;4120.793960301988;4131.471355598433;4151.169766046788;4155.33514637658;4161.375793630949;3918.314294998378;3954.209158168378;4104.158647477275;4111.424400583921;4131.111810960643;4052.3921411788174;4068.5321188063454;4069.9389509157386;4098.6516146127615;4122.154958233555;3641.3809652358896;3661.121330880596;3675.889723308305;3685.0418891088243;3686.1153323202507;5044.545990860804;5074.594032477393;5078.949210507922;5092.643514953955;5133.897322053575;4680.578747912704;4683.8360657376825;4711.222648263032;4717.150912835723;4728.763561821929;5454.945450545483;5474.7810087596445;5486.149646804712;5492.011437941169;5496.477834605706;3909.1595307008847;3958.841646334143;3973.284808734427;3985.2826491231567;4007.3169268907127;5638.210650508932;5644.842807224509;5646.435356464321;5676;5677.602567820254;4043.73715708478;4061;4070.9389359159636;4107.609777071173;4119.546849846514;4026.134381108076;4118.835246590163;4126.958730412717;4172.958270417318;4175.415441838145;4552.863414097583;4574.885627859264;4666.899895047242;4667.13657973276;4676.321933319649;5388.949154914754;5430.647007944471;5451.155070964007;5456.645318054314;5469.808556700496;1297.9870201297865;1339.799030145486;1378.4072848675166;1409.1756322551216;1412.5197432872667;912.1744820937063;943.9292053096045;949.1884438804723;954.6610953111684;967.1585720423277;4539.273716205391;4768.499307572655;4782.426108866889;4790.658615587641;4816.217999340197;4984;4990.6506544541535;5009.7495125243595;5032.421271553745;5066.341375621146;4696.8590942271785;4701.882452938636;4751.216049351888;4757.405324334458;4763.856674398119;2686.516427043151;2705.0929094987987;2728.386113124571;2789.972100279012;3025.5915451414216;5822.592418530747;5823.592348535646;5895.054631971439;5899.882002359929;5899.911501327483;5805.82582522525;5845.09401042839;5857.506335884323;5857.736401861926;5865.706714664335;5616.185653080281;5953.315368732651;5958.731857066442;5970.537218381524;5981.790637327673;5741.25363702716;5752.6836024019085;5777.266819953913;5799.362070172362;5807.157962095388;5366.865828354323;5693.259876216065;5700.657960522382;5716.456936591017;5754.9136762947755;5946.910796338145;5949.8215053548465;5950;5975;6005.759769609167;4046.635802777764;4051.736637118578;4070.9796451017555;4080.591940805896;4101.666958238644;5226.71253081069;5553.750081246273;5604.271444712162;5705.400932902152;5829.883402331845;5509.914447909184;5517.69652669107;5534.972325138348;5567.359753628384;5572.77708891656;5510.8071217507195;5520.751566179451;5543.196236545759;5543.695096769555;5556.888862222652;5272.024675435056;5444.8366549003595;5452.59105567092;5457.290552228185;5468.589855760913;5523.143912693539;5526.309211348582;5583.7944012115795;5587.161925711176;5588.3573389060775;5243.868903277448;5465.207544906046;5467.316585426822;5467.4532546745;5489 07:34:48 INFO - PROCESS | 21650 | |5;yui.html;794.9085855126658;806.1857523900858;808.7573727881636;820.4420993724265;838.1157878438249;15563.844361556381;16544.751828722565;16900.746488802648;16910.492685219448;16959.57601059974;14139;14502;14583;14602.853971460283;14885.851141488582;808.1514409869628;820.7004443378154;822.383212590557;823.6869989404048;824.1511243419258;676.9559978601375;797.1789057270992;812.5896422306756;821.3142026407957;824.9670013199465;861.1990848510883;862.021605477781;863.5121156546562;864.6411739128254;864.887564616599;846.2510678049939;847.0386111763194;848.6266042941118;849.6176720475811;849.6516428264443;521.8695326168458;606.4208680709955;621.8756248750223;623.3330336539859;623.8315654773231;15532.844671553254;15534.766978495332;15595.1422671753;15615.453459128876;15652.669523090552;14191.858081419157;14688;14825.629359265997;15073;15108.169050702207;13296.867031329659;13340.33298335089;13408.597742067754;13545;13648.795268070988;4505.144022635689;4558.293464513005;4584.541545845389;4681.391419115527;4813.326134341195;70382;71970;72044.27955720428;72076.6396168021;72692.27307726908;11609.6517104487;11685.474153663106;11696.354021708783;11731.648050558497;12061.155719099579;22034;22106.668399974013;22119.889400552893;22146.567282071304;22154.667679984814;8567.143285671384;8752.737417877473;8760.299176065899;8843.867341989875;8902;4803.8318658847475;4818.86908971383;4877.707337559757;4922.606191504671;5011.423686276052;3444.3111377724554;3543.681068703829;3544.202554425285;3544.2734239480847;3550.094725844893;576.2969177603318;578.7453520450988;580.9070548712185;594.3521561497902;595.2975488923113;629.2040568680623;631.6020906828669;734.6840858430819;743.6950850151412;746.39054835947;9576.377535460311;10126;10173.389596624227;10227.181825453947;10234.948825255826;709.5919846088519;710.7299226293975;721.2679130682361;730.3098571849657;741.6032422653855;4576.359309696645;4695.577398034194;4783.928241076386;4796.856094317176;4958.776855041459;90512;108106.45946770374;110879;112898;114927.27609085871;83317.58341208377;93404;94511;94851;96248;83396;84865.57567212248;85443.57278213568;87266.56366718253;87413.99999999873;10115.39307641544;10526.578936842441;10528.263021588415;10548.367097974146;10549.578016879239;45980.54019459763;50833.491665082875;51025;51091.2336314963;52245;68957.31042689508;69528.65235673789;77676.2232377669;78146;80733.59633201796;11662.766744665229;11783.939445449607;11801.645950621494;13298.335083245993;14230.288485575473;13916.652083697989;15528.223588820289;15774.526764197093;15818.28817703183;15820.446284379992;13603.795943060664;14441.422343106578;14743.483978061146;14903.62740931442;15185.848141518443;13502.32488375597;14405.92797036008;14641.341139648954;14898.106113633217;14917.701645966803;14431.639209019439;14760.557183284518;15017.924910375377;15417.922910385376;15451.227438627799;11325.207235493766;11737.530498779954;11864.584739534075;11928.403579821148;12389.814152787896;10594.629187978384;11247.031411031792;11413.885861141282;12176.634700958986;12477.5008999639 07:34:48 INFO - PROCESS | 21650 | __end_tp_report 07:34:48 INFO - PROCESS | 21650 | __start_cc_report 07:34:48 INFO - PROCESS | 21650 | _x_x_mozilla_cycle_collect,840 07:34:48 INFO - PROCESS | 21650 | __end_cc_report 07:34:48 INFO - PROCESS | 21650 | __startTimestamp1465137288444__endTimestamp 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | ------- Summary: start ------- 07:34:48 INFO - PROCESS | 21650 | Number of tests: 6 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#0] dojo.html Cycles:165 Average:5476.41 Median:5720.69 stddev:650.04 (11.4%) stddev-sans-first:625.39 07:34:48 INFO - PROCESS | 21650 | Values: 3128.5 3150.2 3163.1 3197.5 3202.9 5273.2 5364.2 5456.8 5573.4 5596.7 5388.3 5403.6 5446.9 5471.3 5526.9 4860.1 4936.0 4944.1 4949.7 5181.1 5031.8 5053.1 5089.0 5116.2 5124.4 4812.8 4919.5 4985.6 5002.4 5005.8 4967.7 4983.3 4986.3 5066.1 5111.3 4993.3 5029.6 5039.5 5043.0 5080.2 5193.4 5345.5 5428.8 5498.6 5523.9 5948.0 5968.8 6014.2 6014.5 6025.1 5681.0 5881.3 5990.3 6050.3 6056.2 5466.2 5561.9 5583.5 5588.7 5588.8 6147.0 6183.8 6184.5 6185.3 6188.2 5601.7 5763.4 5852.0 5868.8 5900.2 6004.6 6006.1 6006.3 6045.2 6067.5 5961.7 5979.2 5979.8 5980.9 5986.6 5606.6 5797.4 5804.5 5807.8 5924.2 4415.4 4481.9 4487.3 4489.8 4520.4 3939.3 3987.0 3994.9 4001.4 4026.9 5346.8 5356.9 5487.1 5532.6 5533.0 5973.1 5986.5 6000.5 6005.2 6048.3 5504.8 5519.0 5569.2 5570.5 5585.6 4713.6 4796.4 4852.7 4863.9 4889.0 6056.4 6062.3 6062.5 6065.4 6068.1 5720.7 5878.9 5890.0 5890.1 5895.1 5980.5 6041.7 6065.7 6085.8 6108.2 5784.3 5803.0 5814.3 5817.6 5820.4 5618.9 5858.4 5895.1 5915.8 5921.4 5743.6 5807.5 5828.7 5848.7 5881.0 5816.1 5821.7 5830.2 5833.1 5835.9 5462.7 5632.0 5696.8 5751.1 5757.6 5908.3 5942.3 5951.9 5952.6 5954.0 5761.8 5766.8 5772.6 5774.0 5778.5 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#1] ext.html Cycles:180 Average:67382.18 Median:42437.26 stddev:139720.81 (329.2%) stddev-sans-first:140022.68 07:34:48 INFO - PROCESS | 21650 | Values: 558.6 601.9 611.2 618.0 619.3 33243.5 36155.6 36200.8 36228.8 42843.0 42241.6 43119.4 43139.6 43214.6 43238.0 8583.9 8813.9 8814.8 8825.7 8827.1 8629.8 8778.6 8779.0 8789.6 8791.0 8519.6 8527.4 8541.6 8548.1 8548.9 8656.8 8701.3 8707.4 8713.3 8745.1 8604.6 8658.6 8676.2 8718.3 8724.6 38852.4 39186.8 39248.6 39322.0 39348.0 3485.9 3640.8 3692.8 3983.7 4303.5 30384.7 32107.8 32145.2 32176.5 32230.0 4307.8 4315.7 4533.1 4635.6 4644.7 395407.0 397259.0 400419.0 400429.0 401396.0 61642.4 62053.0 62419.7 62454.7 62541.0 65379.7 65756.3 65843.3 66008.7 66037.7 17468.4 17696.3 17719.0 17731.3 17737.6 12956.4 12961.9 12965.9 12970.7 12976.2 18422.2 19382.0 19579.1 19580.7 19624.8 7186.8 7190.7 7253.9 7279.9 7446.5 1038.8 1112.9 1158.7 1169.2 1192.0 31937.4 32771.7 33032.2 33079.6 33490.2 1140.0 1141.3 1175.7 1176.2 1196.7 17132.2 17354.7 17357.1 17408.8 17424.8 607392.0 614184.0 618863.0 620854.0 621895.0 59408.4 59882.7 59952.4 59963.1 59977.4 1262.5 1293.6 1382.4 1388.7 1403.3 30511.2 32256.2 34104.3 34209.8 34358.8 52301.2 53269.0 53337.0 53338.7 53343.2 519571.0 538944.0 539167.0 539364.0 540005.0 37963.0 44017.6 44717.6 45424.8 48623.3 49187.8 49510.0 49591.8 50215.2 51003.5 40244.4 41178.4 41939.4 42761.1 43136.1 41144.6 41761.8 41810.2 42098.6 42228.2 40823.2 41986.6 42416.2 42458.4 42606.0 35417.0 37331.1 37927.8 38185.8 38279.9 28912.7 29026.8 29096.9 29172.0 29340.0 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#2] jquery.html Cycles:180 Average:25374.82 Median:2293.02 stddev:68267.85 (2977.2%) stddev-sans-first:68433.58 07:34:48 INFO - PROCESS | 21650 | Values: 385.0 391.3 392.9 395.4 409.6 14263.0 18064.7 19426.8 20112.1 20113.5 15815.7 18014.0 18825.9 18834.3 19120.8 5661.8 5810.6 5834.1 5843.2 5846.3 4137.6 5725.9 5782.4 6058.5 6434.7 6322.2 6341.2 6367.1 6387.9 6401.4 6228.5 6258.2 6374.2 6424.2 6424.9 5031.8 5520.0 5523.9 5526.3 5550.3 12604.7 12805.8 12809.6 12819.2 12821.4 2226.8 2259.6 2326.5 2445.4 2704.9 9424.6 9863.9 10116.8 10822.7 14808.8 1819.2 1841.7 1856.8 1857.4 1859.6 78857.6 81029.0 83066.6 84417.6 86044.0 10935.5 10967.2 10994.1 11221.4 11250.8 15527.6 15585.1 15799.5 15889.6 15903.8 8301.5 8383.8 8390.3 8585.0 8622.7 7100.1 8176.0 8231.2 8249.6 8342.5 4494.8 4545.2 4730.9 4866.8 4938.8 1855.1 1882.6 1916.8 1982.4 2034.6 874.3 980.2 1008.8 1010.9 1049.3 18348.6 19762.1 20056.8 20130.1 20488.0 991.6 995.2 1005.9 1032.8 1038.3 10966.9 11155.4 11228.3 11243.3 11277.2 162523.0 162804.2 459797.0 526080.0 539844.0 74768.0 90895.5 95189.0 95309.5 95528.5 1006.2 1009.7 1014.3 1020.4 1029.6 17494.0 17525.6 17790.9 17924.8 18150.4 39608.6 40643.8 40948.2 42517.4 42581.6 57806.1 58324.4 58333.0 58831.0 59363.7 8211.4 8278.2 8568.1 8606.1 8708.6 9110.6 12776.6 12919.3 13083.3 13563.3 11474.3 11485.1 11514.3 11652.7 11670.5 10835.9 11217.8 11386.7 11424.8 11701.8 11465.5 11502.7 11566.3 11629.3 12107.6 7946.9 8027.1 8043.6 8251.7 8443.7 8338.0 11412.5 11489.8 11494.9 11654.7 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#3] mootools.html Cycles:180 Average:5915.20 Median:4623.33 stddev:3431.59 (74.2%) stddev-sans-first:3423.87 07:34:48 INFO - PROCESS | 21650 | Values: 1323.7 1475.9 1509.0 1665.8 1833.9 8348.8 8629.7 8639.8 8910.7 8917.8 8612.3 8813.7 8819.9 8821.2 8821.8 2392.7 2417.2 2419.5 2421.6 2423.2 2402.8 2424.6 2476.1 2488.3 2493.2 2381.1 2397.6 2413.8 2414.8 2428.1 2316.9 2347.2 2353.1 2353.4 2394.3 2269.6 2315.8 2316.4 2320.6 2321.7 7530.3 7758.8 8875.7 8930.8 8939.9 4692.6 4801.9 4824.9 5234.3 5407.6 3196.8 3350.3 3395.2 3402.5 3526.1 1128.8 1136.1 1136.3 1149.2 1153.6 12086.0 12257.3 12290.4 12297.2 12303.8 4496.6 4607.9 4638.7 4730.1 4754.6 10236.4 10242.6 10256.3 10261.6 10264.8 5293.8 5293.9 5299.6 5305.9 5308.3 4816.1 4818.8 4907.0 4929.3 4947.6 3838.9 3971.9 3973.5 3982.4 4063.3 1247.2 1265.2 1271.2 1273.1 1275.8 908.5 976.2 976.6 1013.0 1015.3 5919.0 6056.1 6126.8 6146.7 6293.5 460.5 473.2 479.7 482.6 483.4 3859.8 3924.5 3955.2 3993.3 4055.0 11121.4 11462.7 11602.1 11610.5 11617.3 11305.8 11368.0 11412.5 11442.8 11454.3 7963.1 8210.4 8220.8 8258.2 8424.7 6014.9 6155.4 6169.7 6258.7 6333.9 10404.3 10564.9 10750.7 10760.6 10764.8 10788.3 11036.7 11062.2 11132.9 11161.3 8281.1 8303.7 8373.9 8384.5 8386.0 8830.1 8881.0 8919.6 8948.1 8985.9 7861.0 8002.0 8028.4 8033.5 8238.2 7962.9 7995.8 8024.8 8068.4 8072.4 7207.5 7325.3 7330.1 7335.8 7339.2 3892.6 5058.1 5263.8 5331.7 5366.5 5194.5 5403.8 5435.9 5453.9 5557.1 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#4] prototype.html Cycles:180 Average:4606.44 Median:5113.27 stddev:1363.93 (26.7%) stddev-sans-first:1329.32 07:34:48 INFO - PROCESS | 21650 | Values: 323.0 329.6 336.8 338.5 341.0 5309.4 5323.3 5337.1 5337.7 5385.8 5039.2 5067.2 5216.7 5239.7 5311.0 4106.8 4139.3 4155.9 4178.0 4187.2 4120.8 4131.5 4151.2 4155.3 4161.4 3918.3 3954.2 4104.2 4111.4 4131.1 4052.4 4068.5 4069.9 4098.7 4122.2 3641.4 3661.1 3675.9 3685.0 3686.1 5044.5 5074.6 5078.9 5092.6 5133.9 4680.6 4683.8 4711.2 4717.2 4728.8 5454.9 5474.8 5486.1 5492.0 5496.5 3909.2 3958.8 3973.3 3985.3 4007.3 5638.2 5644.8 5646.4 5676.0 5677.6 4043.7 4061.0 4070.9 4107.6 4119.5 4026.1 4118.8 4127.0 4173.0 4175.4 4552.9 4574.9 4666.9 4667.1 4676.3 5388.9 5430.6 5451.2 5456.6 5469.8 1298.0 1339.8 1378.4 1409.2 1412.5 912.2 943.9 949.2 954.7 967.2 4539.3 4768.5 4782.4 4790.7 4816.2 4984.0 4990.7 5009.7 5032.4 5066.3 4696.9 4701.9 4751.2 4757.4 4763.9 2686.5 2705.1 2728.4 2790.0 3025.6 5822.6 5823.6 5895.1 5899.9 5899.9 5805.8 5845.1 5857.5 5857.7 5865.7 5616.2 5953.3 5958.7 5970.5 5981.8 5741.3 5752.7 5777.3 5799.4 5807.2 5366.9 5693.3 5700.7 5716.5 5754.9 5946.9 5949.8 5950.0 5975.0 6005.8 4046.6 4051.7 4071.0 4080.6 4101.7 5226.7 5553.8 5604.3 5705.4 5829.9 5509.9 5517.7 5535.0 5567.4 5572.8 5510.8 5520.8 5543.2 5543.7 5556.9 5272.0 5444.8 5452.6 5457.3 5468.6 5523.1 5526.3 5583.8 5587.2 5588.4 5243.9 5465.2 5467.3 5467.5 5489.0 07:34:48 INFO - PROCESS | 21650 | 07:34:48 INFO - PROCESS | 21650 | [#5] yui.html Cycles:180 Average:20575.88 Median:4580.45 stddev:28503.36 (622.3%) stddev-sans-first:28544.62 07:34:48 INFO - PROCESS | 21650 | Values: 794.9 806.2 808.8 820.4 838.1 15563.8 16544.8 16900.7 16910.5 16959.6 14139.0 14502.0 14583.0 14602.9 14885.9 808.2 820.7 822.4 823.7 824.2 677.0 797.2 812.6 821.3 825.0 861.2 862.0 863.5 864.6 864.9 846.3 847.0 848.6 849.6 849.7 521.9 606.4 621.9 623.3 623.8 15532.8 15534.8 15595.1 15615.5 15652.7 14191.9 14688.0 14825.6 15073.0 15108.2 13296.9 13340.3 13408.6 13545.0 13648.8 4505.1 4558.3 4584.5 4681.4 4813.3 70382.0 71970.0 72044.3 72076.6 72692.3 11609.7 11685.5 11696.4 11731.6 12061.2 22034.0 22106.7 22119.9 22146.6 22154.7 8567.1 8752.7 8760.3 8843.9 8902.0 4803.8 4818.9 4877.7 4922.6 5011.4 3444.3 3543.7 3544.2 3544.3 3550.1 576.3 578.7 580.9 594.4 595.3 629.2 631.6 734.7 743.7 746.4 9576.4 10126.0 10173.4 10227.2 10234.9 709.6 710.7 721.3 730.3 741.6 4576.4 4695.6 4783.9 4796.9 4958.8 90512.0 108106.5 110879.0 112898.0 114927.3 83317.6 93404.0 94511.0 94851.0 96248.0 83396.0 84865.6 85443.6 87266.6 87414.0 10115.4 10526.6 10528.3 10548.4 10549.6 45980.5 50833.5 51025.0 51091.2 52245.0 68957.3 69528.7 77676.2 78146.0 80733.6 11662.8 11783.9 11801.6 13298.3 14230.3 13916.7 15528.2 15774.5 15818.3 15820.4 13603.8 14441.4 14743.5 14903.6 15185.8 13502.3 14405.9 14641.3 14898.1 14917.7 14431.6 14760.6 15017.9 15417.9 15451.2 11325.2 11737.5 11864.6 11928.4 12389.8 10594.6 11247.0 11413.9 12176.6 12477.5 07:34:48 INFO - PROCESS | 21650 | -------- Summary: end -------- 07:34:48 INFO - PROCESS | 21650 | 07:34:49 INFO - TEST-INFO | 21650: exit 0 07:34:49 INFO - TEST-OK | dromaeo_css | took 1113213ms 07:34:49 INFO - TEST-START | kraken 07:34:49 INFO - operating with platform_type : linux_ 07:34:49 INFO - Initialising browser for kraken test... 07:34:49 INFO - TEST-INFO | started process 21839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdyO_M2/profile http://localhost:47872/getInfo.html) 07:34:53 INFO - PROCESS | 21839 | __metrics Screen width/height:1600/1200 07:34:53 INFO - PROCESS | 21839 | colorDepth:24 07:34:53 INFO - PROCESS | 21839 | Browser inner width/height: 1024/697 07:34:53 INFO - PROCESS | 21839 | __metrics 07:34:54 ERROR - PROCESS | 21839 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:34:55 INFO - TEST-INFO | 21839: exit 0 07:34:55 INFO - Browser initialized. 07:34:55 INFO - Running cycle 1/1 for kraken test... 07:34:55 INFO - TEST-INFO | started process 21921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdyO_M2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:06 INFO - PROCESS | 21921 | RSS: Main: 156545024 07:35:06 INFO - PROCESS | 21921 | 07:35:09 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47872/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:10 INFO - PROCESS | 21921 | RSS: Main: 214269952 07:35:10 INFO - PROCESS | 21921 | 07:35:12 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47872/tests/kraken/driver.html?testName=audio-dft) 07:35:13 INFO - PROCESS | 21921 | RSS: Main: 202682368 07:35:13 INFO - PROCESS | 21921 | 07:35:16 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47872/tests/kraken/driver.html?testName=audio-fft) 07:35:17 INFO - PROCESS | 21921 | RSS: Main: 268795904 07:35:17 INFO - PROCESS | 21921 | 07:35:19 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47872/tests/kraken/driver.html?testName=audio-oscillator) 07:35:19 INFO - PROCESS | 21921 | RSS: Main: 179265536 07:35:19 INFO - PROCESS | 21921 | 07:35:22 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:22 INFO - PROCESS | 21921 | RSS: Main: 183341056 07:35:22 INFO - PROCESS | 21921 | 07:35:25 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47872/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:26 INFO - PROCESS | 21921 | RSS: Main: 218148864 07:35:26 INFO - PROCESS | 21921 | 07:35:29 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47872/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:30 INFO - PROCESS | 21921 | RSS: Main: 220090368 07:35:30 INFO - PROCESS | 21921 | 07:35:32 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47872/tests/kraken/driver.html?testName=json-parse-financial) 07:35:33 INFO - PROCESS | 21921 | RSS: Main: 220364800 07:35:33 INFO - PROCESS | 21921 | 07:35:35 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:35 INFO - PROCESS | 21921 | RSS: Main: 207917056 07:35:35 INFO - PROCESS | 21921 | 07:35:37 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:38 INFO - PROCESS | 21921 | RSS: Main: 211615744 07:35:38 INFO - PROCESS | 21921 | 07:35:40 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:40 INFO - PROCESS | 21921 | RSS: Main: 219549696 07:35:40 INFO - PROCESS | 21921 | 07:35:43 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:43 INFO - PROCESS | 21921 | RSS: Main: 223223808 07:35:43 INFO - PROCESS | 21921 | 07:35:46 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:47 INFO - PROCESS | 21921 | RSS: Main: 224481280 07:35:47 INFO - PROCESS | 21921 | 07:35:48 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:47872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47872/tests/kraken/driver.html?testName=ai-astar) 07:35:49 INFO - PROCESS | 21921 | RSS: Main: 266723328 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | __start_tp_report 07:35:49 INFO - PROCESS | 21921 | _x_x_mozilla_page_load 07:35:49 INFO - PROCESS | 21921 | _x_x_mozilla_page_load_details 07:35:49 INFO - PROCESS | 21921 | |i|pagename|runs| 07:35:49 INFO - PROCESS | 21921 | |0;ai-astar;112;109;110;113;112;110;113;112;109;112 07:35:49 INFO - PROCESS | 21921 | |1;audio-beat-detection;152;129;129;176;133;126;150;127;176;126 07:35:49 INFO - PROCESS | 21921 | |2;audio-dft;162;161;160;163;162;163;164;163;161;161 07:35:49 INFO - PROCESS | 21921 | |3;audio-fft;74;75;76;119;76;75;75;74;107;75 07:35:49 INFO - PROCESS | 21921 | |4;audio-oscillator;84;85;121;85;85;85;129;84;86;122 07:35:49 INFO - PROCESS | 21921 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;116;117 07:35:49 INFO - PROCESS | 21921 | |6;imaging-darkroom;145;146;145;146;146;145;146;146;145;146 07:35:49 INFO - PROCESS | 21921 | |7;imaging-desaturate;95;95;95;95;95;96;94;96;96;95 07:35:49 INFO - PROCESS | 21921 | |8;json-parse-financial;54;52;53;53;53;53;51;53;52;52 07:35:49 INFO - PROCESS | 21921 | |9;json-stringify-tinderbox;64;63;65;63;64;63;64;63;63;64 07:35:49 INFO - PROCESS | 21921 | |10;stanford-crypto-aes;78;81;79;79;86;80;80;81;111;80 07:35:49 INFO - PROCESS | 21921 | |11;stanford-crypto-ccm;137;123;130;119;122;122;130;126;148;127 07:35:49 INFO - PROCESS | 21921 | |12;stanford-crypto-pbkdf2;159;166;158;160;165;160;161;160;158;160 07:35:49 INFO - PROCESS | 21921 | |13;stanford-crypto-sha256-iterative;62;63;64;63;63;68;62;63;63;62 07:35:49 INFO - PROCESS | 21921 | __end_tp_report 07:35:49 INFO - PROCESS | 21921 | __start_cc_report 07:35:49 INFO - PROCESS | 21921 | _x_x_mozilla_cycle_collect,1657 07:35:49 INFO - PROCESS | 21921 | __end_cc_report 07:35:49 INFO - PROCESS | 21921 | __startTimestamp1465137349157__endTimestamp 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | ------- Summary: start ------- 07:35:49 INFO - PROCESS | 21921 | Number of tests: 14 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.55 (1.4%) stddev-sans-first:1.62 07:35:49 INFO - PROCESS | 21921 | Values: 112.0 109.0 110.0 113.0 112.0 110.0 113.0 112.0 109.0 112.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:141.50 stddev:20.08 (14.2%) stddev-sans-first:21.00 07:35:49 INFO - PROCESS | 21921 | Values: 152.0 129.0 129.0 176.0 133.0 126.0 150.0 127.0 176.0 126.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 07:35:49 INFO - PROCESS | 21921 | Values: 162.0 161.0 160.0 163.0 162.0 163.0 164.0 163.0 161.0 161.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.28 (21.7%) stddev-sans-first:16.97 07:35:49 INFO - PROCESS | 21921 | Values: 74.0 75.0 76.0 119.0 76.0 75.0 75.0 74.0 107.0 75.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:85.00 stddev:19.03 (22.4%) stddev-sans-first:19.63 07:35:49 INFO - PROCESS | 21921 | Values: 84.0 85.0 121.0 85.0 85.0 85.0 129.0 84.0 86.0 122.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:35:49 INFO - PROCESS | 21921 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:35:49 INFO - PROCESS | 21921 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:35:49 INFO - PROCESS | 21921 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 94.0 96.0 96.0 95.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.73 07:35:49 INFO - PROCESS | 21921 | Values: 54.0 52.0 53.0 53.0 53.0 53.0 51.0 53.0 52.0 52.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 07:35:49 INFO - PROCESS | 21921 | Values: 64.0 63.0 65.0 63.0 64.0 63.0 64.0 63.0 63.0 64.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:80.00 stddev:9.90 (12.4%) stddev-sans-first:10.30 07:35:49 INFO - PROCESS | 21921 | Values: 78.0 81.0 79.0 79.0 86.0 80.0 80.0 81.0 111.0 80.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:8.63 (6.7%) stddev-sans-first:8.57 07:35:49 INFO - PROCESS | 21921 | Values: 137.0 123.0 130.0 119.0 122.0 122.0 130.0 126.0 148.0 127.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.00 stddev:2.71 (1.7%) stddev-sans-first:2.80 07:35:49 INFO - PROCESS | 21921 | Values: 159.0 166.0 158.0 160.0 165.0 160.0 161.0 160.0 158.0 160.0 07:35:49 INFO - PROCESS | 21921 | 07:35:49 INFO - PROCESS | 21921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.77 (2.8%) stddev-sans-first:1.81 07:35:49 INFO - PROCESS | 21921 | Values: 62.0 63.0 64.0 63.0 63.0 68.0 62.0 63.0 63.0 62.0 07:35:49 INFO - PROCESS | 21921 | -------- Summary: end -------- 07:35:49 INFO - PROCESS | 21921 | 07:35:50 INFO - TEST-INFO | 21921: exit 0 07:35:50 INFO - TEST-OK | kraken | took 61003ms 07:35:50 INFO - SUITE-END | took 1174s 07:35:50 INFO - Completed test suite (00:19:34) 07:35:50 INFO - javascript benchmark 07:35:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3128.4681604127304, 3150.2439414540518, 3163.1143279881626, 3197.456432406491, 3202.887898923537, 5273.18265668821, 5364.168553874146, 5456.781728730851, 5573.414791446896, 5596.692181929992, 5388.326459192601, 5403.621746477748, 5446.863828404292, 5471.316085489314, 5526.917096243559, 4860.125177468063, 4935.975320123394, 4944.085344211315, 4949.678270912397, 5181.145111056671, 5031.84904452867, 5053.065182941149, 5089.0, 5116.232565115244, 5124.385073791151, 4812.783424745895, 4919.532644398776, 4985.5513003829465, 5002.424721157077, 5005.849824505271, 4967.677100988461, 4983.277424773388, 4986.301917731521, 5066.06277838601, 5111.335526381584, 4993.275974983607, 5029.597632189416, 5039.521245481674, 5043.0, 5080.187170052811, 5193.37679478465, 5345.492178243061, 5428.782848686048, 5498.560115190775, 5523.917141242885, 5948.0, 5968.7910923117915, 6014.1580178775, 6014.518838492954, 6025.126356678257, 5680.971595141998, 5881.264841894763, 5990.341062483123, 6050.304215015286, 6056.242969628796, 5466.234727138204, 5561.860953476155, 5583.469570390806, 5588.6646801191655, 5588.804391846266, 6147.0, 6183.81448556544, 6184.5052395808225, 6185.257769067651, 6188.226471691039, 5601.663900166003, 5763.394843541451, 5852.0, 5868.794592189253, 5900.203472531153, 6004.609700369462, 6006.069059295816, 6006.279246490361, 6045.153678485016, 6067.544934129958, 5961.672108034013, 5979.222701048923, 5979.790707325223, 5980.850478738066, 5986.580939334205, 5606.55147588192, 5797.391273916178, 5804.506616937608, 5807.82576522705, 5924.20023296858, 4415.359772832921, 4481.910361792746, 4487.282034874404, 4489.842855500107, 4520.389747384127, 3939.2712348215673, 3986.980065099714, 3994.8601798936897, 4001.394561211241, 4026.939595906064, 5346.823698786261, 5356.866078348073, 5487.122060470386, 5532.640378375393, 5533.0, 5973.133895585116, 5986.491148252448, 6000.549958753024, 6005.249343832021, 6048.334683184846, 5504.779808807683, 5518.972405138029, 5569.248151499577, 5570.470805273492, 5585.553155747531, 4713.622910167179, 4796.400449943757, 4852.684575502581, 4863.927041094386, 4889.046635906036, 6056.364081771439, 6062.272527296753, 6062.484688801413, 6065.423784740443, 6068.120122582289, 5720.6853623049465, 5878.853028674317, 5889.970550147222, 5890.1164825276555, 5895.145203945318, 5980.491658208927, 6041.667708276087, 6065.72704228302, 6085.817425477243, 6108.17539632144, 5784.305883294031, 5802.970985145047, 5814.331351894586, 5817.563682723728, 5820.388859169896, 5618.88762224745, 5858.443447872445, 5895.086261629454, 5915.822525324247, 5921.3782552831335, 5743.62666426681, 5807.535397168301, 5828.708564571839, 5848.678322692293, 5881.0, 5816.098504731774, 5821.679807610452, 5830.2420685310635, 5833.095870140135, 5835.94164058354, 5462.672239665632, 5631.971840140773, 5696.8006119785605, 5751.137329400456, 5757.625754325955, 5908.320543137423, 5942.346341902474, 5951.940480595139, 5952.642841429528, 5953.970230148995, 5761.769529218952, 5766.826995190151, 5772.624779389326, 5774.04728219839, 5778.537716982715], "value": 5431.040990618373, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6340946679924, 601.8615718384772, 611.1932249430752, 617.9752809887605, 619.2692622705206, 33243.50134747981, 36155.63844361556, 36200.818995905014, 36228.818855905716, 42843.0, 42241.57758422415, 43119.353209701876, 43139.56860431395, 43214.567854321525, 43238.0, 8583.87124193136, 8813.867791983093, 8814.779630509256, 8825.691100811473, 8827.117288271185, 8629.784255393633, 8778.56107194641, 8778.956105219466, 8789.64841406343, 8790.956045219766, 8519.616617252239, 8527.44571602847, 8541.572921353938, 8548.059713431518, 8548.914510854875, 8656.826863462727, 8701.347398945041, 8707.390482666216, 8713.259372953307, 8745.125487451267, 8604.612792424356, 8658.567071646456, 8676.175763302539, 8718.34612404066, 8724.607392667345, 38852.41721374181, 39186.80406597977, 39248.60751392507, 39322.0, 39348.0, 3485.8777261351256, 3640.799756013418, 3692.7968961707097, 3983.661388781928, 4303.483581970152, 30384.696153038407, 32107.83946080278, 32145.1963700907, 32176.517352239734, 32230.0, 4307.8492252771, 4315.697901146921, 4533.138703646297, 4635.582797548203, 4644.744539050351, 395406.99999999715, 397259.0, 400419.0, 400429.0, 401396.0, 61642.383576163666, 62053.0, 62419.6879015602, 62454.687726561075, 62541.0, 65379.67310163419, 65756.34243657599, 65843.34156658468, 66008.66995665088, 66037.66981165159, 17468.388606398716, 17696.29214831392, 17719.025453600178, 17731.29074836992, 17737.556561086076, 12956.352182390843, 12961.935190323988, 12965.935170324088, 12970.740585188243, 12976.15654982423, 18422.184847655306, 19382.040521770792, 19579.11986889974, 19580.70628940567, 19624.803751962583, 7186.8203294917, 7190.7483238086415, 7253.927460725326, 7279.927200728031, 7446.478746487694, 1038.771470276538, 1112.8831472695413, 1158.7045303447567, 1169.181572898974, 1192.022541515966, 31937.361252774816, 32771.67228327734, 33032.174195645304, 33079.60199004975, 33490.16274593106, 1139.9715007124723, 1141.2823700330948, 1175.6884425627215, 1176.1590462819127, 1196.730735584504, 17132.229049692545, 17354.652906941792, 17357.13214339278, 17408.82591174072, 17424.82575174232, 607392.0, 614184.0, 618863.0, 620854.0, 621895.0, 59408.40591594029, 59882.70058649766, 59952.40047599556, 59963.100553491735, 59977.400225998055, 1262.50762202741, 1293.618382577142, 1382.4124746982693, 1388.7361401333715, 1403.3404299978993, 30511.237219069702, 32256.193595160308, 34104.31791364109, 34209.82895085509, 34358.82820585881, 52301.215481768566, 53269.0, 53337.0, 53338.73330633322, 53343.199852003025, 519571.0, 538944.0, 539167.0, 539364.0, 540005.0, 37963.0, 44017.559824401345, 44717.55282447134, 45424.77287613541, 48623.27065094097, 49187.75406122946, 49510.0, 49591.75204123956, 50215.24677129919, 51003.48996509987, 40244.3963340556, 41178.38232426456, 41939.37090943699, 42761.14477710366, 43136.13727725491, 41144.588554114074, 41761.79119104385, 41810.163796724504, 42098.57901420946, 42228.155436890476, 40823.18353632851, 41986.58013419949, 42416.1516769669, 42458.363124553776, 42606.0, 35417.0, 37331.06672333214, 37927.81036094802, 38185.80907095447, 38279.92586058208, 28912.710872891003, 29026.830603813538, 29096.854515727286, 29172.0, 29340.0], "value": 20894.89852581831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.97112716546246, 391.27223364541953, 392.92341952245454, 395.4463750748951, 409.58836369448716, 14263.0, 18064.729029064576, 19426.805731942677, 20112.094955726992, 20113.497162570926, 15815.683686326267, 18014.0, 18825.90587047063, 18834.34079807207, 19120.808791912077, 5661.773529058843, 5810.622309549865, 5834.066549352105, 5843.152742852284, 5846.298444186704, 4137.627613514783, 5725.885482290351, 5782.3639399666, 6058.485028772559, 6434.7104380303, 6322.209723784527, 6341.239051313849, 6367.076773867786, 6387.93612063878, 6401.391867772554, 6228.5017198624, 6258.186435763344, 6374.203224596926, 6424.229092508882, 6424.871502569946, 5031.84904452867, 5519.972400138014, 5523.889522209573, 5526.336839579236, 5550.27846379972, 12604.68488287791, 12805.80791288122, 12809.551665691655, 12819.16675416095, 12821.358932053454, 2226.7773222677765, 2259.570681570496, 2326.4649130700036, 2445.437549363656, 2704.878280477383, 9424.575894084783, 9863.852042219372, 10116.797664046679, 10822.67531974042, 14808.777868331983, 1819.217736373359, 1841.6777064013877, 1856.795752467241, 1857.3963461874944, 1859.6466671332403, 78857.60571197107, 81029.0, 83066.58466707688, 84417.57791211066, 86044.0, 10935.453227338601, 10967.232293739362, 10994.120470362352, 11221.438928053565, 11250.774984500264, 15527.611809704847, 15585.06489610627, 15799.526014219591, 15889.602759930864, 15903.840961590467, 8301.543415112226, 8383.8323233535, 8390.28682561989, 8584.957075214585, 8622.698205562776, 7100.076989991371, 8176.0, 8231.176882311722, 8249.628766705513, 8342.541160236124, 4494.797734101973, 4545.159145558082, 4730.905381892343, 4866.78099485524, 4938.827141050046, 1855.1188185611727, 1882.6234753049446, 1916.7795703493998, 1982.4250967219634, 2034.6032523657746, 874.2568816506047, 980.152168374351, 1008.7528555503949, 1010.888802231754, 1049.338916482611, 18348.63302733938, 19762.11070501831, 20056.799432005493, 20130.094145763476, 20488.0, 991.5984026469291, 995.1938929467154, 1005.9209903839999, 1032.8347464405658, 1038.314712289885, 10966.890331096587, 11155.386453744959, 11228.27329118159, 11243.313502974619, 11277.154213434025, 162523.0, 162804.18597906936, 459797.0, 526080.0, 539844.0, 74768.0, 90895.54552227329, 95189.0, 95309.52345238229, 95528.52235738777, 1006.2101250518308, 1009.6769033909226, 1014.2899970021015, 1020.4081632653043, 1029.5933106422922, 17494.0, 17525.649487010443, 17790.91104544469, 17924.820751792315, 18150.364737234133, 39608.60391396049, 40643.7967810159, 40948.181036379705, 42517.362239567046, 42581.574184259, 57806.132908007254, 58324.416755831895, 58333.0, 58831.0, 59363.70318148382, 8211.384146189179, 8278.172182781915, 8568.057513673615, 8606.096359882122, 8708.56457177126, 9110.590023448829, 12776.552820651232, 12919.289439080942, 13083.345832708135, 13563.254021028939, 11474.25417347903, 11485.138614603771, 11514.251573647685, 11652.708682283012, 11670.533178672758, 10835.945820270848, 11217.775644486901, 11386.658400248005, 11424.82862757076, 11701.76596468083, 11465.541378344773, 11502.654920352403, 11566.30602163873, 11629.302241865515, 12107.576234831738, 7946.8807967879375, 8027.076886157933, 8043.557604331584, 8251.669933202606, 8443.704470343508, 8338.0, 11412.48643811014, 11489.770204596029, 11494.942525287655, 11654.70863228426], "value": 9012.542961430205, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.708784067505, 1475.926203689816, 1508.992455037725, 1665.775120358751, 1833.9174737136827, 8348.79128021799, 8629.654813807449, 8639.827203455927, 8910.688125915594, 8917.777055573613, 8612.267957223628, 8813.691520796774, 8819.867701984474, 8821.19165571058, 8821.779455513599, 2392.712874455068, 2417.190241269177, 2419.5160967806423, 2421.6367544868235, 2423.1761201191593, 2402.8197885158597, 2424.599941009731, 2476.1209770531473, 2488.278399264211, 2493.1772515069983, 2381.130887226159, 2397.6043952747777, 2413.81896357773, 2414.843035202715, 2428.0530593068715, 2316.93049208524, 2347.201951336554, 2353.082297903819, 2353.4351755578623, 2394.2697477269426, 2269.5574362999223, 2315.780000899912, 2316.420894776306, 2320.640300753386, 2321.651752237161, 7530.322270995582, 7758.806029849243, 8875.73372798817, 8930.821383572356, 8939.910600893973, 4692.601128904047, 4801.903961920742, 4824.927626085611, 5234.26720259164, 5407.594430417695, 3196.7602429817625, 3350.3299340131825, 3395.1681837949614, 3402.5406570113214, 3526.1008442847165, 1128.7798879218556, 1136.1308598921833, 1136.2614300704527, 1149.1725957310723, 1153.6077733570626, 12086.0, 12257.325847078408, 12290.385480726018, 12297.200681955645, 12303.815442768366, 4496.6177874881005, 4607.9308810367875, 4638.721676699409, 4730.148573256778, 4754.573627911613, 10236.436995965145, 10242.590296388062, 10256.282060255711, 10261.589536418609, 10264.846027309597, 5293.814716484904, 5293.920591191135, 5299.6290259681455, 5305.920411193835, 5308.336457942757, 4816.133096042746, 4818.7831547580445, 4907.043126590352, 4929.309896614477, 4947.579455746302, 3838.9424158637644, 3971.900702482403, 3973.4834471518516, 3982.4424580558743, 4063.329550624173, 1247.2017908538542, 1265.1649911058657, 1271.211848653822, 1273.0579371265196, 1275.8262398593317, 908.5094049213351, 976.1897624971257, 976.5751897924425, 1012.9696109116738, 1015.2842246216547, 5918.970405147947, 6056.121862330026, 6126.785562505291, 6146.661933593606, 6293.465055470337, 460.4635599526581, 473.2121018504152, 479.6690283704233, 482.63078744760287, 483.41023950779993, 3859.7877116758846, 3924.4898163238595, 3955.248502784462, 3993.281209382281, 4055.0065234017857, 11121.443927803577, 11462.713432164095, 11602.129840262014, 11610.535578576762, 11617.302961822317, 11305.773884522263, 11367.976882080653, 11412.543498259976, 11442.771144577062, 11454.255473394203, 7963.124056353797, 8210.384221183316, 8220.753377398687, 8258.174182581814, 8424.663013479514, 6014.939850601438, 6155.384461553809, 6169.6915154241215, 6258.718357674006, 6333.904991425225, 10404.323718958243, 10564.947175264075, 10750.677479675622, 10760.623378181726, 10764.784704306026, 10788.29876058085, 11036.668899933014, 11062.225644205151, 11132.88867111351, 11161.330320180816, 8281.130481299619, 8303.709370172015, 8373.874391884005, 8384.53885036329, 8386.0, 8830.116988301375, 8881.0, 8919.643214271617, 8948.060453652533, 8985.865212021956, 7861.0, 8002.03975522941, 8028.43800933929, 8033.477823941425, 8238.176182381714, 7962.920370796218, 7995.800104997422, 8024.759257222293, 8068.394870384627, 8072.4349295548745, 7207.459440542085, 7325.304096110861, 7330.120385553554, 7335.816604584928, 7339.1926888043345, 3892.552356479041, 5058.131132672578, 5263.814643447209, 5331.653442526223, 5366.543843773323, 5194.53249207558, 5403.8108666196495, 5435.918461223006, 5453.863653408696, 5557.055300598989], "value": 4634.143614672648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.9854656540455, 329.6308134888924, 336.8029702623965, 338.48550203690394, 340.97613167078316, 5309.398394786551, 5323.307969963904, 5337.11937530307, 5337.665583604099, 5385.81149659762, 5039.193729003351, 5067.226470735241, 5216.669749213955, 5239.711815850127, 5311.0, 4106.79466026699, 4139.337705967046, 4155.937660935088, 4177.979110104453, 4187.1625674865, 4120.793960301988, 4131.471355598433, 4151.169766046788, 4155.33514637658, 4161.375793630949, 3918.314294998378, 3954.209158168378, 4104.158647477275, 4111.424400583921, 4131.111810960643, 4052.3921411788174, 4068.5321188063454, 4069.9389509157386, 4098.6516146127615, 4122.154958233555, 3641.3809652358896, 3661.121330880596, 3675.889723308305, 3685.0418891088243, 3686.1153323202507, 5044.545990860804, 5074.594032477393, 5078.949210507922, 5092.643514953955, 5133.897322053575, 4680.578747912704, 4683.8360657376825, 4711.222648263032, 4717.150912835723, 4728.763561821929, 5454.945450545483, 5474.7810087596445, 5486.149646804712, 5492.011437941169, 5496.477834605706, 3909.1595307008847, 3958.841646334143, 3973.284808734427, 3985.2826491231567, 4007.3169268907127, 5638.210650508932, 5644.842807224509, 5646.435356464321, 5676.0, 5677.602567820254, 4043.73715708478, 4061.0, 4070.9389359159636, 4107.609777071173, 4119.546849846514, 4026.134381108076, 4118.835246590163, 4126.958730412717, 4172.958270417318, 4175.415441838145, 4552.863414097583, 4574.885627859264, 4666.899895047242, 4667.13657973276, 4676.321933319649, 5388.949154914754, 5430.647007944471, 5451.155070964007, 5456.645318054314, 5469.808556700496, 1297.9870201297865, 1339.799030145486, 1378.4072848675166, 1409.1756322551216, 1412.5197432872667, 912.1744820937063, 943.9292053096045, 949.1884438804723, 954.6610953111684, 967.1585720423277, 4539.273716205391, 4768.499307572655, 4782.426108866889, 4790.658615587641, 4816.217999340197, 4984.0, 4990.6506544541535, 5009.7495125243595, 5032.421271553745, 5066.341375621146, 4696.8590942271785, 4701.882452938636, 4751.216049351888, 4757.405324334458, 4763.856674398119, 2686.516427043151, 2705.0929094987987, 2728.386113124571, 2789.972100279012, 3025.5915451414216, 5822.592418530747, 5823.592348535646, 5895.054631971439, 5899.882002359929, 5899.911501327483, 5805.82582522525, 5845.09401042839, 5857.506335884323, 5857.736401861926, 5865.706714664335, 5616.185653080281, 5953.315368732651, 5958.731857066442, 5970.537218381524, 5981.790637327673, 5741.25363702716, 5752.6836024019085, 5777.266819953913, 5799.362070172362, 5807.157962095388, 5366.865828354323, 5693.259876216065, 5700.657960522382, 5716.456936591017, 5754.9136762947755, 5946.910796338145, 5949.8215053548465, 5950.0, 5975.0, 6005.759769609167, 4046.635802777764, 4051.736637118578, 4070.9796451017555, 4080.591940805896, 4101.666958238644, 5226.71253081069, 5553.750081246273, 5604.271444712162, 5705.400932902152, 5829.883402331845, 5509.914447909184, 5517.69652669107, 5534.972325138348, 5567.359753628384, 5572.77708891656, 5510.8071217507195, 5520.751566179451, 5543.196236545759, 5543.695096769555, 5556.888862222652, 5272.024675435056, 5444.8366549003595, 5452.59105567092, 5457.290552228185, 5468.589855760913, 5523.143912693539, 5526.309211348582, 5583.7944012115795, 5587.161925711176, 5588.3573389060775, 5243.868903277448, 5465.207544906046, 5467.316585426822, 5467.4532546745, 5489.0], "value": 4173.995285780555, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9085855126658, 806.1857523900858, 808.7573727881636, 820.4420993724265, 838.1157878438249, 15563.844361556381, 16544.751828722565, 16900.746488802648, 16910.492685219448, 16959.57601059974, 14139.0, 14502.0, 14583.0, 14602.853971460283, 14885.851141488582, 808.1514409869628, 820.7004443378154, 822.383212590557, 823.6869989404048, 824.1511243419258, 676.9559978601375, 797.1789057270992, 812.5896422306756, 821.3142026407957, 824.9670013199465, 861.1990848510883, 862.021605477781, 863.5121156546562, 864.6411739128254, 864.887564616599, 846.2510678049939, 847.0386111763194, 848.6266042941118, 849.6176720475811, 849.6516428264443, 521.8695326168458, 606.4208680709955, 621.8756248750223, 623.3330336539859, 623.8315654773231, 15532.844671553254, 15534.766978495332, 15595.1422671753, 15615.453459128876, 15652.669523090552, 14191.858081419157, 14688.0, 14825.629359265997, 15073.0, 15108.169050702207, 13296.867031329659, 13340.33298335089, 13408.597742067754, 13545.0, 13648.795268070988, 4505.144022635689, 4558.293464513005, 4584.541545845389, 4681.391419115527, 4813.326134341195, 70382.0, 71970.0, 72044.27955720428, 72076.6396168021, 72692.27307726908, 11609.6517104487, 11685.474153663106, 11696.354021708783, 11731.648050558497, 12061.155719099579, 22034.0, 22106.668399974013, 22119.889400552893, 22146.567282071304, 22154.667679984814, 8567.143285671384, 8752.737417877473, 8760.299176065899, 8843.867341989875, 8902.0, 4803.8318658847475, 4818.86908971383, 4877.707337559757, 4922.606191504671, 5011.423686276052, 3444.3111377724554, 3543.681068703829, 3544.202554425285, 3544.2734239480847, 3550.094725844893, 576.2969177603318, 578.7453520450988, 580.9070548712185, 594.3521561497902, 595.2975488923113, 629.2040568680623, 631.6020906828669, 734.6840858430819, 743.6950850151412, 746.39054835947, 9576.377535460311, 10126.0, 10173.389596624227, 10227.181825453947, 10234.948825255826, 709.5919846088519, 710.7299226293975, 721.2679130682361, 730.3098571849657, 741.6032422653855, 4576.359309696645, 4695.577398034194, 4783.928241076386, 4796.856094317176, 4958.776855041459, 90512.0, 108106.45946770374, 110879.0, 112898.0, 114927.27609085871, 83317.58341208377, 93404.0, 94511.0, 94851.0, 96248.0, 83396.0, 84865.57567212248, 85443.57278213568, 87266.56366718253, 87413.99999999873, 10115.39307641544, 10526.578936842441, 10528.263021588415, 10548.367097974146, 10549.578016879239, 45980.54019459763, 50833.491665082875, 51025.0, 51091.2336314963, 52245.0, 68957.31042689508, 69528.65235673789, 77676.2232377669, 78146.0, 80733.59633201796, 11662.766744665229, 11783.939445449607, 11801.645950621494, 13298.335083245993, 14230.288485575473, 13916.652083697989, 15528.223588820289, 15774.526764197093, 15818.28817703183, 15820.446284379992, 13603.795943060664, 14441.422343106578, 14743.483978061146, 14903.62740931442, 15185.848141518443, 13502.32488375597, 14405.92797036008, 14641.341139648954, 14898.106113633217, 14917.701645966803, 14431.639209019439, 14760.557183284518, 15017.924910375377, 15417.922910385376, 15451.227438627799, 11325.207235493766, 11737.530498779954, 11864.584739534075, 11928.403579821148, 12389.814152787896, 10594.629187978384, 11247.031411031792, 11413.885861141282, 12176.634700958986, 12477.5008999639], "value": 7720.348100581057, "unit": "score"}], "name": "dromaeo_css", "value": 7311.322263888312, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 110.0, 113.0, 112.0, 110.0, 113.0, 112.0, 109.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 129.0, 129.0, 176.0, 133.0, 126.0, 150.0, 127.0, 176.0, 126.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 163.0, 162.0, 163.0, 164.0, 163.0, 161.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 119.0, 76.0, 75.0, 75.0, 74.0, 107.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 85.0, 85.0, 85.0, 129.0, 84.0, 86.0, 122.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 53.0, 53.0, 53.0, 51.0, 53.0, 52.0, 52.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 79.0, 79.0, 86.0, 80.0, 80.0, 81.0, 111.0, 80.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 123.0, 130.0, 119.0, 122.0, 122.0, 130.0, 126.0, 148.0, 127.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 166.0, 158.0, 160.0, 165.0, 160.0, 161.0, 160.0, 158.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 63.0, 63.0, 68.0, 62.0, 63.0, 63.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1504.4000000000003, "alertThreshold": 2.0}]} 07:35:50 INFO - Return code: 0 07:35:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:50 ERROR - # TBPL SUCCESS # 07:35:50 INFO - Running post-action listener: _resource_record_post_action 07:35:50 INFO - ##### 07:35:50 INFO - ##### Finished run-tests step (success) 07:35:50 INFO - ##### 07:35:50 INFO - Running post-run listener: _resource_record_post_run 07:35:50 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 5767168; Write bytes: 560201728; Read time: 3108; Write time: 438352 07:35:50 INFO - TinderboxPrint: CPU usage
13.2% 07:35:50 INFO - TinderboxPrint: I/O read bytes / time
5,767,168 / 3,108 07:35:50 INFO - TinderboxPrint: I/O write bytes / time
560,201,728 / 438,352 07:35:50 INFO - TinderboxPrint: CPU idle
8,259.2 (86.8%) 07:35:50 INFO - TinderboxPrint: CPU user
1,208.7 (12.7%) 07:35:50 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247746560; Read time: 0; Write time: 258264 07:35:50 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5767168; Write bytes: 294543360; Read time: 3108; Write time: 175256 07:35:51 INFO - Running post-run listener: _upload_blobber_files 07:35:51 INFO - Blob upload gear active. 07:35:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:51 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 07:35:51 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:51 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:51 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:52 INFO - (blobuploader) - INFO - Done attempting. 07:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:53 INFO - (blobuploader) - INFO - Done attempting. 07:35:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:57 INFO - (blobuploader) - INFO - Done attempting. 07:35:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:57 INFO - Return code: 0 07:35:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84bc9107efe4bb2a91528c533e4990341b758ee0c6f00997ccfc04f175f60b7a643a1183bacf670b74b6ba20ed8810a52d02e184a803e118088d49d450418de5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545db965a9b4a984008a38dad1c9608b1bbbf8284fdb0af8a3329fe8bf9a0ef85939162fe0259146f8065cd720d3ab0b90a3dff982d06a64bdbcb35674a94142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/413b716ad1bbf54567f0d6aa30c113e5df375522abc6b90fd3b988ea43bfb0abcb746d87a6a1bac186f7f2615b82201b0e9f884e56f9c322c2e8faf8c59bdc09"} 07:35:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:57 INFO - Contents: 07:35:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84bc9107efe4bb2a91528c533e4990341b758ee0c6f00997ccfc04f175f60b7a643a1183bacf670b74b6ba20ed8810a52d02e184a803e118088d49d450418de5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545db965a9b4a984008a38dad1c9608b1bbbf8284fdb0af8a3329fe8bf9a0ef85939162fe0259146f8065cd720d3ab0b90a3dff982d06a64bdbcb35674a94142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/413b716ad1bbf54567f0d6aa30c113e5df375522abc6b90fd3b988ea43bfb0abcb746d87a6a1bac186f7f2615b82201b0e9f884e56f9c322c2e8faf8c59bdc09"} 07:35:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:57 INFO - Copying logs to upload dir... 07:35:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.027848 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-05 07:35:56.758097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 07:35:56.761985) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84bc9107efe4bb2a91528c533e4990341b758ee0c6f00997ccfc04f175f60b7a643a1183bacf670b74b6ba20ed8810a52d02e184a803e118088d49d450418de5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545db965a9b4a984008a38dad1c9608b1bbbf8284fdb0af8a3329fe8bf9a0ef85939162fe0259146f8065cd720d3ab0b90a3dff982d06a64bdbcb35674a94142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/413b716ad1bbf54567f0d6aa30c113e5df375522abc6b90fd3b988ea43bfb0abcb746d87a6a1bac186f7f2615b82201b0e9f884e56f9c322c2e8faf8c59bdc09"} build_url:https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/c_4Bq5wGSZiNsISFu9Jsdg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/84bc9107efe4bb2a91528c533e4990341b758ee0c6f00997ccfc04f175f60b7a643a1183bacf670b74b6ba20ed8810a52d02e184a803e118088d49d450418de5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/545db965a9b4a984008a38dad1c9608b1bbbf8284fdb0af8a3329fe8bf9a0ef85939162fe0259146f8065cd720d3ab0b90a3dff982d06a64bdbcb35674a94142", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/413b716ad1bbf54567f0d6aa30c113e5df375522abc6b90fd3b988ea43bfb0abcb746d87a6a1bac186f7f2615b82201b0e9f884e56f9c322c2e8faf8c59bdc09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 07:35:56.787383) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:35:56.787724) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465125893.968198-295976915 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:35:56.870434) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 07:35:56.870807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 07:35:56.871139) ========= ========= Total master_lag: 0.18 =========