builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1465135578.01 results: success (0) buildid: 20160605043005 builduid: fbda51f85e554f00bc7eed972d025b06 revision: b9213f375a3fa9570893c23eef9ef4be4cc83226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.010567) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.010943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.011238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.056531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.056815) ========= 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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 07:06: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% 42.8M=0s 2016-06-05 07:06:18 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084673 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.155910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.156212) ========= 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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022105 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.205909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.206245) ========= 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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 07:06:18,679 truncating revision to first 12 chars 2016-06-05 07:06:18,679 Setting DEBUG logging. 2016-06-05 07:06:18,679 attempt 1/10 2016-06-05 07:06:18,679 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:06:18,999 unpacking tar archive at: mozilla-inbound-b9213f375a3f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.898069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.898347) ========= script_repo_revision: b9213f375a3fa9570893c23eef9ef4be4cc83226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.898759) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.899048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 07:06:18.914971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-05 07:06:18.915304) ========= /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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:06:19 INFO - MultiFileLogger online at 20160605 07:06:19 in /builds/slave/test 07:06: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:06:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:06:19 INFO - {'append_to_log': False, 07:06:19 INFO - 'base_work_dir': '/builds/slave/test', 07:06:19 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:06:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:06:19 INFO - 'branch': 'Mozilla-Inbound', 07:06:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:06:19 INFO - 'config_files': ('talos/linux_config.py',), 07:06:19 INFO - 'default_actions': ('clobber', 07:06:19 INFO - 'read-buildbot-config', 07:06:19 INFO - 'download-and-extract', 07:06:19 INFO - 'populate-webroot', 07:06:19 INFO - 'create-virtualenv', 07:06:19 INFO - 'install', 07:06:19 INFO - 'run-tests'), 07:06:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:06:19 INFO - 'download_minidump_stackwalk': True, 07:06:19 INFO - 'download_symbols': 'ondemand', 07:06:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:06:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:06:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:06:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:06:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:06:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:06:19 INFO - 'installer_path': 'installer.exe', 07:06:19 INFO - 'log_level': 'info', 07:06:19 INFO - 'log_name': 'talos', 07:06:19 INFO - 'log_to_console': True, 07:06:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:06:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:06:19 INFO - 'opt_config_files': (), 07:06:19 INFO - 'pip_index': False, 07:06:19 INFO - 'sps_profile': False, 07:06:19 INFO - 'sps_profile_interval': 0, 07:06:19 INFO - 'suite': 'dromaeojs', 07:06:19 INFO - 'system_bits': '32', 07:06:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:06:19 INFO - 'title': 'talos-linux64-ix-035', 07:06:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:06:19 INFO - 'use_talos_json': True, 07:06:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:06:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:06:19 INFO - 'work_dir': 'build'} 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running clobber step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: clobber 07:06:19 INFO - rmtree: /builds/slave/test/build 07:06:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:06:19 INFO - Running post-action listener: _resource_record_post_action 07:06:19 INFO - ##### 07:06:19 INFO - ##### Finished clobber step (success) 07:06:19 INFO - ##### 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running read-buildbot-config step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: read_buildbot_config 07:06:19 INFO - Using buildbot properties: 07:06:19 INFO - { 07:06:19 INFO - "project": "", 07:06:19 INFO - "product": "firefox", 07:06:19 INFO - "script_repo_revision": "production", 07:06:19 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:06:19 INFO - "repository": "", 07:06:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:06:19 INFO - "buildid": "20160605043005", 07:06:19 INFO - "pgo_build": "True", 07:06:19 INFO - "basedir": "/builds/slave/test", 07:06:19 INFO - "buildnumber": 1051, 07:06:19 INFO - "slavename": "talos-linux64-ix-035", 07:06:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:06:19 INFO - "platform": "ubuntu64_hw", 07:06:19 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:06:19 INFO - "branch": "mozilla-inbound", 07:06:19 INFO - "repo_path": "integration/mozilla-inbound", 07:06:19 INFO - "revision": "b9213f375a3fa9570893c23eef9ef4be4cc83226", 07:06:19 INFO - "stage_platform": "linux64-pgo", 07:06:19 INFO - "builduid": "fbda51f85e554f00bc7eed972d025b06", 07:06:19 INFO - "slavebuilddir": "test" 07:06:19 INFO - } 07:06:19 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:06:19 INFO - Running post-action listener: _resource_record_post_action 07:06:19 INFO - ##### 07:06:19 INFO - ##### Finished read-buildbot-config step (success) 07:06:19 INFO - ##### 07:06:19 INFO - ##### 07:06:19 INFO - ##### Running download-and-extract step. 07:06:19 INFO - ##### 07:06:19 INFO - Running pre-action listener: _resource_record_pre_action 07:06:19 INFO - Running main action method: download_and_extract 07:06:19 INFO - mkdir: /builds/slave/test/build/tests 07:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:25 INFO - Downloaded 1361 bytes. 07:06:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:06:25 INFO - Using the following test package requirements: 07:06:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:06:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:06:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'jsshell-linux-x86_64.zip'], 07:06:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:06:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:06:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:06:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:06:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:06:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:06:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:06:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:25 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:06:25 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:06:25 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:06:25 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:06:25 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:06:28 INFO - Downloaded 24442611 bytes. 07:06: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:06: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:06:29 INFO - Return code: 0 07:06:29 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:06: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:06:29 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:06: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.common.tests.zip 07:06: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.common.tests.zip 07:06: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.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:06: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.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:06:32 INFO - Downloaded 24442611 bytes. 07:06:32 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:06:32 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:06:33 INFO - Return code: 0 07:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:33 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:06:34 INFO - Downloaded 10833369 bytes. 07:06:34 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:06:34 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:06:35 INFO - Return code: 0 07:06: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:06:35 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:06:35 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:06:35 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:06:35 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:06:35 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:06:36 INFO - Downloaded 59173081 bytes. 07:06:36 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:06:36 INFO - mkdir: /builds/slave/test/properties 07:06:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:06:36 INFO - Writing to file /builds/slave/test/properties/build_url 07:06:36 INFO - Contents: 07:06:36 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:06:37 INFO - Running post-action listener: _resource_record_post_action 07:06:37 INFO - Running post-action listener: set_extra_try_arguments 07:06:37 INFO - ##### 07:06:37 INFO - ##### Finished download-and-extract step (success) 07:06:37 INFO - ##### 07:06:37 INFO - ##### 07:06:37 INFO - ##### Running populate-webroot step. 07:06:37 INFO - ##### 07:06:37 INFO - Running pre-action listener: _resource_record_pre_action 07:06:37 INFO - Running main action method: populate_webroot 07:06:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:06:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:06:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:06:37 INFO - '--tppagecycles', 07:06:37 INFO - '7'], 07:06:37 INFO - 'tests': ['tsvgm']}}, 07:06:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:06:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:06:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:06:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:06:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:06:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['damp', 'tps']}, 07:06:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'tests': ['damp', 'tps']}, 07:06:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['dromaeo_dom']}, 07:06:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:06:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['a11yr', 07:06:37 INFO - 'ts_paint', 07:06:37 INFO - 'tpaint', 07:06:37 INFO - 'sessionrestore', 07:06:37 INFO - 'sessionrestore_no_auto_restore', 07:06:37 INFO - 'tabpaint']}, 07:06:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['tsvgx', 07:06:37 INFO - 'tsvgr_opacity', 07:06:37 INFO - 'tart', 07:06:37 INFO - 'tscrollx', 07:06:37 INFO - 'cart']}, 07:06:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:06:37 INFO - 'tsvgr_opacity', 07:06:37 INFO - 'tart', 07:06:37 INFO - 'tscrollx', 07:06:37 INFO - 'cart']}, 07:06:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'talos_options': ['--disable-e10s'], 07:06:37 INFO - 'tests': ['tp5o']}, 07:06:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'tests': ['tp5o']}, 07:06:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'talos_options': ['--disable-e10s', 07:06:37 INFO - '--xperf_path', 07:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:37 INFO - 'tests': ['tp5n']}, 07:06:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:06:37 INFO - 'talos_options': ['--xperf_path', 07:06:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:06:37 INFO - 'tests': ['tp5n']}}, 07:06:37 INFO - 'talos.zip': {'path': '', 07:06:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:06:37 INFO - Running post-action listener: _resource_record_post_action 07:06:37 INFO - ##### 07:06:37 INFO - ##### Finished populate-webroot step (success) 07:06:37 INFO - ##### 07:06:37 INFO - ##### 07:06:37 INFO - ##### Running create-virtualenv step. 07:06:37 INFO - ##### 07:06:37 INFO - Running pre-action listener: _resource_record_pre_action 07:06:37 INFO - Running main action method: create_virtualenv 07:06:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:06:37 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:06:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:06:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:06:37 INFO - Using real prefix '/usr' 07:06:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:06:37 INFO - Installing distribute.............................................................................................................................................................................................done. 07:06:39 INFO - Installing pip.................done. 07:06:39 INFO - Return code: 0 07:06:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:06:39 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:06:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:39 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:06:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:39 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:39 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:06:39 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:06:39 INFO - Using env: {'DISPLAY': ':0', 07:06:39 INFO - 'HOME': '/home/cltbld', 07:06:39 INFO - 'LANG': 'en_US.UTF-8', 07:06:39 INFO - 'LANGUAGE': 'en_US:en', 07:06:39 INFO - 'LOGNAME': 'cltbld', 07:06:39 INFO - 'MAIL': '/var/mail/cltbld', 07:06:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:39 INFO - 'MOZ_NO_REMOTE': '1', 07:06:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:39 INFO - 'NO_EM_RESTART': '1', 07:06:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:39 INFO - 'PWD': '/builds/slave/test', 07:06:39 INFO - 'SHELL': '/bin/bash', 07:06:39 INFO - 'SHLVL': '1', 07:06:39 INFO - 'TERM': 'linux', 07:06:39 INFO - 'TMOUT': '86400', 07:06:39 INFO - 'USER': 'cltbld', 07:06:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:39 INFO - '_': '/tools/buildbot/bin/python'} 07:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:40 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:06:40 INFO - Cleaning up... 07:06:40 INFO - Return code: 0 07:06:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:06: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:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', '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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:06: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 psutil>=3.1.1 07:06:40 INFO - Using env: {'DISPLAY': ':0', 07:06:40 INFO - 'HOME': '/home/cltbld', 07:06:40 INFO - 'LANG': 'en_US.UTF-8', 07:06:40 INFO - 'LANGUAGE': 'en_US:en', 07:06:40 INFO - 'LOGNAME': 'cltbld', 07:06:40 INFO - 'MAIL': '/var/mail/cltbld', 07:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:40 INFO - 'MOZ_NO_REMOTE': '1', 07:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:40 INFO - 'NO_EM_RESTART': '1', 07:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:40 INFO - 'PWD': '/builds/slave/test', 07:06:40 INFO - 'SHELL': '/bin/bash', 07:06:40 INFO - 'SHLVL': '1', 07:06:40 INFO - 'TERM': 'linux', 07:06:40 INFO - 'TMOUT': '86400', 07:06:40 INFO - 'USER': 'cltbld', 07:06:40 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:40 INFO - '_': '/tools/buildbot/bin/python'} 07:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:40 INFO - Downloading/unpacking psutil>=3.1.1 07:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:40 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:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:42 INFO - Installing collected packages: psutil 07:06:42 INFO - Running setup.py install for psutil 07:06:42 INFO - building 'psutil._psutil_linux' extension 07:06:42 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:06:42 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:06:42 INFO - building 'psutil._psutil_posix' extension 07:06:42 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:06:42 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:06:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:06:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:06:42 INFO - Successfully installed psutil 07:06:42 INFO - Cleaning up... 07:06:42 INFO - Return code: 0 07:06:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:06:42 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:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:42 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:42 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:06:42 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:06:42 INFO - Using env: {'DISPLAY': ':0', 07:06:42 INFO - 'HOME': '/home/cltbld', 07:06:42 INFO - 'LANG': 'en_US.UTF-8', 07:06:42 INFO - 'LANGUAGE': 'en_US:en', 07:06:42 INFO - 'LOGNAME': 'cltbld', 07:06:42 INFO - 'MAIL': '/var/mail/cltbld', 07:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:42 INFO - 'MOZ_NO_REMOTE': '1', 07:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:42 INFO - 'NO_EM_RESTART': '1', 07:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:42 INFO - 'PWD': '/builds/slave/test', 07:06:42 INFO - 'SHELL': '/bin/bash', 07:06:42 INFO - 'SHLVL': '1', 07:06:42 INFO - 'TERM': 'linux', 07:06:42 INFO - 'TMOUT': '86400', 07:06:42 INFO - 'USER': 'cltbld', 07:06:42 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:42 INFO - '_': '/tools/buildbot/bin/python'} 07:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06: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:06: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:06: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:06: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:06: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:06: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:06:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:44 INFO - Installing collected packages: mozsystemmonitor 07:06:44 INFO - Running setup.py install for mozsystemmonitor 07:06:45 INFO - Successfully installed mozsystemmonitor 07:06:45 INFO - Cleaning up... 07:06:45 INFO - Return code: 0 07:06:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:45 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:45 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:06:45 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:06:45 INFO - Using env: {'DISPLAY': ':0', 07:06:45 INFO - 'HOME': '/home/cltbld', 07:06:45 INFO - 'LANG': 'en_US.UTF-8', 07:06:45 INFO - 'LANGUAGE': 'en_US:en', 07:06:45 INFO - 'LOGNAME': 'cltbld', 07:06:45 INFO - 'MAIL': '/var/mail/cltbld', 07:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:45 INFO - 'MOZ_NO_REMOTE': '1', 07:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:45 INFO - 'NO_EM_RESTART': '1', 07:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:45 INFO - 'PWD': '/builds/slave/test', 07:06:45 INFO - 'SHELL': '/bin/bash', 07:06:45 INFO - 'SHLVL': '1', 07:06:45 INFO - 'TERM': 'linux', 07:06:45 INFO - 'TMOUT': '86400', 07:06:45 INFO - 'USER': 'cltbld', 07:06:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:45 INFO - '_': '/tools/buildbot/bin/python'} 07:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:06: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:06: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:06: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:06: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:06: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:06: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:06:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:47 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:47 INFO - warning: no files found matching '*.txt' 07:06:47 INFO - no previously-included directories found matching 'build' 07:06:47 INFO - no previously-included directories found matching 'dist' 07:06:47 INFO - no previously-included directories found matching '.git*' 07:06:47 INFO - Installing collected packages: jsonschema, functools32 07:06:47 INFO - Running setup.py install for functools32 07:06:47 INFO - warning: no files found matching '*.txt' 07:06:47 INFO - no previously-included directories found matching 'build' 07:06:47 INFO - no previously-included directories found matching 'dist' 07:06:47 INFO - no previously-included directories found matching '.git*' 07:06:47 INFO - Successfully installed jsonschema functools32 07:06:47 INFO - Cleaning up... 07:06:47 INFO - Return code: 0 07:06:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06: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:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:47 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:47 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:06:47 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:06:47 INFO - Using env: {'DISPLAY': ':0', 07:06:47 INFO - 'HOME': '/home/cltbld', 07:06:47 INFO - 'LANG': 'en_US.UTF-8', 07:06:47 INFO - 'LANGUAGE': 'en_US:en', 07:06:47 INFO - 'LOGNAME': 'cltbld', 07:06:47 INFO - 'MAIL': '/var/mail/cltbld', 07:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:47 INFO - 'MOZ_NO_REMOTE': '1', 07:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:47 INFO - 'NO_EM_RESTART': '1', 07:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:47 INFO - 'PWD': '/builds/slave/test', 07:06:47 INFO - 'SHELL': '/bin/bash', 07:06:47 INFO - 'SHLVL': '1', 07:06:47 INFO - 'TERM': 'linux', 07:06:47 INFO - 'TMOUT': '86400', 07:06:47 INFO - 'USER': 'cltbld', 07:06:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:47 INFO - '_': '/tools/buildbot/bin/python'} 07:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:47 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:06:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:49 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:06:49 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:06:49 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:06:49 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:06:49 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:06:49 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:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:50 INFO - Downloading docopt-0.6.1.tar.gz 07:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:50 INFO - Running setup.py install for blobuploader 07:06:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:50 INFO - Running setup.py install for requests 07:06:50 INFO - Running setup.py install for docopt 07:06:51 INFO - Successfully installed blobuploader requests docopt 07:06:51 INFO - Cleaning up... 07:06:51 INFO - Return code: 0 07:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:51 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:51 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:06:51 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:06:51 INFO - Using env: {'DISPLAY': ':0', 07:06:51 INFO - 'HOME': '/home/cltbld', 07:06:51 INFO - 'LANG': 'en_US.UTF-8', 07:06:51 INFO - 'LANGUAGE': 'en_US:en', 07:06:51 INFO - 'LOGNAME': 'cltbld', 07:06:51 INFO - 'MAIL': '/var/mail/cltbld', 07:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:51 INFO - 'MOZ_NO_REMOTE': '1', 07:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:51 INFO - 'NO_EM_RESTART': '1', 07:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:51 INFO - 'PWD': '/builds/slave/test', 07:06:51 INFO - 'SHELL': '/bin/bash', 07:06:51 INFO - 'SHLVL': '1', 07:06:51 INFO - 'TERM': 'linux', 07:06:51 INFO - 'TMOUT': '86400', 07:06:51 INFO - 'USER': 'cltbld', 07:06:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:51 INFO - '_': '/tools/buildbot/bin/python'} 07:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:51 INFO - Running setup.py (path:/tmp/pip-pGNJi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:51 INFO - Running setup.py (path:/tmp/pip-OiLqmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:51 INFO - Running setup.py (path:/tmp/pip-smrWr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:51 INFO - Running setup.py (path:/tmp/pip-HxKQz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:51 INFO - Running setup.py (path:/tmp/pip-8F9Mzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:51 INFO - Running setup.py (path:/tmp/pip-G_xKd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:51 INFO - Running setup.py (path:/tmp/pip-Fu4bmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:51 INFO - Running setup.py (path:/tmp/pip-4beA5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:51 INFO - Running setup.py (path:/tmp/pip-8TA2nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:51 INFO - Running setup.py (path:/tmp/pip-7MpdYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:52 INFO - Running setup.py (path:/tmp/pip-jfgNN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:52 INFO - Running setup.py (path:/tmp/pip-aSYVSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:52 INFO - Running setup.py (path:/tmp/pip-43fjKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:52 INFO - Running setup.py (path:/tmp/pip-K_Ex9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:52 INFO - Running setup.py (path:/tmp/pip-ZVTv2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:52 INFO - Running setup.py (path:/tmp/pip-sr5M2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:52 INFO - Running setup.py (path:/tmp/pip-HU21Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:52 INFO - Running setup.py install for manifestparser 07:06:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:52 INFO - Running setup.py install for mozcrash 07:06:52 INFO - Running setup.py install for mozdebug 07:06:52 INFO - Running setup.py install for mozdevice 07:06:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:52 INFO - Running setup.py install for mozfile 07:06:53 INFO - Running setup.py install for mozhttpd 07:06:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for mozinfo 07:06:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for mozInstall 07:06:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for mozleak 07:06:53 INFO - Running setup.py install for mozlog 07:06:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for moznetwork 07:06:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for mozprocess 07:06:53 INFO - Running setup.py install for mozprofile 07:06:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:53 INFO - Running setup.py install for mozrunner 07:06:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:54 INFO - Running setup.py install for mozscreenshot 07:06:54 INFO - Running setup.py install for moztest 07:06:54 INFO - Running setup.py install for mozversion 07:06:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:54 INFO - Cleaning up... 07:06:54 INFO - Return code: 0 07:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:54 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 07:06:54 INFO - 'HOME': '/home/cltbld', 07:06:54 INFO - 'LANG': 'en_US.UTF-8', 07:06:54 INFO - 'LANGUAGE': 'en_US:en', 07:06:54 INFO - 'LOGNAME': 'cltbld', 07:06:54 INFO - 'MAIL': '/var/mail/cltbld', 07:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:54 INFO - 'MOZ_NO_REMOTE': '1', 07:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:54 INFO - 'NO_EM_RESTART': '1', 07:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:54 INFO - 'PWD': '/builds/slave/test', 07:06:54 INFO - 'SHELL': '/bin/bash', 07:06:54 INFO - 'SHLVL': '1', 07:06:54 INFO - 'TERM': 'linux', 07:06:54 INFO - 'TMOUT': '86400', 07:06:54 INFO - 'USER': 'cltbld', 07:06:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:54 INFO - '_': '/tools/buildbot/bin/python'} 07:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:54 INFO - Running setup.py (path:/tmp/pip-0XOwmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:54 INFO - Running setup.py (path:/tmp/pip-sZzWvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:54 INFO - Running setup.py (path:/tmp/pip-zxhRLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:54 INFO - Running setup.py (path:/tmp/pip-wSNsTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:54 INFO - Running setup.py (path:/tmp/pip-LsXQXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:54 INFO - Running setup.py (path:/tmp/pip-nR2aJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:54 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:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:54 INFO - Running setup.py (path:/tmp/pip-ZHocES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:55 INFO - Running setup.py (path:/tmp/pip-soZC6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:55 INFO - Running setup.py (path:/tmp/pip-YnCfNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:55 INFO - Running setup.py (path:/tmp/pip-3DVbzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:55 INFO - Running setup.py (path:/tmp/pip-_EtWft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:55 INFO - Running setup.py (path:/tmp/pip-9Jc_go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:55 INFO - Running setup.py (path:/tmp/pip-h7T9Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:55 INFO - Running setup.py (path:/tmp/pip-DTEAaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:55 INFO - Running setup.py (path:/tmp/pip-xjjZ7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:55 INFO - Running setup.py (path:/tmp/pip-RoKUy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:55 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:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:55 INFO - Running setup.py (path:/tmp/pip-Hxwp6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:55 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:06:55 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:06:55 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:06:55 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:06:55 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:06:55 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:06:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:57 INFO - Downloading blessings-1.6.tar.gz 07:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:57 INFO - Installing collected packages: blessings 07:06:57 INFO - Running setup.py install for blessings 07:06:57 INFO - Successfully installed blessings 07:06:57 INFO - Cleaning up... 07:06:57 INFO - Return code: 0 07:06:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:58 INFO - Reading from file tmpfile_stdout 07:06:58 INFO - Current package versions: 07:06:58 INFO - argparse == 1.2.1 07:06:58 INFO - blessings == 1.6 07:06:58 INFO - blobuploader == 1.2.4 07:06:58 INFO - docopt == 0.6.1 07:06:58 INFO - functools32 == 3.2.3-2 07:06:58 INFO - jsonschema == 2.5.1 07:06:58 INFO - manifestparser == 1.1 07:06:58 INFO - mozInstall == 1.12 07:06:58 INFO - mozcrash == 0.17 07:06:58 INFO - mozdebug == 0.1 07:06:58 INFO - mozdevice == 0.48 07:06:58 INFO - mozfile == 1.2 07:06:58 INFO - mozhttpd == 0.7 07:06:58 INFO - mozinfo == 0.9 07:06:58 INFO - mozleak == 0.1 07:06:58 INFO - mozlog == 3.2 07:06:58 INFO - moznetwork == 0.27 07:06:58 INFO - mozprocess == 0.22 07:06:58 INFO - mozprofile == 0.28 07:06:58 INFO - mozrunner == 6.11 07:06:58 INFO - mozscreenshot == 0.1 07:06:58 INFO - mozsystemmonitor == 0.3 07:06:58 INFO - moztest == 0.7 07:06:58 INFO - mozversion == 1.4 07:06:58 INFO - psutil == 3.1.1 07:06:58 INFO - requests == 1.2.3 07:06:58 INFO - wsgiref == 0.1.2 07:06:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:58 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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:58 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:06:58 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:06:58 INFO - Using env: {'DISPLAY': ':0', 07:06:58 INFO - 'HOME': '/home/cltbld', 07:06:58 INFO - 'LANG': 'en_US.UTF-8', 07:06:58 INFO - 'LANGUAGE': 'en_US:en', 07:06:58 INFO - 'LOGNAME': 'cltbld', 07:06:58 INFO - 'MAIL': '/var/mail/cltbld', 07:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:58 INFO - 'MOZ_NO_REMOTE': '1', 07:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:58 INFO - 'NO_EM_RESTART': '1', 07:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:58 INFO - 'PWD': '/builds/slave/test', 07:06:58 INFO - 'SHELL': '/bin/bash', 07:06:58 INFO - 'SHLVL': '1', 07:06:58 INFO - 'TERM': 'linux', 07:06:58 INFO - 'TMOUT': '86400', 07:06:58 INFO - 'USER': 'cltbld', 07:06:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:58 INFO - '_': '/tools/buildbot/bin/python'} 07:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 INFO - Cleaning up... 07:06:58 INFO - Return code: 0 07:06:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06:58 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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:58 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:06:58 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:06:58 INFO - Using env: {'DISPLAY': ':0', 07:06:58 INFO - 'HOME': '/home/cltbld', 07:06:58 INFO - 'LANG': 'en_US.UTF-8', 07:06:58 INFO - 'LANGUAGE': 'en_US:en', 07:06:58 INFO - 'LOGNAME': 'cltbld', 07:06:58 INFO - 'MAIL': '/var/mail/cltbld', 07:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:58 INFO - 'MOZ_NO_REMOTE': '1', 07:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:58 INFO - 'NO_EM_RESTART': '1', 07:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:58 INFO - 'PWD': '/builds/slave/test', 07:06:58 INFO - 'SHELL': '/bin/bash', 07:06:58 INFO - 'SHLVL': '1', 07:06:58 INFO - 'TERM': 'linux', 07:06:58 INFO - 'TMOUT': '86400', 07:06:58 INFO - 'USER': 'cltbld', 07:06:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:58 INFO - '_': '/tools/buildbot/bin/python'} 07:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:58 INFO - Cleaning up... 07:06:58 INFO - Return code: 0 07:06:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:06:58 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:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:58 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 0x7fbdbe8c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x156b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1636350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', '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:06:58 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:06:58 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:06:58 INFO - Using env: {'DISPLAY': ':0', 07:06:58 INFO - 'HOME': '/home/cltbld', 07:06:58 INFO - 'LANG': 'en_US.UTF-8', 07:06:58 INFO - 'LANGUAGE': 'en_US:en', 07:06:58 INFO - 'LOGNAME': 'cltbld', 07:06:58 INFO - 'MAIL': '/var/mail/cltbld', 07:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:58 INFO - 'MOZ_NO_REMOTE': '1', 07:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:58 INFO - 'NO_EM_RESTART': '1', 07:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:58 INFO - 'PWD': '/builds/slave/test', 07:06:58 INFO - 'SHELL': '/bin/bash', 07:06:58 INFO - 'SHLVL': '1', 07:06:58 INFO - 'TERM': 'linux', 07:06:58 INFO - 'TMOUT': '86400', 07:06:58 INFO - 'USER': 'cltbld', 07:06:58 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:58 INFO - '_': '/tools/buildbot/bin/python'} 07:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:58 INFO - Downloading/unpacking flake8 07:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:07:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:07:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:07:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:00 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:07:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:01 INFO - no previously-included directories found matching 'docs/_build' 07:07:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:07:01 INFO - Running setup.py install for pep8 07:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:07:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:07:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:07:01 INFO - no previously-included directories found matching 'docs/_build' 07:07:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:07:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:07:01 INFO - Cleaning up... 07:07:01 INFO - Return code: 0 07:07:01 INFO - Running post-action listener: _resource_record_post_action 07:07:01 INFO - Running post-action listener: _start_resource_monitoring 07:07:01 INFO - Starting resource monitoring. 07:07:01 INFO - ##### 07:07:01 INFO - ##### Finished create-virtualenv step (success) 07:07:01 INFO - ##### 07:07:01 INFO - ##### 07:07:01 INFO - ##### Running install step. 07:07:01 INFO - ##### 07:07:01 INFO - Running pre-action listener: _resource_record_pre_action 07:07:01 INFO - Running main action method: install 07:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:07:01 INFO - Reading from file tmpfile_stdout 07:07:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:07:01 INFO - Reading from file tmpfile_stdout 07:07:01 INFO - Output received: 07:07:01 INFO - Usage: mozinstall [options] installer 07:07:01 INFO - Options: 07:07:01 INFO - -h, --help show this help message and exit 07:07:01 INFO - -d DEST, --destination=DEST 07:07:01 INFO - Directory to install application into. [default: 07:07:01 INFO - "/builds/slave/test"] 07:07:01 INFO - --app=APP Application being installed. [default: firefox] 07:07:01 INFO - mkdir: /builds/slave/test/build/application 07:07:01 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:07:01 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:07:18 INFO - Reading from file tmpfile_stdout 07:07:18 INFO - Output received: 07:07:18 INFO - /builds/slave/test/build/application/firefox/firefox 07:07:18 INFO - Running post-action listener: _resource_record_post_action 07:07:18 INFO - ##### 07:07:18 INFO - ##### Finished install step (success) 07:07:18 INFO - ##### 07:07:18 INFO - ##### 07:07:18 INFO - ##### Running run-tests step. 07:07:18 INFO - ##### 07:07:18 INFO - Running pre-action listener: _resource_record_pre_action 07:07:18 INFO - Running main action method: run_tests 07:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:07:18 INFO - Python 2.7.3 07:07:18 INFO - Return code: 0 07:07:18 INFO - grabbing minidump binary from tooltool 07:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:07:18 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 0x16c51c0>, '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 0x16c60c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c6550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:07:18 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:07:18 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:07:18 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:07:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:07:18 INFO - Return code: 0 07:07:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:07:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:07:19 INFO - Return code: 0 07:07:19 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-035', '--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:07:19 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-035 --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:07:19 INFO - Using env: {'DISPLAY': ':0', 07:07:19 INFO - 'HOME': '/home/cltbld', 07:07:19 INFO - 'LANG': 'en_US.UTF-8', 07:07:19 INFO - 'LANGUAGE': 'en_US:en', 07:07:19 INFO - 'LOGNAME': 'cltbld', 07:07:19 INFO - 'MAIL': '/var/mail/cltbld', 07:07:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:07:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:07:19 INFO - 'MOZ_NO_REMOTE': '1', 07:07:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:07:19 INFO - 'NO_EM_RESTART': '1', 07:07:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:07:19 INFO - 'PWD': '/builds/slave/test', 07:07:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:07:19 INFO - 'SHELL': '/bin/bash', 07:07:19 INFO - 'SHLVL': '1', 07:07:19 INFO - 'TERM': 'linux', 07:07:19 INFO - 'TMOUT': '86400', 07:07:19 INFO - 'USER': 'cltbld', 07:07:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375', 07:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:07:19 INFO - '_': '/tools/buildbot/bin/python'} 07:07:19 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-035', '--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:07:19 INFO - mozversion application_buildid: 20160605043005 07:07:19 INFO - mozversion application_changeset: b9213f375a3fa9570893c23eef9ef4be4cc83226 07:07:19 INFO - mozversion application_display_name: Nightly 07:07:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:07:19 INFO - mozversion application_name: Firefox 07:07:19 INFO - mozversion application_remotingname: firefox 07:07:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:19 INFO - mozversion application_vendor: Mozilla 07:07:19 INFO - mozversion application_version: 49.0a1 07:07:19 INFO - mozversion platform_buildid: 20160605043005 07:07:19 INFO - mozversion platform_changeset: b9213f375a3fa9570893c23eef9ef4be4cc83226 07:07:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:07:19 INFO - mozversion platform_version: 49.0a1 07:07:19 INFO - using testdate: 1465135639 07:07:19 INFO - actual date: 1465135639 07:07:19 INFO - starting webserver on 'localhost:33890' 07:07:19 INFO - SUITE-START | Running 2 tests 07:07:19 INFO - TEST-START | dromaeo_css 07:07:19 INFO - operating with platform_type : linux_ 07:07:19 INFO - Initialising browser for dromaeo_css test... 07:07:19 INFO - TEST-INFO | started process 10764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgW3sGf/profile http://localhost:33890/getInfo.html) 07:07:23 INFO - PROCESS | 10764 | __metrics Screen width/height:1600/1200 07:07:23 INFO - PROCESS | 10764 | colorDepth:24 07:07:23 INFO - PROCESS | 10764 | Browser inner width/height: 1024/697 07:07:23 INFO - PROCESS | 10764 | __metrics 07:07:24 ERROR - PROCESS | 10764 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:07:25 INFO - TEST-INFO | 10764: exit 0 07:07:25 INFO - Browser initialized. 07:07:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:07:25 INFO - TEST-INFO | started process 10844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgW3sGf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:37 INFO - PROCESS | 10844 | RSS: Main: 155635712 07:07:37 INFO - PROCESS | 10844 | 07:08:28 INFO - PROCESS | 10844 | 1465135708691 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:10:36 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33890/tests/dromaeo/cssquery-ext.html) 07:10:37 INFO - PROCESS | 10844 | RSS: Main: 255897600 07:10:37 INFO - PROCESS | 10844 | 07:13:40 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-ext.html (next: http://localhost:33890/tests/dromaeo/cssquery-jquery.html) 07:13:40 INFO - PROCESS | 10844 | RSS: Main: 245321728 07:13:40 INFO - PROCESS | 10844 | 07:16:42 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33890/tests/dromaeo/cssquery-mootools.html) 07:16:43 INFO - PROCESS | 10844 | RSS: Main: 246394880 07:16:43 INFO - PROCESS | 10844 | 07:19:45 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33890/tests/dromaeo/cssquery-prototype.html) 07:19:46 INFO - PROCESS | 10844 | RSS: Main: 236843008 07:19:46 INFO - PROCESS | 10844 | 07:22:48 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33890/tests/dromaeo/cssquery-yui.html) 07:22:49 INFO - PROCESS | 10844 | RSS: Main: 227667968 07:22:49 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | Cycle 1(1): loaded http://localhost:33890/tests/dromaeo/cssquery-yui.html (next: http://localhost:33890/tests/dromaeo/cssquery-dojo.html) 07:25:52 INFO - PROCESS | 10844 | RSS: Main: 291475456 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | __start_tp_report 07:25:52 INFO - PROCESS | 10844 | _x_x_mozilla_page_load 07:25:52 INFO - PROCESS | 10844 | _x_x_mozilla_page_load_details 07:25:52 INFO - PROCESS | 10844 | |i|pagename|runs| 07:25:52 INFO - PROCESS | 10844 | |0;dojo.html;3125.1405863387567;3139.2465808206007;3158.9417545122374;3181.8090914545114;3203.07110937828;5281.471852814717;5352.598555108373;5486.890262194754;5577.888442231153;5579.1910173024935;5379.408265090837;5467.480589344006;5488.807891723791;5498.917516237249;5517.724113794305;4921.212605983034;4951.232558953368;5003.099442100421;5016.623753218505;5189.325387699612;5076.213186956028;5082.415522214956;5123.129068058439;5128.205128205134;5143.485651434845;4798.4001999750035;4824.276358546211;4944.307796908436;4973.403191616993;5027.547520723152;4940.382452193476;4969.279454479117;4979.551840334351;5030.647854650176;5086.262491938648;4986.252062190664;4998.125328067574;5019.623528235397;5033.219850923113;5082.390113186404;5238.371395432572;5388.1648344506275;5446.945530544684;5530.668159910419;5533.253010843525;5936.584439089265;5944.464998150144;5968.4031596840405;5985.790497332572;5987.191729116557;5704.486596206361;5958.076498142795;6008.158857759873;6013.879722405527;6017.277926648786;5360.088784906575;5449.782008719686;5451.1005684062475;5454.972725136349;5455.427180146107;5934.910976335358;5979.850503737442;5984.640921544721;5985.850353741192;5986.610870293417;5771.682557459296;5852.209951656557;5896.64620122794;5899.793507227227;5908.291005079418;5975.79084732041;5990.670513121733;6010.038393856962;6022.066579680157;6026.849328766816;5617.719114044281;5804.65172089676;5809.970950145307;5812.564057695689;5820.592558520862;5895.616784908967;5923.792667256712;5962.07587823888;5963.671998040063;5965.045592705146;4413.271810151289;4417.249067658506;4426.955730442719;4427.889302767457;4431.313146462304;3877.166409222031;3925.1953349563273;3933.272344616255;3933.8229779659982;3984.1633257015774;5482.671039737628;5493.23094766733;5499.972500137474;5562.082256427644;5567.777288908398;5940.01989671708;5942.10868369748;5947.167396564484;5947.702614869239;5995.250593675791;5343.759530821122;5557.972210138923;5566.471185237396;5569.749361278752;5571.275734154615;4801.591864691541;4892.3884514435695;4897.706137631753;4920.40955085392;4927.90144197114;6071.939280607226;6073.14975903365;6073.544484163705;6074.42292982166;6098.024316109401;5723;5858.355580886014;5861.794837180678;5912.911306330495;5919.733611987557;6129.84675383119;6181.505479561534;6186.381361863958;6187.566870319034;6189.6286222826775;5865.94134058654;5872.94127058741;5875.383084776037;5882.352941176381;5919.319278283053;5675.347335056521;5925.851853703692;5964.373740757158;5979.162917191509;5981.282246130492;5636.9436305638055;5682.460166284196;5702.287214098238;5739.311282646109;5746.3966283541295;5699.971500142473;5725.770969161187;5738.913916291175;5744.339400968942;5763.538916886723;5420.322459692538;5638.802641907678;5648.519875810603;5658.321001479849;5662.122371032497;5844.824655260349;5873.236479257669;5885.028970219866;5907.054871220584;5939.10913362999;5658.179563963285;5659.26429564154;5662.858428539154;5667.1782591524825;5705.686187259741 07:25:52 INFO - PROCESS | 10844 | |1;ext.html;586.3023002626874;624.581530374649;626.9122322874797;633.8447080465287;637.9170707807984;32191.356172876527;44641.33038004429;45231.321530177076;45304.14914732244;45408;45239;45569.54430455694;45682.54317456824;45716;45773.54226457734;7974.601269936509;8563.914360856405;8814.955925220365;8820.691275805348;10382.9480852596;10114.494275286243;10444.477776111164;10502.684919452391;10522.631707890225;10528.842067368996;10511.106555942753;10551.78896422071;10575.841362379571;10584.576616935314;10585.947070264638;10476.476176191198;10535.894641053568;10554.102901253325;10554.261201715883;10555.472226388727;10494.212934029978;10606.840897386546;10610.257281990263;10613.9469302653;10615.57537698491;43028.354574681405;43507.78246108749;43543.56456435427;43562.346564801555;43625.34561981573;3569.7501174917766;4022.1754540319166;4054.2904991626347;4192.993681516445;4331.696781225315;31887.149835509965;32537.83731081353;32601.510977335358;33062.17344566381;33608.6639133608;4332.371806088131;4340.218760623086;4345.67407444443;4372.322290045048;4530.980529380896;248687;248825;248899;248942;249555;34970.47544286838;57900.710496447246;57985.420145798;58356.4164358351;58465.41534584685;36775.816120919226;37017.444738328944;37115.072123196594;37175.81412092976;37218.25563488769;14189.858101418853;14267.500637477639;14286.071405358827;14286.928565357106;14300.284985750672;12193.32936688473;12877.613671589866;12933.224006559636;13119;13125.278109704059;8371.414001019992;8381.07808141104;8457.619407126695;8476.321894248445;8524.914750852537;3090.922726931845;3188.2985743136474;3258.6212065192544;3284.3759685659647;3328.9334213315597;1022.5705203814416;1059.3157178205395;1142.6176422159724;1152.389233706137;1207.1188032735977;33188.668113318556;33331.500027499605;33419.83290083534;33448;33967.83016084904;1138.8804175561613;1175.4769127738246;1223.2843786384888;1267.1636719765095;1274.7960326347925;17140;17648.382306619205;17648.735268970977;17672.11639418024;17706.5573360667;170055;170225;170540;170643;171558.14220929064;59047.70476147592;59618.105728414106;59711.701441492514;59733.104003439985;60049.699751500964;1296.4554886947506;1382.384838746768;1425.4369524038154;1430.306301443799;1431.992840035793;32576.34847302993;33953.32093358169;34250.48624270688;34312.97061088171;34564.65435345715;49289;49948.75025624849;50028.499715002385;50073;50093.49906501034;336626.6337336595;343926;344905;344909;345426;25355.36611584725;26984.190474285802;27512.724872751816;27755.86122069377;29269.121926342243;47186.29220561763;47672.28491572699;47783.761081194374;48160.27759583539;49372;40733.1853362937;41399.68802495853;41520.37719434271;42630.5736942639;43417;40927;41397.379039315034;41431.585684142774;41912;42245.36631950585;41237;41472.792636036625;42277.78861105798;43054.569454305056;43113.56886431095;34388.312233755685;37010.8149459251;37132.81433592923;37472.62527374691;37821;27958.58062129029;28422.43155136844;28434;28530.42939141164;28577.28556786097 07:25:52 INFO - PROCESS | 10844 | |2;jquery.html;388.79473631741604;389.88693278949125;393.3647159836861;400.6674460198035;418.7152736139426;14258.857411425883;16572.751408728847;18187.090645467724;19616.215351385927;19635;18722.251109955585;19092.427227183205;19128.33050843221;19200;19310.420687379366;5474.069408200596;5612.102063669814;5645.887082258352;5701.116326969326;5701.2018317435595;4001.9199616007663;4179.770112643803;5400.216968539559;5564.276644036269;5582.190582365554;5914.674692891911;6222.284437289702;6222.906656400158;6343.207099112611;6352.968235158841;5293.073712100367;5545.3622833374275;5547;6289;6312.3687631236735;5434.429384914567;5435.402105768402;5441.83674489766;5460.563154947595;5466.535344495683;13836;20092.799072009384;22113.44716382087;22157.562668106497;22189.667154992687;2316.2819525946843;2466.062896099471;2469.2098528470897;2797.2727090956296;2941.2058744138963;8996.505192214425;9594.088561586637;9596.904030959671;9652.806943861153;10224.74438139045;1816.7184086466618;1848.8613353998503;1853.4902901702005;1930.3822776711459;1968.625961067407;84163;84694;89355.55322223413;89966;90602;10743.409112498888;10774.569017239222;10960.506777195045;11032.669019929415;11171.273867198606;13257.66855828612;13944.511942082181;14764.26178691061;15375.538733838002;15421.151836649093;8213.835723285501;8335.333173346118;8425.70510032146;8565.528895910784;8607.096254893271;7980.920190798134;8114.675412983533;8328.625211865481;8359.643513708019;8508.489490630582;4567.931481027787;4725.740084295397;4786.593139583105;4792.376990991149;4806.206975849016;1902.9904850475937;1933.2750218668;1938.3797184900695;1939.2921583621876;1960.1277431542826;909.9226565741853;961.3222678012124;966.917811985989;1038.7610849504506;1053.199568328076;18253.543661408305;18473.7228941566;18658.53353666142;18770.155343009596;19081.61836763257;1000.6997900629927;1022.8107800057013;1023.7031260934394;1041.250299784154;1048.580567772897;9454.33819632633;10475.685729428129;10555.208359373079;10562.947185264178;10609.469526523642;500447;505430.97162149986;511374;512262;513954;58060.07178263485;95321;95698.52150739341;96439.51780241054;99402;997.9151772099453;1011.261778901406;1020.9183265338903;1035;1043.5669197283044;16514.42199523011;16598;16733.832661673227;16833.326666933677;16882.409115680894;26734.105477999885;34647;35723.82138089293;39616;42841;53665.46334536605;54933.17600236079;54937;55012.72493637506;55279.17081243865;6858.6570671467225;7140;7435.293647103516;8155.266026057683;8418.284445822173;12458.190217635825;12517.56188533397;12644.30456324911;12654.936725316315;12761.425735841724;10683.89316106829;11003.33979961205;11019.944900275448;11155.55377784912;11357.204995650556;10981.121510279;10981.61564345244;11231.831522527005;11296.265742726697;11394.316341019234;11077.889221107685;11250.7749845001;11315.434228288388;11488.138389620644;11573.247738896946;7193.5324203926575;7267.890981635385;7469.290417410337;7643.808904777425;7744.7676569703;9016.368854180144;11147.163962702993;11224.887751122384;11259.155563332946;11320.773584528428 07:25:52 INFO - PROCESS | 10844 | |3;mootools.html;1330.2882957617676;1525.4127161042995;1550.1786748118425;1728.9394871179504;1856.4709057918496;8455.49267043977;8862.113788621135;8872.822543549126;9095.0904909509;9107.362484626063;8811.295096392289;9009.864852027225;9028.954855225731;9040.72877813665;9054.818903621923;2047.7952204779551;2236.563870045342;2312.0867257433306;2373.679553260309;2402.507485965373;2386.95226095478;2392.8923198456023;2397.712274527059;2399.244238065004;2411.05968672218;2399.7720216579396;2420;2429.441228517433;2431.3070774829175;2437.609982402816;1972.0829814136423;2243.5737209930144;2256.8307376946796;2331.848429852071;2341.5785158671433;2307.803836673868;2338.3920180753125;2341.0635745701684;2341.8946147423235;2362.11420717231;8948.373613847034;9103.13520215585;9114.544272786401;9116.58975346111;9120.81758364829;5355.410904800468;5515.145152501369;5516.448355164492;5520;5526;3253.6908993645566;3386.407378708741;3428.0915557377316;3432.1076520104953;3450.05123591012;1060.4220699718594;1101.1961268274204;1107.7230692326918;1113.209621168963;1118.7762447510531;12622.368881555885;12626.873731262662;12631.115821892472;12642.620721378373;12662.55681051168;4722.058845334557;4801.927971080437;4851.660383773173;4863.8540843774745;4902.460729319772;10526.578936842594;10531.420771857622;10554.2084343673;10566.154707623526;10577.418241996764;5192.1952097424955;5192.221166824931;5226.660267082628;5230.790768369223;5233.1365324721755;4239.703220774578;4860.902781944341;4986.301917731521;4996.525330093636;5045.192769156991;4010.4585880905706;4042.543669913658;4083.734557253769;4161.52142503616;4164;1269.3843485909326;1281.1608396500308;1281.493809945085;1287.8905293050009;1297.545858949379;956.5073986896754;978.4862946952907;982.6757170133839;1000.0599436529639;1002.2533212756543;5896.823095307148;5930.05119180929;5958.940410595926;6006.819795406145;6096.908546371808;949.1410273702311;951.857221416793;979.8187335342842;981.293468702533;1000.8548760429696;4015.417764424142;4093.7953102344763;4127.215828992482;4153;4153.127843152912;11174.553017879356;11412.315261084195;11594.76810463803;11617.825732614017;11623;11452.255603385753;11467.942660286646;11493.597724079784;11520.711982200512;11536.884631153582;7990.360771138295;8130.674773009132;8143.307818835466;8169.223923727236;8321.875171872547;5791.8552036199435;5888.440598143169;6023.427774361428;6092.908606370819;6095.9390406097145;10290.588376465157;10313.329633573794;10508.737281568023;10519.421431821018;10538.156947444339;10206.897931020594;10486.528106235086;10693.465326733787;10791.298565593212;10798.622048228275;6775.119234499483;7845.529268243924;8078.515289082674;8126.75619731409;8257.05043919957;9057.864132037894;9063.864042039242;9124.266389385995;9130.589123489326;9151.816963660556;7633.503822251758;7859.567723775247;8027.2775450209765;8030.598470076356;8162.83674326522;7719.228077192236;7815.062192536932;7848.018997625297;7849.882251766114;7931.127575966754;6872.41584465326;6877.759278425231;6879.140107486564;6902.758403455855;6955.339242771928;4974.154393752999;5077.7968881245815;5092.108880945893;5161.974190129025;5177.92233116496;5178.456262092426;5267.9736601316745;5281.973590132025;5372.355317361941;5400.83797486076 07:25:52 INFO - PROCESS | 10844 | |4;prototype.html;326.4874147588286;330.4778450048923;338.74424809269004;340.5521738913327;340.65934065934067;5295.576353891689;5318.680879147254;5388.703621300827;5398.325209348832;5448.902172663528;5338.145896656536;5372.7045012524395;5381.569474442045;5396;5403.081476149055;3971.285168669638;4032.5967403259733;4108.609682080212;4153.584641535853;4234.153169366139;4162.8959276018195;4199.979000104995;4217.789110544476;4218.915621687564;4231.661467082641;4003.7397569158056;4184.121334519755;4191.580841915815;4195.098053918407;4202.91594168118;4073.775942323171;4084.202321409844;4109.486314210723;4150.667946564297;4206.116715489751;3699.68661125302;3701.9259614807825;3704.833282502267;3716.145286584074;3729.3473642112795;5037.244413337992;5256.8685782855355;5261.105612045962;5262.394824595182;5267.815626453055;4737.218358970766;4773.570378665937;4777.665563410563;4807.711537307773;4837.419509658828;5497.175423686439;5564.443555644443;5603.467670571289;5636.351819540723;5669.489745922846;4070.1249231415386;4073.103917138225;4083.244599749056;4093.5087789465456;4101.52832424272;5632.633878797906;5923.378045305224;5937.435943585352;5937.970310148422;5941.792037278675;4106.589341065929;4119.443875076886;4120.114175452292;4120.361343991686;4121.505419349637;4170.457840480718;4170.874873753793;4180.519240287406;4182.473397210058;4182.916341673211;4684.158989628472;4787.928181077286;4788.329633851264;4798.104748624343;4810.2063159578975;5694.772209111672;5703.885922281531;5732.598718089694;5733.627314224562;5742.851429714074;1405.9947137796526;1425.9714805703827;1427.0866645346987;1427.2364285107417;1429.3782204740971;882.8013696918142;901.5762591581946;902.6795487601938;947.8483642374548;963.0802583532709;5371.140617501181;5374.838754837361;5378.757955891994;5379.731013449312;5384.542313903362;5760.193572899798;5762.049261871744;5770.913436298459;5776.393478684761;5790.594658373873;5133.204353325241;5347.358317001985;5374.005808925362;5394.892102158014;5405.675659460445;3043.691212778482;3054.9694503054684;3055.220918665726;3064.7701422392965;3069.969300307013;5665.461781130868;5891.852703682356;5909.261342332208;5947.762089516371;5958.761649534057;5880.941190588125;5921.437463440966;5924.933511967801;5935.673537955454;5960.910586341209;5986.431289027535;6017.247844019497;6025.312912384539;6038.456538911431;6045.093236014545;5597.720113994365;5793.565482588907;5797.43469263305;5802.098950524738;5851.385604511465;5660.547156227574;5726.482482142153;5731.684757338387;5735.304406928737;5747.872637929022;5882.558808089325;5982.8632559813495;5994.490468310068;6019.337872834072;6031.939680603314;4055.3916912463364;4115.444415003936;4124.752514849119;4133.111381053088;4137.275976704004;5792.478676919098;5793.246877905845;5797.159391898024;5859.970700146642;5907.054871220584;5622.522085622768;5754.741036653277;5755.827325180251;5765.308163020464;5767.798127065533;5610.102383618601;5696.658200507983;5745.827625171251;5748.798792042426;5750.6837123958585;5322.467753224647;5362.544183744425;5583.720813959367;5590.301212348457;5596.216529685766;5701.344345400166;5715.199872018004;5727.31272247333;5732.337622089714;5762.884742305214;5425.528213641432;5613.46672066153;5615.971920140373;5624.409437009055;5635.435876676021 07:25:52 INFO - PROCESS | 10844 | |5;yui.html;801.563148084294;823.1685997142886;833.4915701422135;848.6817443458699;883.7260449260727;15115.395384184632;16871.24079416426;17445.82554174458;17460.563485912844;17472.912635436805;15617.21913904303;15656.530304090868;15691.84308156918;16233.107179105144;16380.099094549794;801.7714951238898;826.396730386818;826.9255766980971;829.5188790501495;829.9751007469786;680.3332733920761;802.2819576479047;824.4146655874337;828.2628460670009;836.5357226739158;859.2138193552922;862.525610913998;865.2342676731107;865.3812524045306;865.6926790989203;711.1501755402296;850.8128211793396;851.5018714052287;851.6593362654957;852.0925214646413;614.1340709599443;628.7296462521114;630.533405280094;635.1457289945016;635.4027214418478;14155.150690958575;14172.149671019668;14180.787288190686;14271.429142834275;14272.92863535686;14444.205568693718;14848;14894.776578351333;14908;15085.773713394308;13170.934145329307;13203.2738199399;13258.867411325957;13398.799018014737;13996;4554.8861278467975;4593.931091033637;4631.328457373662;4755.476897541268;4795.904081918342;74473.62763186204;77549.46955834853;77559.61220193919;78349;78421;11844.230125041844;11873.168878178445;11895.524179032915;11967;12189.756204875854;21578;22987;23047;23062.30813075577;23136.4215894604;9330.160285574331;9363.15731584147;9385.15533601979;9400.952995235117;9736.805263894825;4967.528084831935;5017.67385119966;5019;5039.168537191323;5040;3536.5756109267054;3642.162302670348;3646.3983442732183;3648.5074514940675;3649.087728067983;653.323809856796;655.8425977765302;656.9868602627921;679.7009315900988;680.7379159023811;734.6693987705447;748.9775306740806;749.8612756640039;752.2101793117314;768.3469051306345;9638.180754635794;9921.553530091163;10514.57941682324;10568.365898046142;10572.36565806054;633.6989929783316;701.428335906245;750.2497502497503;771.3289438188699;802.955837428947;4564.726116433025;4581.633469322446;4640.69835460694;4648.418947631546;4692.319613656001;118587.8141218594;118736;126811.36594317154;129960.3501982484;130600;106065;106891;108066;108607.45696271468;110385;92639;94187.52906235425;95161.5241923786;95441;95787;9545.331826772337;9881.802363952824;9884.30809843304;9901.207903367856;9907.256955728206;52644.21033684421;53536.66158346072;54647.726761365935;55548.44451555433;56596.15105773335;73725.6313718428;83572;84068;84672.57663711642;86925;11487.725349111593;12711;13112.278824664734;13146.539871104847;13148;14039.719205616035;14538.709225815635;14715;15788.68422631564;15890.284937178087;12857.742845142857;14177.362018708976;14504.419823206954;14525.4916077941;14610.926945365205;14362.856371436152;14737.1894545801;14804.777928330868;15275.541733748005;15330.846691533388;14183.290835458392;14494.492692755703;14817.925910370379;14928.925355373154;15216.239188040776;11220.11856004527;11326;11330.94334528322;11368.602098926498;11419.885801141882;11191.776164476827;11716.648500544998;11874.584389546324;12088.21426607303;12216.816747748613 07:25:52 INFO - PROCESS | 10844 | __end_tp_report 07:25:52 INFO - PROCESS | 10844 | __start_cc_report 07:25:52 INFO - PROCESS | 10844 | _x_x_mozilla_cycle_collect,795 07:25:52 INFO - PROCESS | 10844 | __end_cc_report 07:25:52 INFO - PROCESS | 10844 | __startTimestamp1465136752811__endTimestamp 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | ------- Summary: start ------- 07:25:52 INFO - PROCESS | 10844 | Number of tests: 6 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#0] dojo.html Cycles:165 Average:5461.17 Median:5659.26 stddev:647.91 (11.4%) stddev-sans-first:623.44 07:25:52 INFO - PROCESS | 10844 | Values: 3125.1 3139.2 3158.9 3181.8 3203.1 5281.5 5352.6 5486.9 5577.9 5579.2 5379.4 5467.5 5488.8 5498.9 5517.7 4921.2 4951.2 5003.1 5016.6 5189.3 5076.2 5082.4 5123.1 5128.2 5143.5 4798.4 4824.3 4944.3 4973.4 5027.5 4940.4 4969.3 4979.6 5030.6 5086.3 4986.3 4998.1 5019.6 5033.2 5082.4 5238.4 5388.2 5446.9 5530.7 5533.3 5936.6 5944.5 5968.4 5985.8 5987.2 5704.5 5958.1 6008.2 6013.9 6017.3 5360.1 5449.8 5451.1 5455.0 5455.4 5934.9 5979.9 5984.6 5985.9 5986.6 5771.7 5852.2 5896.6 5899.8 5908.3 5975.8 5990.7 6010.0 6022.1 6026.8 5617.7 5804.7 5810.0 5812.6 5820.6 5895.6 5923.8 5962.1 5963.7 5965.0 4413.3 4417.2 4427.0 4427.9 4431.3 3877.2 3925.2 3933.3 3933.8 3984.2 5482.7 5493.2 5500.0 5562.1 5567.8 5940.0 5942.1 5947.2 5947.7 5995.3 5343.8 5558.0 5566.5 5569.7 5571.3 4801.6 4892.4 4897.7 4920.4 4927.9 6071.9 6073.1 6073.5 6074.4 6098.0 5723.0 5858.4 5861.8 5912.9 5919.7 6129.8 6181.5 6186.4 6187.6 6189.6 5865.9 5872.9 5875.4 5882.4 5919.3 5675.3 5925.9 5964.4 5979.2 5981.3 5636.9 5682.5 5702.3 5739.3 5746.4 5700.0 5725.8 5738.9 5744.3 5763.5 5420.3 5638.8 5648.5 5658.3 5662.1 5844.8 5873.2 5885.0 5907.1 5939.1 5658.2 5659.3 5662.9 5667.2 5705.7 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#1] ext.html Cycles:180 Average:43918.26 Median:34281.73 stddev:69064.72 (201.5%) stddev-sans-first:69181.83 07:25:52 INFO - PROCESS | 10844 | Values: 586.3 624.6 626.9 633.8 637.9 32191.4 44641.3 45231.3 45304.1 45408.0 45239.0 45569.5 45682.5 45716.0 45773.5 7974.6 8563.9 8815.0 8820.7 10382.9 10114.5 10444.5 10502.7 10522.6 10528.8 10511.1 10551.8 10575.8 10584.6 10585.9 10476.5 10535.9 10554.1 10554.3 10555.5 10494.2 10606.8 10610.3 10613.9 10615.6 43028.4 43507.8 43543.6 43562.3 43625.3 3569.8 4022.2 4054.3 4193.0 4331.7 31887.1 32537.8 32601.5 33062.2 33608.7 4332.4 4340.2 4345.7 4372.3 4531.0 248687.0 248825.0 248899.0 248942.0 249555.0 34970.5 57900.7 57985.4 58356.4 58465.4 36775.8 37017.4 37115.1 37175.8 37218.3 14189.9 14267.5 14286.1 14286.9 14300.3 12193.3 12877.6 12933.2 13119.0 13125.3 8371.4 8381.1 8457.6 8476.3 8524.9 3090.9 3188.3 3258.6 3284.4 3328.9 1022.6 1059.3 1142.6 1152.4 1207.1 33188.7 33331.5 33419.8 33448.0 33967.8 1138.9 1175.5 1223.3 1267.2 1274.8 17140.0 17648.4 17648.7 17672.1 17706.6 170055.0 170225.0 170540.0 170643.0 171558.1 59047.7 59618.1 59711.7 59733.1 60049.7 1296.5 1382.4 1425.4 1430.3 1432.0 32576.3 33953.3 34250.5 34313.0 34564.7 49289.0 49948.8 50028.5 50073.0 50093.5 336626.6 343926.0 344905.0 344909.0 345426.0 25355.4 26984.2 27512.7 27755.9 29269.1 47186.3 47672.3 47783.8 48160.3 49372.0 40733.2 41399.7 41520.4 42630.6 43417.0 40927.0 41397.4 41431.6 41912.0 42245.4 41237.0 41472.8 42277.8 43054.6 43113.6 34388.3 37010.8 37132.8 37472.6 37821.0 27958.6 28422.4 28434.0 28530.4 28577.3 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#2] jquery.html Cycles:180 Average:29029.41 Median:18794.10 stddev:83899.36 (446.4%) stddev-sans-first:84107.16 07:25:52 INFO - PROCESS | 10844 | Values: 388.8 389.9 393.4 400.7 418.7 14258.9 16572.8 18187.1 19616.2 19635.0 18722.3 19092.4 19128.3 19200.0 19310.4 5474.1 5612.1 5645.9 5701.1 5701.2 4001.9 4179.8 5400.2 5564.3 5582.2 5914.7 6222.3 6222.9 6343.2 6353.0 5293.1 5545.4 5547.0 6289.0 6312.4 5434.4 5435.4 5441.8 5460.6 5466.5 13836.0 20092.8 22113.4 22157.6 22189.7 2316.3 2466.1 2469.2 2797.3 2941.2 8996.5 9594.1 9596.9 9652.8 10224.7 1816.7 1848.9 1853.5 1930.4 1968.6 84163.0 84694.0 89355.6 89966.0 90602.0 10743.4 10774.6 10960.5 11032.7 11171.3 13257.7 13944.5 14764.3 15375.5 15421.2 8213.8 8335.3 8425.7 8565.5 8607.1 7980.9 8114.7 8328.6 8359.6 8508.5 4567.9 4725.7 4786.6 4792.4 4806.2 1903.0 1933.3 1938.4 1939.3 1960.1 909.9 961.3 966.9 1038.8 1053.2 18253.5 18473.7 18658.5 18770.2 19081.6 1000.7 1022.8 1023.7 1041.3 1048.6 9454.3 10475.7 10555.2 10562.9 10609.5 500447.0 505431.0 511374.0 512262.0 513954.0 58060.1 95321.0 95698.5 96439.5 99402.0 997.9 1011.3 1020.9 1035.0 1043.6 16514.4 16598.0 16733.8 16833.3 16882.4 26734.1 34647.0 35723.8 39616.0 42841.0 53665.5 54933.2 54937.0 55012.7 55279.2 6858.7 7140.0 7435.3 8155.3 8418.3 12458.2 12517.6 12644.3 12654.9 12761.4 10683.9 11003.3 11019.9 11155.6 11357.2 10981.1 10981.6 11231.8 11296.3 11394.3 11077.9 11250.8 11315.4 11488.1 11573.2 7193.5 7267.9 7469.3 7643.8 7744.8 9016.4 11147.2 11224.9 11259.2 11320.8 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#3] mootools.html Cycles:180 Average:5938.70 Median:4826.79 stddev:3428.89 (71.0%) stddev-sans-first:3421.02 07:25:52 INFO - PROCESS | 10844 | Values: 1330.3 1525.4 1550.2 1728.9 1856.5 8455.5 8862.1 8872.8 9095.1 9107.4 8811.3 9009.9 9029.0 9040.7 9054.8 2047.8 2236.6 2312.1 2373.7 2402.5 2387.0 2392.9 2397.7 2399.2 2411.1 2399.8 2420.0 2429.4 2431.3 2437.6 1972.1 2243.6 2256.8 2331.8 2341.6 2307.8 2338.4 2341.1 2341.9 2362.1 8948.4 9103.1 9114.5 9116.6 9120.8 5355.4 5515.1 5516.4 5520.0 5526.0 3253.7 3386.4 3428.1 3432.1 3450.1 1060.4 1101.2 1107.7 1113.2 1118.8 12622.4 12626.9 12631.1 12642.6 12662.6 4722.1 4801.9 4851.7 4863.9 4902.5 10526.6 10531.4 10554.2 10566.2 10577.4 5192.2 5192.2 5226.7 5230.8 5233.1 4239.7 4860.9 4986.3 4996.5 5045.2 4010.5 4042.5 4083.7 4161.5 4164.0 1269.4 1281.2 1281.5 1287.9 1297.5 956.5 978.5 982.7 1000.1 1002.3 5896.8 5930.1 5958.9 6006.8 6096.9 949.1 951.9 979.8 981.3 1000.9 4015.4 4093.8 4127.2 4153.0 4153.1 11174.6 11412.3 11594.8 11617.8 11623.0 11452.3 11467.9 11493.6 11520.7 11536.9 7990.4 8130.7 8143.3 8169.2 8321.9 5791.9 5888.4 6023.4 6092.9 6095.9 10290.6 10313.3 10508.7 10519.4 10538.2 10206.9 10486.5 10693.5 10791.3 10798.6 6775.1 7845.5 8078.5 8126.8 8257.1 9057.9 9063.9 9124.3 9130.6 9151.8 7633.5 7859.6 8027.3 8030.6 8162.8 7719.2 7815.1 7848.0 7849.9 7931.1 6872.4 6877.8 6879.1 6902.8 6955.3 4974.2 5077.8 5092.1 5162.0 5177.9 5178.5 5268.0 5282.0 5372.4 5400.8 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#4] prototype.html Cycles:180 Average:4752.53 Median:5391.80 stddev:1408.69 (26.1%) stddev-sans-first:1372.91 07:25:52 INFO - PROCESS | 10844 | Values: 326.5 330.5 338.7 340.6 340.7 5295.6 5318.7 5388.7 5398.3 5448.9 5338.1 5372.7 5381.6 5396.0 5403.1 3971.3 4032.6 4108.6 4153.6 4234.2 4162.9 4200.0 4217.8 4218.9 4231.7 4003.7 4184.1 4191.6 4195.1 4202.9 4073.8 4084.2 4109.5 4150.7 4206.1 3699.7 3701.9 3704.8 3716.1 3729.3 5037.2 5256.9 5261.1 5262.4 5267.8 4737.2 4773.6 4777.7 4807.7 4837.4 5497.2 5564.4 5603.5 5636.4 5669.5 4070.1 4073.1 4083.2 4093.5 4101.5 5632.6 5923.4 5937.4 5938.0 5941.8 4106.6 4119.4 4120.1 4120.4 4121.5 4170.5 4170.9 4180.5 4182.5 4182.9 4684.2 4787.9 4788.3 4798.1 4810.2 5694.8 5703.9 5732.6 5733.6 5742.9 1406.0 1426.0 1427.1 1427.2 1429.4 882.8 901.6 902.7 947.8 963.1 5371.1 5374.8 5378.8 5379.7 5384.5 5760.2 5762.0 5770.9 5776.4 5790.6 5133.2 5347.4 5374.0 5394.9 5405.7 3043.7 3055.0 3055.2 3064.8 3070.0 5665.5 5891.9 5909.3 5947.8 5958.8 5880.9 5921.4 5924.9 5935.7 5960.9 5986.4 6017.2 6025.3 6038.5 6045.1 5597.7 5793.6 5797.4 5802.1 5851.4 5660.5 5726.5 5731.7 5735.3 5747.9 5882.6 5982.9 5994.5 6019.3 6031.9 4055.4 4115.4 4124.8 4133.1 4137.3 5792.5 5793.2 5797.2 5860.0 5907.1 5622.5 5754.7 5755.8 5765.3 5767.8 5610.1 5696.7 5745.8 5748.8 5750.7 5322.5 5362.5 5583.7 5590.3 5596.2 5701.3 5715.2 5727.3 5732.3 5762.9 5425.5 5613.5 5616.0 5624.4 5635.4 07:25:52 INFO - PROCESS | 10844 | 07:25:52 INFO - PROCESS | 10844 | [#5] yui.html Cycles:180 Average:22249.86 Median:4587.78 stddev:32457.20 (707.5%) stddev-sans-first:32508.30 07:25:52 INFO - PROCESS | 10844 | Values: 801.6 823.2 833.5 848.7 883.7 15115.4 16871.2 17445.8 17460.6 17472.9 15617.2 15656.5 15691.8 16233.1 16380.1 801.8 826.4 826.9 829.5 830.0 680.3 802.3 824.4 828.3 836.5 859.2 862.5 865.2 865.4 865.7 711.2 850.8 851.5 851.7 852.1 614.1 628.7 630.5 635.1 635.4 14155.2 14172.1 14180.8 14271.4 14272.9 14444.2 14848.0 14894.8 14908.0 15085.8 13170.9 13203.3 13258.9 13398.8 13996.0 4554.9 4593.9 4631.3 4755.5 4795.9 74473.6 77549.5 77559.6 78349.0 78421.0 11844.2 11873.2 11895.5 11967.0 12189.8 21578.0 22987.0 23047.0 23062.3 23136.4 9330.2 9363.2 9385.2 9401.0 9736.8 4967.5 5017.7 5019.0 5039.2 5040.0 3536.6 3642.2 3646.4 3648.5 3649.1 653.3 655.8 657.0 679.7 680.7 734.7 749.0 749.9 752.2 768.3 9638.2 9921.6 10514.6 10568.4 10572.4 633.7 701.4 750.2 771.3 803.0 4564.7 4581.6 4640.7 4648.4 4692.3 118587.8 118736.0 126811.4 129960.4 130600.0 106065.0 106891.0 108066.0 108607.5 110385.0 92639.0 94187.5 95161.5 95441.0 95787.0 9545.3 9881.8 9884.3 9901.2 9907.3 52644.2 53536.7 54647.7 55548.4 56596.2 73725.6 83572.0 84068.0 84672.6 86925.0 11487.7 12711.0 13112.3 13146.5 13148.0 14039.7 14538.7 14715.0 15788.7 15890.3 12857.7 14177.4 14504.4 14525.5 14610.9 14362.9 14737.2 14804.8 15275.5 15330.8 14183.3 14494.5 14817.9 14928.9 15216.2 11220.1 11326.0 11330.9 11368.6 11419.9 11191.8 11716.6 11874.6 12088.2 12216.8 07:25:52 INFO - PROCESS | 10844 | -------- Summary: end -------- 07:25:52 INFO - PROCESS | 10844 | 07:25:53 INFO - TEST-INFO | 10844: exit 0 07:25:53 INFO - TEST-OK | dromaeo_css | took 1113523ms 07:25:53 INFO - TEST-START | kraken 07:25:53 INFO - operating with platform_type : linux_ 07:25:53 INFO - Initialising browser for kraken test... 07:25:53 INFO - TEST-INFO | started process 11030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zKF43/profile http://localhost:33890/getInfo.html) 07:25:57 INFO - PROCESS | 11030 | __metrics Screen width/height:1600/1200 07:25:57 INFO - PROCESS | 11030 | colorDepth:24 07:25:57 INFO - PROCESS | 11030 | Browser inner width/height: 1024/697 07:25:57 INFO - PROCESS | 11030 | __metrics 07:25:58 ERROR - PROCESS | 11030 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:25:59 INFO - TEST-INFO | 11030: exit 0 07:25:59 INFO - Browser initialized. 07:25:59 INFO - Running cycle 1/1 for kraken test... 07:25:59 INFO - TEST-INFO | started process 11110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zKF43/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:10 INFO - PROCESS | 11110 | RSS: Main: 155537408 07:26:10 INFO - PROCESS | 11110 | 07:26:13 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33890/tests/kraken/driver.html?testName=audio-beat-detection) 07:26:14 INFO - PROCESS | 11110 | RSS: Main: 213778432 07:26:14 INFO - PROCESS | 11110 | 07:26:17 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33890/tests/kraken/driver.html?testName=audio-dft) 07:26:17 INFO - PROCESS | 11110 | RSS: Main: 202072064 07:26:17 INFO - PROCESS | 11110 | 07:26:20 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33890/tests/kraken/driver.html?testName=audio-fft) 07:26:21 INFO - PROCESS | 11110 | RSS: Main: 268124160 07:26:21 INFO - PROCESS | 11110 | 07:26:23 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33890/tests/kraken/driver.html?testName=audio-oscillator) 07:26:24 INFO - PROCESS | 11110 | RSS: Main: 178814976 07:26:24 INFO - PROCESS | 11110 | 07:26:26 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33890/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:26:26 INFO - PROCESS | 11110 | RSS: Main: 182919168 07:26:26 INFO - PROCESS | 11110 | 07:26:29 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33890/tests/kraken/driver.html?testName=imaging-darkroom) 07:26:30 INFO - PROCESS | 11110 | RSS: Main: 217792512 07:26:30 INFO - PROCESS | 11110 | 07:26:33 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33890/tests/kraken/driver.html?testName=imaging-desaturate) 07:26:34 INFO - PROCESS | 11110 | RSS: Main: 220127232 07:26:34 INFO - PROCESS | 11110 | 07:26:37 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33890/tests/kraken/driver.html?testName=json-parse-financial) 07:26:37 INFO - PROCESS | 11110 | RSS: Main: 219709440 07:26:37 INFO - PROCESS | 11110 | 07:26:39 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33890/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:39 INFO - PROCESS | 11110 | RSS: Main: 206753792 07:26:39 INFO - PROCESS | 11110 | 07:26:41 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:42 INFO - PROCESS | 11110 | RSS: Main: 211259392 07:26:42 INFO - PROCESS | 11110 | 07:26:44 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:45 INFO - PROCESS | 11110 | RSS: Main: 218521600 07:26:45 INFO - PROCESS | 11110 | 07:26:47 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:48 INFO - PROCESS | 11110 | RSS: Main: 223395840 07:26:48 INFO - PROCESS | 11110 | 07:26:50 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:51 INFO - PROCESS | 11110 | RSS: Main: 224088064 07:26:51 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | Cycle 1(1): loaded http://localhost:33890/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33890/tests/kraken/driver.html?testName=ai-astar) 07:26:53 INFO - PROCESS | 11110 | RSS: Main: 266215424 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | __start_tp_report 07:26:53 INFO - PROCESS | 11110 | _x_x_mozilla_page_load 07:26:53 INFO - PROCESS | 11110 | _x_x_mozilla_page_load_details 07:26:53 INFO - PROCESS | 11110 | |i|pagename|runs| 07:26:53 INFO - PROCESS | 11110 | |0;ai-astar;112;105;109;113;112;111;110;111;111;111 07:26:53 INFO - PROCESS | 11110 | |1;audio-beat-detection;159;124;126;181;128;129;156;131;151;124 07:26:53 INFO - PROCESS | 11110 | |2;audio-dft;160;160;160;160;160;161;162;162;161;161 07:26:53 INFO - PROCESS | 11110 | |3;audio-fft;75;74;75;137;77;76;74;75;98;75 07:26:53 INFO - PROCESS | 11110 | |4;audio-oscillator;85;85;106;85;85;85;122;85;84;131 07:26:53 INFO - PROCESS | 11110 | |5;imaging-gaussian-blur;117;116;116;116;117;116;117;116;117;117 07:26:53 INFO - PROCESS | 11110 | |6;imaging-darkroom;146;146;146;145;146;147;146;146;145;146 07:26:53 INFO - PROCESS | 11110 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;95 07:26:53 INFO - PROCESS | 11110 | |8;json-parse-financial;53;51;51;52;51;53;51;52;53;52 07:26:53 INFO - PROCESS | 11110 | |9;json-stringify-tinderbox;62;62;64;63;64;62;65;65;66;64 07:26:53 INFO - PROCESS | 11110 | |10;stanford-crypto-aes;78;79;78;81;79;81;82;85;116;87 07:26:53 INFO - PROCESS | 11110 | |11;stanford-crypto-ccm;131;120;131;128;128;144;120;124;138;124 07:26:53 INFO - PROCESS | 11110 | |12;stanford-crypto-pbkdf2;157;159;160;157;158;160;159;163;161;155 07:26:53 INFO - PROCESS | 11110 | |13;stanford-crypto-sha256-iterative;65;64;63;62;64;62;63;63;61;60 07:26:53 INFO - PROCESS | 11110 | __end_tp_report 07:26:53 INFO - PROCESS | 11110 | __start_cc_report 07:26:53 INFO - PROCESS | 11110 | _x_x_mozilla_cycle_collect,1634 07:26:53 INFO - PROCESS | 11110 | __end_cc_report 07:26:53 INFO - PROCESS | 11110 | __startTimestamp1465136813491__endTimestamp 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | ------- Summary: start ------- 07:26:53 INFO - PROCESS | 11110 | Number of tests: 14 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.22 (2.0%) stddev-sans-first:2.29 07:26:53 INFO - PROCESS | 11110 | Values: 112.0 105.0 109.0 113.0 112.0 111.0 110.0 111.0 111.0 111.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:141.00 stddev:19.62 (13.9%) stddev-sans-first:19.69 07:26:53 INFO - PROCESS | 11110 | Values: 159.0 124.0 126.0 181.0 128.0 129.0 156.0 131.0 151.0 124.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 07:26:53 INFO - PROCESS | 11110 | Values: 160.0 160.0 160.0 160.0 160.0 161.0 162.0 162.0 161.0 161.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:20.11 (26.8%) stddev-sans-first:21.09 07:26:53 INFO - PROCESS | 11110 | Values: 75.0 74.0 75.0 137.0 77.0 76.0 74.0 75.0 98.0 75.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:17.85 (21.0%) stddev-sans-first:18.53 07:26:53 INFO - PROCESS | 11110 | Values: 85.0 85.0 106.0 85.0 85.0 85.0 122.0 85.0 84.0 131.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:26:53 INFO - PROCESS | 11110 | Values: 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:26:53 INFO - PROCESS | 11110 | Values: 146.0 146.0 146.0 145.0 146.0 147.0 146.0 146.0 145.0 146.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:26:53 INFO - PROCESS | 11110 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.88 (1.7%) stddev-sans-first:0.83 07:26:53 INFO - PROCESS | 11110 | Values: 53.0 51.0 51.0 52.0 51.0 53.0 51.0 52.0 53.0 52.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.36 07:26:53 INFO - PROCESS | 11110 | Values: 62.0 62.0 64.0 63.0 64.0 62.0 65.0 65.0 66.0 64.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:81.00 stddev:11.42 (14.1%) stddev-sans-first:11.86 07:26:53 INFO - PROCESS | 11110 | Values: 78.0 79.0 78.0 81.0 79.0 81.0 82.0 85.0 116.0 87.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:129.50 stddev:7.66 (5.9%) stddev-sans-first:8.08 07:26:53 INFO - PROCESS | 11110 | Values: 131.0 120.0 131.0 128.0 128.0 144.0 120.0 124.0 138.0 124.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:159.50 stddev:2.28 (1.4%) stddev-sans-first:2.32 07:26:53 INFO - PROCESS | 11110 | Values: 157.0 159.0 160.0 157.0 158.0 160.0 159.0 163.0 161.0 155.0 07:26:53 INFO - PROCESS | 11110 | 07:26:53 INFO - PROCESS | 11110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.33 07:26:53 INFO - PROCESS | 11110 | Values: 65.0 64.0 63.0 62.0 64.0 62.0 63.0 63.0 61.0 60.0 07:26:53 INFO - PROCESS | 11110 | -------- Summary: end -------- 07:26:53 INFO - PROCESS | 11110 | 07:26:54 INFO - TEST-INFO | 11110: exit 0 07:26:54 INFO - TEST-OK | kraken | took 60934ms 07:26:54 INFO - SUITE-END | took 1174s 07:26:54 INFO - Completed test suite (00:19:34) 07:26:54 INFO - javascript benchmark 07:26:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.1405863387567, 3139.2465808206007, 3158.9417545122374, 3181.8090914545114, 3203.07110937828, 5281.471852814717, 5352.598555108373, 5486.890262194754, 5577.888442231153, 5579.1910173024935, 5379.408265090837, 5467.480589344006, 5488.807891723791, 5498.917516237249, 5517.724113794305, 4921.212605983034, 4951.232558953368, 5003.099442100421, 5016.623753218505, 5189.325387699612, 5076.213186956028, 5082.415522214956, 5123.129068058439, 5128.205128205134, 5143.485651434845, 4798.4001999750035, 4824.276358546211, 4944.307796908436, 4973.403191616993, 5027.547520723152, 4940.382452193476, 4969.279454479117, 4979.551840334351, 5030.647854650176, 5086.262491938648, 4986.252062190664, 4998.125328067574, 5019.623528235397, 5033.219850923113, 5082.390113186404, 5238.371395432572, 5388.1648344506275, 5446.945530544684, 5530.668159910419, 5533.253010843525, 5936.584439089265, 5944.464998150144, 5968.4031596840405, 5985.790497332572, 5987.191729116557, 5704.486596206361, 5958.076498142795, 6008.158857759873, 6013.879722405527, 6017.277926648786, 5360.088784906575, 5449.782008719686, 5451.1005684062475, 5454.972725136349, 5455.427180146107, 5934.910976335358, 5979.850503737442, 5984.640921544721, 5985.850353741192, 5986.610870293417, 5771.682557459296, 5852.209951656557, 5896.64620122794, 5899.793507227227, 5908.291005079418, 5975.79084732041, 5990.670513121733, 6010.038393856962, 6022.066579680157, 6026.849328766816, 5617.719114044281, 5804.65172089676, 5809.970950145307, 5812.564057695689, 5820.592558520862, 5895.616784908967, 5923.792667256712, 5962.07587823888, 5963.671998040063, 5965.045592705146, 4413.271810151289, 4417.249067658506, 4426.955730442719, 4427.889302767457, 4431.313146462304, 3877.166409222031, 3925.1953349563273, 3933.272344616255, 3933.8229779659982, 3984.1633257015774, 5482.671039737628, 5493.23094766733, 5499.972500137474, 5562.082256427644, 5567.777288908398, 5940.01989671708, 5942.10868369748, 5947.167396564484, 5947.702614869239, 5995.250593675791, 5343.759530821122, 5557.972210138923, 5566.471185237396, 5569.749361278752, 5571.275734154615, 4801.591864691541, 4892.3884514435695, 4897.706137631753, 4920.40955085392, 4927.90144197114, 6071.939280607226, 6073.14975903365, 6073.544484163705, 6074.42292982166, 6098.024316109401, 5723.0, 5858.355580886014, 5861.794837180678, 5912.911306330495, 5919.733611987557, 6129.84675383119, 6181.505479561534, 6186.381361863958, 6187.566870319034, 6189.6286222826775, 5865.94134058654, 5872.94127058741, 5875.383084776037, 5882.352941176381, 5919.319278283053, 5675.347335056521, 5925.851853703692, 5964.373740757158, 5979.162917191509, 5981.282246130492, 5636.9436305638055, 5682.460166284196, 5702.287214098238, 5739.311282646109, 5746.3966283541295, 5699.971500142473, 5725.770969161187, 5738.913916291175, 5744.339400968942, 5763.538916886723, 5420.322459692538, 5638.802641907678, 5648.519875810603, 5658.321001479849, 5662.122371032497, 5844.824655260349, 5873.236479257669, 5885.028970219866, 5907.054871220584, 5939.10913362999, 5658.179563963285, 5659.26429564154, 5662.858428539154, 5667.1782591524825, 5705.686187259741], "value": 5415.753425273129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.3023002626874, 624.581530374649, 626.9122322874797, 633.8447080465287, 637.9170707807984, 32191.356172876527, 44641.33038004429, 45231.321530177076, 45304.14914732244, 45408.0, 45239.0, 45569.54430455694, 45682.54317456824, 45716.0, 45773.54226457734, 7974.601269936509, 8563.914360856405, 8814.955925220365, 8820.691275805348, 10382.9480852596, 10114.494275286243, 10444.477776111164, 10502.684919452391, 10522.631707890225, 10528.842067368996, 10511.106555942753, 10551.78896422071, 10575.841362379571, 10584.576616935314, 10585.947070264638, 10476.476176191198, 10535.894641053568, 10554.102901253325, 10554.261201715883, 10555.472226388727, 10494.212934029978, 10606.840897386546, 10610.257281990263, 10613.9469302653, 10615.57537698491, 43028.354574681405, 43507.78246108749, 43543.56456435427, 43562.346564801555, 43625.34561981573, 3569.7501174917766, 4022.1754540319166, 4054.2904991626347, 4192.993681516445, 4331.696781225315, 31887.149835509965, 32537.83731081353, 32601.510977335358, 33062.17344566381, 33608.6639133608, 4332.371806088131, 4340.218760623086, 4345.67407444443, 4372.322290045048, 4530.980529380896, 248687.0, 248825.0, 248899.0, 248942.0, 249555.0, 34970.47544286838, 57900.710496447246, 57985.420145798, 58356.4164358351, 58465.41534584685, 36775.816120919226, 37017.444738328944, 37115.072123196594, 37175.81412092976, 37218.25563488769, 14189.858101418853, 14267.500637477639, 14286.071405358827, 14286.928565357106, 14300.284985750672, 12193.32936688473, 12877.613671589866, 12933.224006559636, 13119.0, 13125.278109704059, 8371.414001019992, 8381.07808141104, 8457.619407126695, 8476.321894248445, 8524.914750852537, 3090.922726931845, 3188.2985743136474, 3258.6212065192544, 3284.3759685659647, 3328.9334213315597, 1022.5705203814416, 1059.3157178205395, 1142.6176422159724, 1152.389233706137, 1207.1188032735977, 33188.668113318556, 33331.500027499605, 33419.83290083534, 33448.0, 33967.83016084904, 1138.8804175561613, 1175.4769127738246, 1223.2843786384888, 1267.1636719765095, 1274.7960326347925, 17140.0, 17648.382306619205, 17648.735268970977, 17672.11639418024, 17706.5573360667, 170055.0, 170225.0, 170540.0, 170643.0, 171558.14220929064, 59047.70476147592, 59618.105728414106, 59711.701441492514, 59733.104003439985, 60049.699751500964, 1296.4554886947506, 1382.384838746768, 1425.4369524038154, 1430.306301443799, 1431.992840035793, 32576.34847302993, 33953.32093358169, 34250.48624270688, 34312.97061088171, 34564.65435345715, 49289.0, 49948.75025624849, 50028.499715002385, 50073.0, 50093.49906501034, 336626.6337336595, 343926.0, 344905.0, 344909.0, 345426.0, 25355.36611584725, 26984.190474285802, 27512.724872751816, 27755.86122069377, 29269.121926342243, 47186.29220561763, 47672.28491572699, 47783.761081194374, 48160.27759583539, 49372.0, 40733.1853362937, 41399.68802495853, 41520.37719434271, 42630.5736942639, 43417.0, 40927.0, 41397.379039315034, 41431.585684142774, 41912.0, 42245.36631950585, 41237.0, 41472.792636036625, 42277.78861105798, 43054.569454305056, 43113.56886431095, 34388.312233755685, 37010.8149459251, 37132.81433592923, 37472.62527374691, 37821.0, 27958.58062129029, 28422.43155136844, 28434.0, 28530.42939141164, 28577.28556786097], "value": 18642.65312485757, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.79473631741604, 389.88693278949125, 393.3647159836861, 400.6674460198035, 418.7152736139426, 14258.857411425883, 16572.751408728847, 18187.090645467724, 19616.215351385927, 19635.0, 18722.251109955585, 19092.427227183205, 19128.33050843221, 19200.0, 19310.420687379366, 5474.069408200596, 5612.102063669814, 5645.887082258352, 5701.116326969326, 5701.2018317435595, 4001.9199616007663, 4179.770112643803, 5400.216968539559, 5564.276644036269, 5582.190582365554, 5914.674692891911, 6222.284437289702, 6222.906656400158, 6343.207099112611, 6352.968235158841, 5293.073712100367, 5545.3622833374275, 5547.0, 6289.0, 6312.3687631236735, 5434.429384914567, 5435.402105768402, 5441.83674489766, 5460.563154947595, 5466.535344495683, 13836.0, 20092.799072009384, 22113.44716382087, 22157.562668106497, 22189.667154992687, 2316.2819525946843, 2466.062896099471, 2469.2098528470897, 2797.2727090956296, 2941.2058744138963, 8996.505192214425, 9594.088561586637, 9596.904030959671, 9652.806943861153, 10224.74438139045, 1816.7184086466618, 1848.8613353998503, 1853.4902901702005, 1930.3822776711459, 1968.625961067407, 84163.0, 84694.0, 89355.55322223413, 89966.0, 90602.0, 10743.409112498888, 10774.569017239222, 10960.506777195045, 11032.669019929415, 11171.273867198606, 13257.66855828612, 13944.511942082181, 14764.26178691061, 15375.538733838002, 15421.151836649093, 8213.835723285501, 8335.333173346118, 8425.70510032146, 8565.528895910784, 8607.096254893271, 7980.920190798134, 8114.675412983533, 8328.625211865481, 8359.643513708019, 8508.489490630582, 4567.931481027787, 4725.740084295397, 4786.593139583105, 4792.376990991149, 4806.206975849016, 1902.9904850475937, 1933.2750218668, 1938.3797184900695, 1939.2921583621876, 1960.1277431542826, 909.9226565741853, 961.3222678012124, 966.917811985989, 1038.7610849504506, 1053.199568328076, 18253.543661408305, 18473.7228941566, 18658.53353666142, 18770.155343009596, 19081.61836763257, 1000.6997900629927, 1022.8107800057013, 1023.7031260934394, 1041.250299784154, 1048.580567772897, 9454.33819632633, 10475.685729428129, 10555.208359373079, 10562.947185264178, 10609.469526523642, 500447.0, 505430.97162149986, 511374.0, 512262.0, 513954.0, 58060.07178263485, 95321.0, 95698.52150739341, 96439.51780241054, 99402.0, 997.9151772099453, 1011.261778901406, 1020.9183265338903, 1035.0, 1043.5669197283044, 16514.42199523011, 16598.0, 16733.832661673227, 16833.326666933677, 16882.409115680894, 26734.105477999885, 34647.0, 35723.82138089293, 39616.0, 42841.0, 53665.46334536605, 54933.17600236079, 54937.0, 55012.72493637506, 55279.17081243865, 6858.6570671467225, 7140.0, 7435.293647103516, 8155.266026057683, 8418.284445822173, 12458.190217635825, 12517.56188533397, 12644.30456324911, 12654.936725316315, 12761.425735841724, 10683.89316106829, 11003.33979961205, 11019.944900275448, 11155.55377784912, 11357.204995650556, 10981.121510279, 10981.61564345244, 11231.831522527005, 11296.265742726697, 11394.316341019234, 11077.889221107685, 11250.7749845001, 11315.434228288388, 11488.138389620644, 11573.247738896946, 7193.5324203926575, 7267.890981635385, 7469.290417410337, 7643.808904777425, 7744.7676569703, 9016.368854180144, 11147.163962702993, 11224.887751122384, 11259.155563332946, 11320.773584528428], "value": 8968.859851346544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.2882957617676, 1525.4127161042995, 1550.1786748118425, 1728.9394871179504, 1856.4709057918496, 8455.49267043977, 8862.113788621135, 8872.822543549126, 9095.0904909509, 9107.362484626063, 8811.295096392289, 9009.864852027225, 9028.954855225731, 9040.72877813665, 9054.818903621923, 2047.7952204779551, 2236.563870045342, 2312.0867257433306, 2373.679553260309, 2402.507485965373, 2386.95226095478, 2392.8923198456023, 2397.712274527059, 2399.244238065004, 2411.05968672218, 2399.7720216579396, 2420.0, 2429.441228517433, 2431.3070774829175, 2437.609982402816, 1972.0829814136423, 2243.5737209930144, 2256.8307376946796, 2331.848429852071, 2341.5785158671433, 2307.803836673868, 2338.3920180753125, 2341.0635745701684, 2341.8946147423235, 2362.11420717231, 8948.373613847034, 9103.13520215585, 9114.544272786401, 9116.58975346111, 9120.81758364829, 5355.410904800468, 5515.145152501369, 5516.448355164492, 5520.0, 5526.0, 3253.6908993645566, 3386.407378708741, 3428.0915557377316, 3432.1076520104953, 3450.05123591012, 1060.4220699718594, 1101.1961268274204, 1107.7230692326918, 1113.209621168963, 1118.7762447510531, 12622.368881555885, 12626.873731262662, 12631.115821892472, 12642.620721378373, 12662.55681051168, 4722.058845334557, 4801.927971080437, 4851.660383773173, 4863.8540843774745, 4902.460729319772, 10526.578936842594, 10531.420771857622, 10554.2084343673, 10566.154707623526, 10577.418241996764, 5192.1952097424955, 5192.221166824931, 5226.660267082628, 5230.790768369223, 5233.1365324721755, 4239.703220774578, 4860.902781944341, 4986.301917731521, 4996.525330093636, 5045.192769156991, 4010.4585880905706, 4042.543669913658, 4083.734557253769, 4161.52142503616, 4164.0, 1269.3843485909326, 1281.1608396500308, 1281.493809945085, 1287.8905293050009, 1297.545858949379, 956.5073986896754, 978.4862946952907, 982.6757170133839, 1000.0599436529639, 1002.2533212756543, 5896.823095307148, 5930.05119180929, 5958.940410595926, 6006.819795406145, 6096.908546371808, 949.1410273702311, 951.857221416793, 979.8187335342842, 981.293468702533, 1000.8548760429696, 4015.417764424142, 4093.7953102344763, 4127.215828992482, 4153.0, 4153.127843152912, 11174.553017879356, 11412.315261084195, 11594.76810463803, 11617.825732614017, 11623.0, 11452.255603385753, 11467.942660286646, 11493.597724079784, 11520.711982200512, 11536.884631153582, 7990.360771138295, 8130.674773009132, 8143.307818835466, 8169.223923727236, 8321.875171872547, 5791.8552036199435, 5888.440598143169, 6023.427774361428, 6092.908606370819, 6095.9390406097145, 10290.588376465157, 10313.329633573794, 10508.737281568023, 10519.421431821018, 10538.156947444339, 10206.897931020594, 10486.528106235086, 10693.465326733787, 10791.298565593212, 10798.622048228275, 6775.119234499483, 7845.529268243924, 8078.515289082674, 8126.75619731409, 8257.05043919957, 9057.864132037894, 9063.864042039242, 9124.266389385995, 9130.589123489326, 9151.816963660556, 7633.503822251758, 7859.567723775247, 8027.2775450209765, 8030.598470076356, 8162.83674326522, 7719.228077192236, 7815.062192536932, 7848.018997625297, 7849.882251766114, 7931.127575966754, 6872.41584465326, 6877.759278425231, 6879.140107486564, 6902.758403455855, 6955.339242771928, 4974.154393752999, 5077.7968881245815, 5092.108880945893, 5161.974190129025, 5177.92233116496, 5178.456262092426, 5267.9736601316745, 5281.973590132025, 5372.355317361941, 5400.83797486076], "value": 4726.611252812416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.4874147588286, 330.4778450048923, 338.74424809269004, 340.5521738913327, 340.65934065934067, 5295.576353891689, 5318.680879147254, 5388.703621300827, 5398.325209348832, 5448.902172663528, 5338.145896656536, 5372.7045012524395, 5381.569474442045, 5396.0, 5403.081476149055, 3971.285168669638, 4032.5967403259733, 4108.609682080212, 4153.584641535853, 4234.153169366139, 4162.8959276018195, 4199.979000104995, 4217.789110544476, 4218.915621687564, 4231.661467082641, 4003.7397569158056, 4184.121334519755, 4191.580841915815, 4195.098053918407, 4202.91594168118, 4073.775942323171, 4084.202321409844, 4109.486314210723, 4150.667946564297, 4206.116715489751, 3699.68661125302, 3701.9259614807825, 3704.833282502267, 3716.145286584074, 3729.3473642112795, 5037.244413337992, 5256.8685782855355, 5261.105612045962, 5262.394824595182, 5267.815626453055, 4737.218358970766, 4773.570378665937, 4777.665563410563, 4807.711537307773, 4837.419509658828, 5497.175423686439, 5564.443555644443, 5603.467670571289, 5636.351819540723, 5669.489745922846, 4070.1249231415386, 4073.103917138225, 4083.244599749056, 4093.5087789465456, 4101.52832424272, 5632.633878797906, 5923.378045305224, 5937.435943585352, 5937.970310148422, 5941.792037278675, 4106.589341065929, 4119.443875076886, 4120.114175452292, 4120.361343991686, 4121.505419349637, 4170.457840480718, 4170.874873753793, 4180.519240287406, 4182.473397210058, 4182.916341673211, 4684.158989628472, 4787.928181077286, 4788.329633851264, 4798.104748624343, 4810.2063159578975, 5694.772209111672, 5703.885922281531, 5732.598718089694, 5733.627314224562, 5742.851429714074, 1405.9947137796526, 1425.9714805703827, 1427.0866645346987, 1427.2364285107417, 1429.3782204740971, 882.8013696918142, 901.5762591581946, 902.6795487601938, 947.8483642374548, 963.0802583532709, 5371.140617501181, 5374.838754837361, 5378.757955891994, 5379.731013449312, 5384.542313903362, 5760.193572899798, 5762.049261871744, 5770.913436298459, 5776.393478684761, 5790.594658373873, 5133.204353325241, 5347.358317001985, 5374.005808925362, 5394.892102158014, 5405.675659460445, 3043.691212778482, 3054.9694503054684, 3055.220918665726, 3064.7701422392965, 3069.969300307013, 5665.461781130868, 5891.852703682356, 5909.261342332208, 5947.762089516371, 5958.761649534057, 5880.941190588125, 5921.437463440966, 5924.933511967801, 5935.673537955454, 5960.910586341209, 5986.431289027535, 6017.247844019497, 6025.312912384539, 6038.456538911431, 6045.093236014545, 5597.720113994365, 5793.565482588907, 5797.43469263305, 5802.098950524738, 5851.385604511465, 5660.547156227574, 5726.482482142153, 5731.684757338387, 5735.304406928737, 5747.872637929022, 5882.558808089325, 5982.8632559813495, 5994.490468310068, 6019.337872834072, 6031.939680603314, 4055.3916912463364, 4115.444415003936, 4124.752514849119, 4133.111381053088, 4137.275976704004, 5792.478676919098, 5793.246877905845, 5797.159391898024, 5859.970700146642, 5907.054871220584, 5622.522085622768, 5754.741036653277, 5755.827325180251, 5765.308163020464, 5767.798127065533, 5610.102383618601, 5696.658200507983, 5745.827625171251, 5748.798792042426, 5750.6837123958585, 5322.467753224647, 5362.544183744425, 5583.720813959367, 5590.301212348457, 5596.216529685766, 5701.344345400166, 5715.199872018004, 5727.31272247333, 5732.337622089714, 5762.884742305214, 5425.528213641432, 5613.46672066153, 5615.971920140373, 5624.409437009055, 5635.435876676021], "value": 4299.223439942474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.563148084294, 823.1685997142886, 833.4915701422135, 848.6817443458699, 883.7260449260727, 15115.395384184632, 16871.24079416426, 17445.82554174458, 17460.563485912844, 17472.912635436805, 15617.21913904303, 15656.530304090868, 15691.84308156918, 16233.107179105144, 16380.099094549794, 801.7714951238898, 826.396730386818, 826.9255766980971, 829.5188790501495, 829.9751007469786, 680.3332733920761, 802.2819576479047, 824.4146655874337, 828.2628460670009, 836.5357226739158, 859.2138193552922, 862.525610913998, 865.2342676731107, 865.3812524045306, 865.6926790989203, 711.1501755402296, 850.8128211793396, 851.5018714052287, 851.6593362654957, 852.0925214646413, 614.1340709599443, 628.7296462521114, 630.533405280094, 635.1457289945016, 635.4027214418478, 14155.150690958575, 14172.149671019668, 14180.787288190686, 14271.429142834275, 14272.92863535686, 14444.205568693718, 14848.0, 14894.776578351333, 14908.0, 15085.773713394308, 13170.934145329307, 13203.2738199399, 13258.867411325957, 13398.799018014737, 13996.0, 4554.8861278467975, 4593.931091033637, 4631.328457373662, 4755.476897541268, 4795.904081918342, 74473.62763186204, 77549.46955834853, 77559.61220193919, 78349.0, 78421.0, 11844.230125041844, 11873.168878178445, 11895.524179032915, 11967.0, 12189.756204875854, 21578.0, 22987.0, 23047.0, 23062.30813075577, 23136.4215894604, 9330.160285574331, 9363.15731584147, 9385.15533601979, 9400.952995235117, 9736.805263894825, 4967.528084831935, 5017.67385119966, 5019.0, 5039.168537191323, 5040.0, 3536.5756109267054, 3642.162302670348, 3646.3983442732183, 3648.5074514940675, 3649.087728067983, 653.323809856796, 655.8425977765302, 656.9868602627921, 679.7009315900988, 680.7379159023811, 734.6693987705447, 748.9775306740806, 749.8612756640039, 752.2101793117314, 768.3469051306345, 9638.180754635794, 9921.553530091163, 10514.57941682324, 10568.365898046142, 10572.36565806054, 633.6989929783316, 701.428335906245, 750.2497502497503, 771.3289438188699, 802.955837428947, 4564.726116433025, 4581.633469322446, 4640.69835460694, 4648.418947631546, 4692.319613656001, 118587.8141218594, 118736.0, 126811.36594317154, 129960.3501982484, 130600.0, 106065.0, 106891.0, 108066.0, 108607.45696271468, 110385.0, 92639.0, 94187.52906235425, 95161.5241923786, 95441.0, 95787.0, 9545.331826772337, 9881.802363952824, 9884.30809843304, 9901.207903367856, 9907.256955728206, 52644.21033684421, 53536.66158346072, 54647.726761365935, 55548.44451555433, 56596.15105773335, 73725.6313718428, 83572.0, 84068.0, 84672.57663711642, 86925.0, 11487.725349111593, 12711.0, 13112.278824664734, 13146.539871104847, 13148.0, 14039.719205616035, 14538.709225815635, 14715.0, 15788.68422631564, 15890.284937178087, 12857.742845142857, 14177.362018708976, 14504.419823206954, 14525.4916077941, 14610.926945365205, 14362.856371436152, 14737.1894545801, 14804.777928330868, 15275.541733748005, 15330.846691533388, 14183.290835458392, 14494.492692755703, 14817.925910370379, 14928.925355373154, 15216.239188040776, 11220.11856004527, 11326.0, 11330.94334528322, 11368.602098926498, 11419.885801141882, 11191.776164476827, 11716.648500544998, 11874.584389546324, 12088.21426607303, 12216.816747748613], "value": 7938.354981668492, "unit": "score"}], "name": "dromaeo_css", "value": 7257.200424045629, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 109.0, 113.0, 112.0, 111.0, 110.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 126.0, 181.0, 128.0, 129.0, 156.0, 131.0, 151.0, 124.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 137.0, 77.0, 76.0, 74.0, 75.0, 98.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 106.0, 85.0, 85.0, 85.0, 122.0, 85.0, 84.0, 131.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 52.0, 51.0, 53.0, 51.0, 52.0, 53.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 63.0, 64.0, 62.0, 65.0, 65.0, 66.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 81.0, 79.0, 81.0, 82.0, 85.0, 116.0, 87.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 120.0, 131.0, 128.0, 128.0, 144.0, 120.0, 124.0, 138.0, 124.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 160.0, 157.0, 158.0, 160.0, 159.0, 163.0, 161.0, 155.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 61.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1498.8, "alertThreshold": 2.0}]} 07:26:54 INFO - Return code: 0 07:26:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:54 ERROR - # TBPL SUCCESS # 07:26:54 INFO - Running post-action listener: _resource_record_post_action 07:26:54 INFO - ##### 07:26:54 INFO - ##### Finished run-tests step (success) 07:26:54 INFO - ##### 07:26:54 INFO - Running post-run listener: _resource_record_post_run 07:26:54 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542777344; Read time: 8; Write time: 466540 07:26:54 INFO - TinderboxPrint: CPU usage
13.1% 07:26:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:26:54 INFO - TinderboxPrint: I/O write bytes / time
542,777,344 / 466,540 07:26:54 INFO - TinderboxPrint: CPU idle
8,271.2 (86.9%) 07:26:54 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 07:26:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:54 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247922688; Read time: 0; Write time: 243616 07:26:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294129664; Read time: 8; Write time: 222896 07:26:55 INFO - Running post-run listener: _upload_blobber_files 07:26:55 INFO - Blob upload gear active. 07:26:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:55 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:26:55 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:26:55 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:26:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:56 INFO - (blobuploader) - INFO - Done attempting. 07:26:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:27:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:01 INFO - (blobuploader) - INFO - Done attempting. 07:27:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:27:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:27:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:27:02 INFO - (blobuploader) - INFO - Done attempting. 07:27:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:27:02 INFO - Return code: 0 07:27:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:27:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:27:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bc3485680df92c9ecad099761ed03aabc2bd53ddf4d3c0f72c7bf7c52161fc3f62893389d8e88b475b9f883b4077f0cdfeb68e9788ef3339c7ff542d5ae6f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adcfa694af72c0a02774424eec8abcfcddf5e143b7cbaa645a561b0b2279e26f3393d91a21977678d38c1f2b233c7895911796e4497819c7cfeecac17102d8c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c036c8719996c029c7b05992c52743721d8ed79b6a4d5795cdcb6a9b6a8fa258f1cf1d7b2daee67400a3406529c7d94e0e757ae7688abe69471d538b288f7d5e"} 07:27:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:27:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:27:02 INFO - Contents: 07:27:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8bc3485680df92c9ecad099761ed03aabc2bd53ddf4d3c0f72c7bf7c52161fc3f62893389d8e88b475b9f883b4077f0cdfeb68e9788ef3339c7ff542d5ae6f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adcfa694af72c0a02774424eec8abcfcddf5e143b7cbaa645a561b0b2279e26f3393d91a21977678d38c1f2b233c7895911796e4497819c7cfeecac17102d8c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c036c8719996c029c7b05992c52743721d8ed79b6a4d5795cdcb6a9b6a8fa258f1cf1d7b2daee67400a3406529c7d94e0e757ae7688abe69471d538b288f7d5e"} 07:27:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:27:02 INFO - Copying logs to upload dir... 07:27:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:27:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.063430 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-05 07:27:01.989340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 07:27:01.992887) ========= 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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 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/8bc3485680df92c9ecad099761ed03aabc2bd53ddf4d3c0f72c7bf7c52161fc3f62893389d8e88b475b9f883b4077f0cdfeb68e9788ef3339c7ff542d5ae6f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adcfa694af72c0a02774424eec8abcfcddf5e143b7cbaa645a561b0b2279e26f3393d91a21977678d38c1f2b233c7895911796e4497819c7cfeecac17102d8c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c036c8719996c029c7b05992c52743721d8ed79b6a4d5795cdcb6a9b6a8fa258f1cf1d7b2daee67400a3406529c7d94e0e757ae7688abe69471d538b288f7d5e"} 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.011415 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/8bc3485680df92c9ecad099761ed03aabc2bd53ddf4d3c0f72c7bf7c52161fc3f62893389d8e88b475b9f883b4077f0cdfeb68e9788ef3339c7ff542d5ae6f5a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/adcfa694af72c0a02774424eec8abcfcddf5e143b7cbaa645a561b0b2279e26f3393d91a21977678d38c1f2b233c7895911796e4497819c7cfeecac17102d8c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c036c8719996c029c7b05992c52743721d8ed79b6a4d5795cdcb6a9b6a8fa258f1cf1d7b2daee67400a3406529c7d94e0e757ae7688abe69471d538b288f7d5e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 07:27:02.018386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:27:02.018732) ========= 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=ed14279e38b05397cf4aa391000001a4-1465131793.229080-1519668375 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 07:27:02.103559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 07:27:02.103884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 07:27:02.104186) ========= ========= Total master_lag: 0.16 =========