builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1465389856.53 results: success (0) buildid: 20160608030219 builduid: 0c11aa9677234146964981c620c0c4de revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.525379) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.525796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.526071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.535084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.535373) ========= 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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 05:44:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 129M=0s 2016-06-08 05:44:17 (129 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096749 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.697768) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.698102) ========= 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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009694 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:16.725524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 05:44:16.725857) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 05:44:17,602 truncating revision to first 12 chars 2016-06-08 05:44:17,602 Setting DEBUG logging. 2016-06-08 05:44:17,602 attempt 1/10 2016-06-08 05:44:17,602 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8ad071a6e14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 05:44:18,572 unpacking tar archive at: mozilla-central-f8ad071a6e14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.291981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 05:44:18.025966) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:18.026315) ========= script_repo_revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:18.026752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:18.027022) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 05:44:18.033326) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 05:44:18.033612) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:18 INFO - MultiFileLogger online at 20160608 05:44:18 in /builds/slave/test 05:44:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:44:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:18 INFO - {'append_to_log': False, 05:44:18 INFO - 'base_work_dir': '/builds/slave/test', 05:44:18 INFO - 'blob_upload_branch': 'Firefox', 05:44:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:18 INFO - 'branch': 'Firefox', 05:44:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:18 INFO - 'config_files': ('talos/linux_config.py',), 05:44:18 INFO - 'default_actions': ('clobber', 05:44:18 INFO - 'read-buildbot-config', 05:44:18 INFO - 'download-and-extract', 05:44:18 INFO - 'populate-webroot', 05:44:18 INFO - 'create-virtualenv', 05:44:18 INFO - 'install', 05:44:18 INFO - 'run-tests'), 05:44:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:18 INFO - 'download_minidump_stackwalk': True, 05:44:18 INFO - 'download_symbols': 'ondemand', 05:44:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:18 INFO - 'installer_path': 'installer.exe', 05:44:18 INFO - 'log_level': 'info', 05:44:18 INFO - 'log_name': 'talos', 05:44:18 INFO - 'log_to_console': True, 05:44:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:18 INFO - 'opt_config_files': (), 05:44:18 INFO - 'pip_index': False, 05:44:18 INFO - 'sps_profile': False, 05:44:18 INFO - 'sps_profile_interval': 0, 05:44:18 INFO - 'suite': 'dromaeojs', 05:44:18 INFO - 'system_bits': '32', 05:44:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:18 INFO - 'title': 'talos-linux64-ix-043', 05:44:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:18 INFO - 'use_talos_json': True, 05:44:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:18 INFO - 'work_dir': 'build'} 05:44:18 INFO - ##### 05:44:18 INFO - ##### Running clobber step. 05:44:18 INFO - ##### 05:44:18 INFO - Running pre-action listener: _resource_record_pre_action 05:44:18 INFO - Running main action method: clobber 05:44:18 INFO - rmtree: /builds/slave/test/build 05:44:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - ##### 05:44:19 INFO - ##### Finished clobber step (success) 05:44:19 INFO - ##### 05:44:19 INFO - ##### 05:44:19 INFO - ##### Running read-buildbot-config step. 05:44:19 INFO - ##### 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: read_buildbot_config 05:44:19 INFO - Using buildbot properties: 05:44:19 INFO - { 05:44:19 INFO - "project": "", 05:44:19 INFO - "product": "firefox", 05:44:19 INFO - "script_repo_revision": "production", 05:44:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:44:19 INFO - "repository": "", 05:44:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:44:19 INFO - "buildid": "20160608030219", 05:44:19 INFO - "stage_platform": "linux64-pgo", 05:44:19 INFO - "basedir": "/builds/slave/test", 05:44:19 INFO - "nightly_build": "True", 05:44:19 INFO - "buildnumber": 474, 05:44:19 INFO - "slavename": "talos-linux64-ix-043", 05:44:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:44:19 INFO - "platform": "ubuntu64_hw", 05:44:19 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:19 INFO - "branch": "mozilla-central", 05:44:19 INFO - "repo_path": "mozilla-central", 05:44:19 INFO - "revision": "f8ad071a6e14331d73fa44c8d3108bc2b66b2174", 05:44:19 INFO - "pgo_build": "True", 05:44:19 INFO - "builduid": "0c11aa9677234146964981c620c0c4de", 05:44:19 INFO - "slavebuilddir": "test" 05:44:19 INFO - } 05:44:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:44:19 INFO - Running post-action listener: _resource_record_post_action 05:44:19 INFO - ##### 05:44:19 INFO - ##### Finished read-buildbot-config step (success) 05:44:19 INFO - ##### 05:44:19 INFO - ##### 05:44:19 INFO - ##### Running download-and-extract step. 05:44:19 INFO - ##### 05:44:19 INFO - Running pre-action listener: _resource_record_pre_action 05:44:19 INFO - Running main action method: download_and_extract 05:44:19 INFO - mkdir: /builds/slave/test/build/tests 05:44: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')]} 05:44:19 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:44:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:44:22 INFO - Downloaded 1361 bytes. 05:44:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:44:22 INFO - Using the following test package requirements: 05:44:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:44:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'jsshell-linux-x86_64.zip'], 05:44:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:22 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:23 INFO - Downloaded 24450077 bytes. 05:44:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:24 INFO - Return code: 0 05:44:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:24 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:44:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:44:26 INFO - Downloaded 24450077 bytes. 05:44:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:44:27 INFO - Return code: 0 05:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:27 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:44:28 INFO - Downloaded 10833369 bytes. 05:44:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:44:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:44:29 INFO - Return code: 0 05:44: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')]} 05:44:29 INFO - https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:44:31 INFO - Downloaded 59230935 bytes. 05:44:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:31 INFO - mkdir: /builds/slave/test/properties 05:44:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:44:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:44:31 INFO - Contents: 05:44:31 INFO - build_url:https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:44:32 INFO - Running post-action listener: _resource_record_post_action 05:44:32 INFO - Running post-action listener: set_extra_try_arguments 05:44:32 INFO - ##### 05:44:32 INFO - ##### Finished download-and-extract step (success) 05:44:32 INFO - ##### 05:44:32 INFO - ##### 05:44:32 INFO - ##### Running populate-webroot step. 05:44:32 INFO - ##### 05:44:32 INFO - Running pre-action listener: _resource_record_pre_action 05:44:32 INFO - Running main action method: populate_webroot 05:44:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:32 INFO - '--tppagecycles', 05:44:32 INFO - '7'], 05:44:32 INFO - 'tests': ['tsvgm']}}, 05:44:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:44:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:44:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:44:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['damp', 'tps']}, 05:44:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'tests': ['damp', 'tps']}, 05:44:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['dromaeo_dom']}, 05:44:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['a11yr', 05:44:32 INFO - 'ts_paint', 05:44:32 INFO - 'tpaint', 05:44:32 INFO - 'sessionrestore', 05:44:32 INFO - 'sessionrestore_no_auto_restore', 05:44:32 INFO - 'tabpaint']}, 05:44:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['tsvgx', 05:44:32 INFO - 'tsvgr_opacity', 05:44:32 INFO - 'tart', 05:44:32 INFO - 'tscrollx', 05:44:32 INFO - 'cart']}, 05:44:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:44:32 INFO - 'tsvgr_opacity', 05:44:32 INFO - 'tart', 05:44:32 INFO - 'tscrollx', 05:44:32 INFO - 'cart']}, 05:44:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'talos_options': ['--disable-e10s'], 05:44:32 INFO - 'tests': ['tp5o']}, 05:44:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'tests': ['tp5o']}, 05:44:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'talos_options': ['--disable-e10s', 05:44:32 INFO - '--xperf_path', 05:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:32 INFO - 'tests': ['tp5n']}, 05:44:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:32 INFO - 'talos_options': ['--xperf_path', 05:44:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:32 INFO - 'tests': ['tp5n']}}, 05:44:32 INFO - 'talos.zip': {'path': '', 05:44:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:32 INFO - Running post-action listener: _resource_record_post_action 05:44:32 INFO - ##### 05:44:32 INFO - ##### Finished populate-webroot step (success) 05:44:32 INFO - ##### 05:44:32 INFO - ##### 05:44:32 INFO - ##### Running create-virtualenv step. 05:44:32 INFO - ##### 05:44:32 INFO - Running pre-action listener: _resource_record_pre_action 05:44:32 INFO - Running main action method: create_virtualenv 05:44:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:44:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:44:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:44:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:32 INFO - Using real prefix '/usr' 05:44:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:44:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:34 INFO - Installing pip.................done. 05:44:34 INFO - Return code: 0 05:44:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:34 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:44:34 INFO - Using env: {'DISPLAY': ':0', 05:44:34 INFO - 'HOME': '/home/cltbld', 05:44:34 INFO - 'LANG': 'en_US.UTF-8', 05:44:34 INFO - 'LANGUAGE': 'en_US:en', 05:44:34 INFO - 'LOGNAME': 'cltbld', 05:44:34 INFO - 'MAIL': '/var/mail/cltbld', 05:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:34 INFO - 'MOZ_NO_REMOTE': '1', 05:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:34 INFO - 'NO_EM_RESTART': '1', 05:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:34 INFO - 'PWD': '/builds/slave/test', 05:44:34 INFO - 'SHELL': '/bin/bash', 05:44:34 INFO - 'SHLVL': '1', 05:44:34 INFO - 'TERM': 'linux', 05:44:34 INFO - 'TMOUT': '86400', 05:44:34 INFO - 'USER': 'cltbld', 05:44:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:34 INFO - '_': '/tools/buildbot/bin/python'} 05:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:44:34 INFO - Cleaning up... 05:44:34 INFO - Return code: 0 05:44:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:34 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:44:34 INFO - Using env: {'DISPLAY': ':0', 05:44:34 INFO - 'HOME': '/home/cltbld', 05:44:34 INFO - 'LANG': 'en_US.UTF-8', 05:44:34 INFO - 'LANGUAGE': 'en_US:en', 05:44:34 INFO - 'LOGNAME': 'cltbld', 05:44:34 INFO - 'MAIL': '/var/mail/cltbld', 05:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:34 INFO - 'MOZ_NO_REMOTE': '1', 05:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:34 INFO - 'NO_EM_RESTART': '1', 05:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:34 INFO - 'PWD': '/builds/slave/test', 05:44:34 INFO - 'SHELL': '/bin/bash', 05:44:34 INFO - 'SHLVL': '1', 05:44:34 INFO - 'TERM': 'linux', 05:44:34 INFO - 'TMOUT': '86400', 05:44:34 INFO - 'USER': 'cltbld', 05:44:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:34 INFO - '_': '/tools/buildbot/bin/python'} 05:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:34 INFO - Downloading/unpacking psutil>=3.1.1 05:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:36 INFO - Installing collected packages: psutil 05:44:36 INFO - Running setup.py install for psutil 05:44:36 INFO - building 'psutil._psutil_linux' extension 05:44:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:44:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:44:37 INFO - building 'psutil._psutil_posix' extension 05:44:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:44:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:44:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:37 INFO - Successfully installed psutil 05:44:37 INFO - Cleaning up... 05:44:37 INFO - Return code: 0 05:44:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:37 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:44:37 INFO - Using env: {'DISPLAY': ':0', 05:44:37 INFO - 'HOME': '/home/cltbld', 05:44:37 INFO - 'LANG': 'en_US.UTF-8', 05:44:37 INFO - 'LANGUAGE': 'en_US:en', 05:44:37 INFO - 'LOGNAME': 'cltbld', 05:44:37 INFO - 'MAIL': '/var/mail/cltbld', 05:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:37 INFO - 'MOZ_NO_REMOTE': '1', 05:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:37 INFO - 'NO_EM_RESTART': '1', 05:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:37 INFO - 'PWD': '/builds/slave/test', 05:44:37 INFO - 'SHELL': '/bin/bash', 05:44:37 INFO - 'SHLVL': '1', 05:44:37 INFO - 'TERM': 'linux', 05:44:37 INFO - 'TMOUT': '86400', 05:44:37 INFO - 'USER': 'cltbld', 05:44:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:37 INFO - '_': '/tools/buildbot/bin/python'} 05:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:44:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:44:39 INFO - Installing collected packages: mozsystemmonitor 05:44:39 INFO - Running setup.py install for mozsystemmonitor 05:44:39 INFO - Successfully installed mozsystemmonitor 05:44:39 INFO - Cleaning up... 05:44:39 INFO - Return code: 0 05:44:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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', '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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:44: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 jsonschema==2.5.1 05:44:39 INFO - Using env: {'DISPLAY': ':0', 05:44:39 INFO - 'HOME': '/home/cltbld', 05:44:39 INFO - 'LANG': 'en_US.UTF-8', 05:44:39 INFO - 'LANGUAGE': 'en_US:en', 05:44:39 INFO - 'LOGNAME': 'cltbld', 05:44:39 INFO - 'MAIL': '/var/mail/cltbld', 05:44:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:39 INFO - 'MOZ_NO_REMOTE': '1', 05:44:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:39 INFO - 'NO_EM_RESTART': '1', 05:44:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:39 INFO - 'PWD': '/builds/slave/test', 05:44:39 INFO - 'SHELL': '/bin/bash', 05:44:39 INFO - 'SHLVL': '1', 05:44:39 INFO - 'TERM': 'linux', 05:44:39 INFO - 'TMOUT': '86400', 05:44:39 INFO - 'USER': 'cltbld', 05:44:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:39 INFO - '_': '/tools/buildbot/bin/python'} 05:44:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:41 INFO - warning: no files found matching '*.txt' 05:44:41 INFO - no previously-included directories found matching 'build' 05:44:41 INFO - no previously-included directories found matching 'dist' 05:44:41 INFO - no previously-included directories found matching '.git*' 05:44:41 INFO - Installing collected packages: jsonschema, functools32 05:44:41 INFO - Running setup.py install for functools32 05:44:41 INFO - warning: no files found matching '*.txt' 05:44:41 INFO - no previously-included directories found matching 'build' 05:44:41 INFO - no previously-included directories found matching 'dist' 05:44:41 INFO - no previously-included directories found matching '.git*' 05:44:41 INFO - Successfully installed jsonschema functools32 05:44:41 INFO - Cleaning up... 05:44:42 INFO - Return code: 0 05:44:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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', '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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:44: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 blobuploader==1.2.4 05:44:42 INFO - Using env: {'DISPLAY': ':0', 05:44:42 INFO - 'HOME': '/home/cltbld', 05:44:42 INFO - 'LANG': 'en_US.UTF-8', 05:44:42 INFO - 'LANGUAGE': 'en_US:en', 05:44:42 INFO - 'LOGNAME': 'cltbld', 05:44:42 INFO - 'MAIL': '/var/mail/cltbld', 05:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:42 INFO - 'MOZ_NO_REMOTE': '1', 05:44:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:42 INFO - 'NO_EM_RESTART': '1', 05:44:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:42 INFO - 'PWD': '/builds/slave/test', 05:44:42 INFO - 'SHELL': '/bin/bash', 05:44:42 INFO - 'SHLVL': '1', 05:44:42 INFO - 'TERM': 'linux', 05:44:42 INFO - 'TMOUT': '86400', 05:44:42 INFO - 'USER': 'cltbld', 05:44:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:42 INFO - '_': '/tools/buildbot/bin/python'} 05:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:44:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:44 INFO - Downloading docopt-0.6.1.tar.gz 05:44:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:44 INFO - Running setup.py install for blobuploader 05:44:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:44:44 INFO - Running setup.py install for requests 05:44:45 INFO - Running setup.py install for docopt 05:44:45 INFO - Successfully installed blobuploader requests docopt 05:44:45 INFO - Cleaning up... 05:44:45 INFO - Return code: 0 05:44:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44: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')]} 05:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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')]} 05:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:45 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:45 INFO - Using env: {'DISPLAY': ':0', 05:44:45 INFO - 'HOME': '/home/cltbld', 05:44:45 INFO - 'LANG': 'en_US.UTF-8', 05:44:45 INFO - 'LANGUAGE': 'en_US:en', 05:44:45 INFO - 'LOGNAME': 'cltbld', 05:44:45 INFO - 'MAIL': '/var/mail/cltbld', 05:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:45 INFO - 'MOZ_NO_REMOTE': '1', 05:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:45 INFO - 'NO_EM_RESTART': '1', 05:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:45 INFO - 'PWD': '/builds/slave/test', 05:44:45 INFO - 'SHELL': '/bin/bash', 05:44:45 INFO - 'SHLVL': '1', 05:44:45 INFO - 'TERM': 'linux', 05:44:45 INFO - 'TMOUT': '86400', 05:44:45 INFO - 'USER': 'cltbld', 05:44:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:45 INFO - '_': '/tools/buildbot/bin/python'} 05:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:45 INFO - Running setup.py (path:/tmp/pip-Izj9SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:45 INFO - Running setup.py (path:/tmp/pip-SxcdzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:45 INFO - Running setup.py (path:/tmp/pip-IWos2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:45 INFO - Running setup.py (path:/tmp/pip-SxGDhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:45 INFO - Running setup.py (path:/tmp/pip-yh8VBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:45 INFO - Running setup.py (path:/tmp/pip-j6W9Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:45 INFO - Running setup.py (path:/tmp/pip-v1hx9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:45 INFO - Running setup.py (path:/tmp/pip-Csv3Z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:45 INFO - Running setup.py (path:/tmp/pip-oTljtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:46 INFO - Running setup.py (path:/tmp/pip-KqBqdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:46 INFO - Running setup.py (path:/tmp/pip-Gl6VwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:46 INFO - Running setup.py (path:/tmp/pip-YKMR0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:46 INFO - Running setup.py (path:/tmp/pip-IRWoOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:46 INFO - Running setup.py (path:/tmp/pip-CMCRmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:46 INFO - Running setup.py (path:/tmp/pip-WNFMDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:46 INFO - Running setup.py (path:/tmp/pip-wiBzCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:46 INFO - Running setup.py (path:/tmp/pip-9k_ngw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:46 INFO - Running setup.py install for manifestparser 05:44:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozcrash 05:44:46 INFO - Running setup.py install for mozdebug 05:44:46 INFO - Running setup.py install for mozdevice 05:44:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:44:46 INFO - Running setup.py install for mozfile 05:44:46 INFO - Running setup.py install for mozhttpd 05:44:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozinfo 05:44:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozInstall 05:44:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozleak 05:44:47 INFO - Running setup.py install for mozlog 05:44:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for moznetwork 05:44:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozprocess 05:44:47 INFO - Running setup.py install for mozprofile 05:44:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozrunner 05:44:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:44:47 INFO - Running setup.py install for mozscreenshot 05:44:47 INFO - Running setup.py install for moztest 05:44:48 INFO - Running setup.py install for mozversion 05:44:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:44:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:48 INFO - Cleaning up... 05:44:48 INFO - Return code: 0 05:44:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:48 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:48 INFO - Using env: {'DISPLAY': ':0', 05:44:48 INFO - 'HOME': '/home/cltbld', 05:44:48 INFO - 'LANG': 'en_US.UTF-8', 05:44:48 INFO - 'LANGUAGE': 'en_US:en', 05:44:48 INFO - 'LOGNAME': 'cltbld', 05:44:48 INFO - 'MAIL': '/var/mail/cltbld', 05:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:48 INFO - 'MOZ_NO_REMOTE': '1', 05:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:48 INFO - 'NO_EM_RESTART': '1', 05:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:48 INFO - 'PWD': '/builds/slave/test', 05:44:48 INFO - 'SHELL': '/bin/bash', 05:44:48 INFO - 'SHLVL': '1', 05:44:48 INFO - 'TERM': 'linux', 05:44:48 INFO - 'TMOUT': '86400', 05:44:48 INFO - 'USER': 'cltbld', 05:44:48 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:48 INFO - '_': '/tools/buildbot/bin/python'} 05:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:48 INFO - Running setup.py (path:/tmp/pip-WYZtJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:48 INFO - Running setup.py (path:/tmp/pip-ePJIrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:48 INFO - Running setup.py (path:/tmp/pip-Zg5FY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:48 INFO - Running setup.py (path:/tmp/pip-ssk16t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:48 INFO - Running setup.py (path:/tmp/pip-m8bbnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:48 INFO - Running setup.py (path:/tmp/pip-Lqgu6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:48 INFO - Running setup.py (path:/tmp/pip-12h4p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:48 INFO - Running setup.py (path:/tmp/pip-626nZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:48 INFO - Running setup.py (path:/tmp/pip-S8hRq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:48 INFO - Running setup.py (path:/tmp/pip-Ws_GhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:48 INFO - Running setup.py (path:/tmp/pip-dNgWYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:49 INFO - Running setup.py (path:/tmp/pip-SWOQTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:49 INFO - Running setup.py (path:/tmp/pip-jZjo_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:49 INFO - Running setup.py (path:/tmp/pip-mpsjYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:49 INFO - Running setup.py (path:/tmp/pip-2Xz31j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:49 INFO - Running setup.py (path:/tmp/pip-8jLCzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:44:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:49 INFO - Running setup.py (path:/tmp/pip-I3U6qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:44:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44: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 05:44:51 INFO - Downloading blessings-1.6.tar.gz 05:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:51 INFO - Installing collected packages: blessings 05:44:51 INFO - Running setup.py install for blessings 05:44:51 INFO - Successfully installed blessings 05:44:51 INFO - Cleaning up... 05:44:51 INFO - Return code: 0 05:44:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:44:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:51 INFO - Reading from file tmpfile_stdout 05:44:51 INFO - Current package versions: 05:44:51 INFO - argparse == 1.2.1 05:44:51 INFO - blessings == 1.6 05:44:51 INFO - blobuploader == 1.2.4 05:44:51 INFO - docopt == 0.6.1 05:44:51 INFO - functools32 == 3.2.3-2 05:44:51 INFO - jsonschema == 2.5.1 05:44:51 INFO - manifestparser == 1.1 05:44:51 INFO - mozInstall == 1.12 05:44:51 INFO - mozcrash == 0.17 05:44:51 INFO - mozdebug == 0.1 05:44:51 INFO - mozdevice == 0.48 05:44:51 INFO - mozfile == 1.2 05:44:51 INFO - mozhttpd == 0.7 05:44:51 INFO - mozinfo == 0.9 05:44:51 INFO - mozleak == 0.1 05:44:51 INFO - mozlog == 3.2 05:44:51 INFO - moznetwork == 0.27 05:44:51 INFO - mozprocess == 0.22 05:44:51 INFO - mozprofile == 0.28 05:44:51 INFO - mozrunner == 6.11 05:44:51 INFO - mozscreenshot == 0.1 05:44:51 INFO - mozsystemmonitor == 0.3 05:44:51 INFO - moztest == 0.7 05:44:51 INFO - mozversion == 1.4 05:44:51 INFO - psutil == 3.1.1 05:44:51 INFO - requests == 1.2.3 05:44:51 INFO - wsgiref == 0.1.2 05:44:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:44:51 INFO - Using env: {'DISPLAY': ':0', 05:44:51 INFO - 'HOME': '/home/cltbld', 05:44:51 INFO - 'LANG': 'en_US.UTF-8', 05:44:51 INFO - 'LANGUAGE': 'en_US:en', 05:44:51 INFO - 'LOGNAME': 'cltbld', 05:44:51 INFO - 'MAIL': '/var/mail/cltbld', 05:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:51 INFO - 'MOZ_NO_REMOTE': '1', 05:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:51 INFO - 'NO_EM_RESTART': '1', 05:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:51 INFO - 'PWD': '/builds/slave/test', 05:44:51 INFO - 'SHELL': '/bin/bash', 05:44:51 INFO - 'SHLVL': '1', 05:44:51 INFO - 'TERM': 'linux', 05:44:51 INFO - 'TMOUT': '86400', 05:44:51 INFO - 'USER': 'cltbld', 05:44:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:51 INFO - '_': '/tools/buildbot/bin/python'} 05:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:44:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:44:51 INFO - Cleaning up... 05:44:51 INFO - Return code: 0 05:44:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:51 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:44:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:51 INFO - Using env: {'DISPLAY': ':0', 05:44:51 INFO - 'HOME': '/home/cltbld', 05:44:51 INFO - 'LANG': 'en_US.UTF-8', 05:44:51 INFO - 'LANGUAGE': 'en_US:en', 05:44:51 INFO - 'LOGNAME': 'cltbld', 05:44:51 INFO - 'MAIL': '/var/mail/cltbld', 05:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:51 INFO - 'MOZ_NO_REMOTE': '1', 05:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:51 INFO - 'NO_EM_RESTART': '1', 05:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:51 INFO - 'PWD': '/builds/slave/test', 05:44:51 INFO - 'SHELL': '/bin/bash', 05:44:51 INFO - 'SHLVL': '1', 05:44:51 INFO - 'TERM': 'linux', 05:44:51 INFO - 'TMOUT': '86400', 05:44:51 INFO - 'USER': 'cltbld', 05:44:51 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:51 INFO - '_': '/tools/buildbot/bin/python'} 05:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:44:52 INFO - Cleaning up... 05:44:52 INFO - Return code: 0 05:44:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:52 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 0x7fd5fa0aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a87350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, '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': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:44:52 INFO - Using env: {'DISPLAY': ':0', 05:44:52 INFO - 'HOME': '/home/cltbld', 05:44:52 INFO - 'LANG': 'en_US.UTF-8', 05:44:52 INFO - 'LANGUAGE': 'en_US:en', 05:44:52 INFO - 'LOGNAME': 'cltbld', 05:44:52 INFO - 'MAIL': '/var/mail/cltbld', 05:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:52 INFO - 'MOZ_NO_REMOTE': '1', 05:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:52 INFO - 'NO_EM_RESTART': '1', 05:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:52 INFO - 'PWD': '/builds/slave/test', 05:44:52 INFO - 'SHELL': '/bin/bash', 05:44:52 INFO - 'SHLVL': '1', 05:44:52 INFO - 'TERM': 'linux', 05:44:52 INFO - 'TMOUT': '86400', 05:44:52 INFO - 'USER': 'cltbld', 05:44:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:52 INFO - '_': '/tools/buildbot/bin/python'} 05:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:52 INFO - Downloading/unpacking flake8 05:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:54 INFO - no previously-included directories found matching 'docs/_build' 05:44:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:54 INFO - Running setup.py install for pep8 05:44:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:54 INFO - no previously-included directories found matching 'docs/_build' 05:44:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:44:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:55 INFO - Cleaning up... 05:44:55 INFO - Return code: 0 05:44:55 INFO - Running post-action listener: _resource_record_post_action 05:44:55 INFO - Running post-action listener: _start_resource_monitoring 05:44:55 INFO - Starting resource monitoring. 05:44:55 INFO - ##### 05:44:55 INFO - ##### Finished create-virtualenv step (success) 05:44:55 INFO - ##### 05:44:55 INFO - ##### 05:44:55 INFO - ##### Running install step. 05:44:55 INFO - ##### 05:44:55 INFO - Running pre-action listener: _resource_record_pre_action 05:44:55 INFO - Running main action method: install 05:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:55 INFO - Reading from file tmpfile_stdout 05:44:55 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:55 INFO - Reading from file tmpfile_stdout 05:44:55 INFO - Output received: 05:44:55 INFO - Usage: mozinstall [options] installer 05:44:55 INFO - Options: 05:44:55 INFO - -h, --help show this help message and exit 05:44:55 INFO - -d DEST, --destination=DEST 05:44:55 INFO - Directory to install application into. [default: 05:44:55 INFO - "/builds/slave/test"] 05:44:55 INFO - --app=APP Application being installed. [default: firefox] 05:44:55 INFO - mkdir: /builds/slave/test/build/application 05:44:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:45:12 INFO - Reading from file tmpfile_stdout 05:45:12 INFO - Output received: 05:45:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:45:12 INFO - Running post-action listener: _resource_record_post_action 05:45:12 INFO - ##### 05:45:12 INFO - ##### Finished install step (success) 05:45:12 INFO - ##### 05:45:12 INFO - ##### 05:45:12 INFO - ##### Running run-tests step. 05:45:12 INFO - ##### 05:45:12 INFO - Running pre-action listener: _resource_record_pre_action 05:45:12 INFO - Running main action method: run_tests 05:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:45:12 INFO - Python 2.7.3 05:45:12 INFO - Return code: 0 05:45:12 INFO - grabbing minidump binary from tooltool 05:45:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:45:12 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 0x2b161c0>, '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 0x2b170c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b17550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:45:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:45:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:45:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:45:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:45:12 INFO - Return code: 0 05:45:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:45:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:45:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:45:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:45:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:45:13 INFO - Return code: 0 05:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 05:45:13 INFO - Using env: {'DISPLAY': ':0', 05:45:13 INFO - 'HOME': '/home/cltbld', 05:45:13 INFO - 'LANG': 'en_US.UTF-8', 05:45:13 INFO - 'LANGUAGE': 'en_US:en', 05:45:13 INFO - 'LOGNAME': 'cltbld', 05:45:13 INFO - 'MAIL': '/var/mail/cltbld', 05:45:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:45:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:45:13 INFO - 'MOZ_NO_REMOTE': '1', 05:45:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:45:13 INFO - 'NO_EM_RESTART': '1', 05:45:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:45:13 INFO - 'PWD': '/builds/slave/test', 05:45:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:45:13 INFO - 'SHELL': '/bin/bash', 05:45:13 INFO - 'SHLVL': '1', 05:45:13 INFO - 'TERM': 'linux', 05:45:13 INFO - 'TMOUT': '86400', 05:45:13 INFO - 'USER': 'cltbld', 05:45:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1465389740.959119-100504234', 05:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:45:13 INFO - '_': '/tools/buildbot/bin/python'} 05:45:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 05:45:13 INFO - mozversion application_buildid: 20160608030219 05:45:13 INFO - mozversion application_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 05:45:13 INFO - mozversion application_display_name: Nightly 05:45:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:45:13 INFO - mozversion application_name: Firefox 05:45:13 INFO - mozversion application_remotingname: firefox 05:45:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:45:13 INFO - mozversion application_vendor: Mozilla 05:45:13 INFO - mozversion application_version: 50.0a1 05:45:13 INFO - mozversion platform_buildid: 20160608030219 05:45:13 INFO - mozversion platform_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 05:45:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:45:13 INFO - mozversion platform_version: 50.0a1 05:45:13 INFO - using testdate: 1465389913 05:45:13 INFO - actual date: 1465389913 05:45:13 INFO - starting webserver on 'localhost:48348' 05:45:13 INFO - SUITE-START | Running 2 tests 05:45:13 INFO - TEST-START | dromaeo_css 05:45:13 INFO - operating with platform_type : linux_ 05:45:13 INFO - Initialising browser for dromaeo_css test... 05:45:13 INFO - TEST-INFO | started process 1057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGK5N0/profile http://localhost:48348/getInfo.html) 05:45:17 INFO - PROCESS | 1057 | __metrics Screen width/height:1600/1200 05:45:17 INFO - PROCESS | 1057 | colorDepth:24 05:45:17 INFO - PROCESS | 1057 | Browser inner width/height: 1024/697 05:45:17 INFO - PROCESS | 1057 | __metrics 05:45:18 ERROR - PROCESS | 1057 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:45:18 INFO - PROCESS | 1057 | console.error: PushService: 05:45:18 INFO - PROCESS | 1057 | stateChangeProcessEnqueue: Error transitioning state 05:45:18 INFO - PROCESS | 1057 | UnknownError 05:45:19 INFO - TEST-INFO | 1057: exit 0 05:45:19 INFO - Browser initialized. 05:45:19 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:19 INFO - TEST-INFO | started process 1147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBGK5N0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:30 INFO - PROCESS | 1147 | RSS: Main: 154697728 05:45:30 INFO - PROCESS | 1147 | 05:46:21 INFO - PROCESS | 1147 | 1465389981554 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:48:29 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48348/tests/dromaeo/cssquery-ext.html) 05:48:30 INFO - PROCESS | 1147 | RSS: Main: 244207616 05:48:30 INFO - PROCESS | 1147 | 05:51:32 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-ext.html (next: http://localhost:48348/tests/dromaeo/cssquery-jquery.html) 05:51:33 INFO - PROCESS | 1147 | RSS: Main: 232587264 05:51:33 INFO - PROCESS | 1147 | 05:54:35 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48348/tests/dromaeo/cssquery-mootools.html) 05:54:36 INFO - PROCESS | 1147 | RSS: Main: 244551680 05:54:36 INFO - PROCESS | 1147 | 05:57:38 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48348/tests/dromaeo/cssquery-prototype.html) 05:57:38 INFO - PROCESS | 1147 | RSS: Main: 242540544 05:57:38 INFO - PROCESS | 1147 | 06:00:41 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48348/tests/dromaeo/cssquery-yui.html) 06:00:41 INFO - PROCESS | 1147 | RSS: Main: 229421056 06:00:41 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | Cycle 1(1): loaded http://localhost:48348/tests/dromaeo/cssquery-yui.html (next: http://localhost:48348/tests/dromaeo/cssquery-dojo.html) 06:03:44 INFO - PROCESS | 1147 | RSS: Main: 281702400 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | __start_tp_report 06:03:44 INFO - PROCESS | 1147 | _x_x_mozilla_page_load 06:03:44 INFO - PROCESS | 1147 | _x_x_mozilla_page_load_details 06:03:44 INFO - PROCESS | 1147 | |i|pagename|runs| 06:03:44 INFO - PROCESS | 1147 | |0;dojo.html;3074.2775447769773;3107.8756849725996;3130.5460708197306;3134.0597820653797;3157.9526307105384;4824.107540105083;5078.84763457096;5211.843644690661;5259.579233661308;5284.048871203182;5204.32343795307;5207.9739601302035;5218.086834803904;5230.424653288135;5277.577793776498;4698.154332220199;4720.433547974248;4861.611071114302;4873.22028475444;4949.208126699728;4846.975765121187;4862.0275944811;4905.803767849282;4910.803567857281;4930.260460930871;4592.10453961476;4595.632349412039;4626.259798432268;4664.976675116636;4712.222483290253;4621.306803979396;4671.182543054952;4686.81252749893;4690.906181876378;4718.9292160617615;4618.1918164321105;4637.536246375369;4657.301404789275;4661.95338046622;4674.883127921795;4949.653524253304;5080.1617733074;5127.2052831811125;5185.688858668492;5197.220416937452;5630.634008789416;5664.603477756558;5672.432756724335;5714.200011998323;5719.71401429931;5666.1784041314195;5726.914096288559;5740.74166662497;5743.4543718346695;5747.109198074305;5109.20807274873;5214.921776173361;5296.708681022581;5305.973470132663;5366.463353664602;5814.883702325929;5820.214271073435;5822.272215973004;5828.213191219216;5839.416058394211;5262.02652509287;5607.551395888319;5619.325680918316;5619.606627536115;5632.690202038927;5513.952349053748;5555.30558680165;5567.081431563746;5588.776448942078;5648.604597678205;5566.332040155207;5572.275604171513;5586.860328491739;5605.299337582802;5623.790884959753;5273.34083239595;5532.363778165482;5606.439356064361;5617.775288988395;5623.718814059281;4303;4303.440552728125;4312.633426158749;4345.130973805251;4350.8694739157245;3840.8861430185493;3872.5159355080614;3883.0292426893275;3898.9610103899167;3911.7261791674878;5061.013102444987;5108.335916330928;5258.605604579595;5261.789528418897;5312.760925758273;5641.661500309912;5658.575606829504;5675.3757086720425;5705.5435565154685;5723.399043100498;5314.3091398117995;5346.091164501966;5349.1976203569775;5375.16684913839;5392.299001129828;4470.150671372428;4590.311453282035;4643.95356046442;4695.201815691341;4715.882102947454;5779.075347944308;5795.420457954255;5800.8259752207505;5830.504407125357;5839.0949402842625;5658.349289831722;5666.17840413146;5678.772849086073;5683.715814209356;5687.004774164588;5481.890362192814;5706.087026075808;5769.336526299529;5818.4763371296785;5823.126531020212;5535.612507124623;5542.7782888684005;5579.302587176603;5582.972085139549;5587.245721827664;5638.126090455986;5653.2085508028085;5653.236813030188;5677.120046392815;5692.5445964321925;5305.124654431976;5369.436209197978;5444.3194600674915;5513.145462453326;5551.583631227593;5451.672899626035;5509.889802204014;5515.172724091419;5520.282363292747;5528.75120619565;5136.871578210575;5138.665986710852;5396.622236443412;5407.297051383295;5457.099578569491;5489.258950041853;5556.499915007668;5569.749361278671;5617.859553511032;5624.85937851557;5439.836804895701;5456.699881506555;5477.945220547744;5493.670379777226;5506.091494903296 06:03:44 INFO - PROCESS | 1147 | |1;ext.html;560.202257371531;572.6993328502537;585.9803941142408;594.0406243916077;598.5839841310288;31811.363772724533;35156.12109697256;35173.296534069304;45516.54483455164;46896;44412;45162.32256516155;45263.54736452635;45421.31868021974;45441.36469082474;8730.956345218265;8913.286937045053;8922.375433719642;8947.105289471034;8962.37263391563;8696.739097827076;8821.206091451768;8837.469751814911;8846.778830529256;8851.424657397249;8816.779580510507;8867.379283450162;8878.334124940622;8882.689105881296;8885.600147993357;8770.649174033031;8825.470471771681;8831.955840220759;8878.334124940622;8880.644774209024;8473.237408633253;8579.914200858037;8693;8736;8762.693305734269;41089;41654.583454165375;41846.163076738296;41948.58051419508;42119.7894010531;3401.149712571857;3411.0278570607506;3436.639152888961;3592.5329707137903;3982;30170.396592068035;31331.216719581964;31351.216219594466;31352.686473135433;31356.686433135834;4032.858849940238;4181.226473102455;4225.302825033866;4307.095509942916;4356.302991521341;337090;337667;341394;341482;341942;59893.40106598965;60077.399226008056;60319.39680603226;60580.69709651423;60638;63006.369936300965;63030.369696303365;63080.79949606614;63220.36779632237;63317.36682633115;15662.843371566367;15980.280887360097;16197.109158996132;16325.591860203353;16329.673406531803;11387.37369444672;11488.59789907366;11597.18819682614;12367.69080772988;12657.810132848015;18691.626167476574;19170.90414547946;19372.61254774925;19526.511837204183;19551.80448195528;6968.581885086911;7143.142822861186;7155.284471552803;7181.245969173266;7182.928170718331;1009.5759780892043;1105.7290963713942;1130.7681925205313;1130.9377984210782;1162.2329262686756;31822.681773182434;32042;32186;32212.19469513281;32666.020019399457;1153.7231064544617;1157.2015309436463;1162.3258510064143;1176.988230117705;1181.6809461445362;16193.59516012109;16516.917415412845;16798.916005419895;16881.15594220284;16952.884850115403;517206;524577;525779;526956;528156;58156;59284;59457;59546.40453595408;59802.70098649479;1263.1978693529675;1365.3105181883086;1398.0632975906167;1404.3329418526118;1408.478862820763;30519.344510827166;32616.836915815267;32825.34349313048;33304.66695333113;33440.832795835864;44620.77689611531;44793;45008;45029;45031.54968450274;381048;381206;384873;385327;386708;22659.320220393416;27486.725132749216;27594.724052759215;28798.424031519673;29007.419851602426;47081.293780592634;47095.293570595786;48263.27605085997;48282;48343.374246930915;38994.6100538991;39091.6090839088;39508;39531.40702889516;39886;38814.80592597019;39480.40779388369;39597.2080558393;39865.2026959465;39940.40089398719;39314.80342598383;39394.40908386434;39687.80156099201;39911;40391.798041009606;33662;34897.47653785144;35013.824930875184;35741.46387804133;35742.64257357393;27204;27341.726582733918;27533;27652.723472765818;27787.44425111446 06:03:44 INFO - PROCESS | 1147 | |2;jquery.html;394.686224451561;396.68661757211805;398.6611380326723;403.9959600403996;417.0075220974083;13981.860181398182;17364.739528907077;18579.163937622805;19343.419697409066;19366.322178723763;17271.740923886122;18208.453746387597;18511.44465666029;19058.904705476452;19077.332293369735;5502.532284755801;5608.755129958954;5699.2306038684665;5726.3414707308775;5751.65490070595;4007.73949693269;5565.860853478655;5688.374278829346;6047.848803779897;6379.298277189506;6386.425221730044;6396.808095757135;6417.647029413381;6419.325970773071;6474.352564743512;6230.096635987802;6306.873862522747;6428.550001499897;6459.031145328191;6468.967655161718;4934.925976110361;5626.690532020737;5641.915371269434;5643.971780141114;5651.18057881609;12841.614751557468;12855.485780568766;13113.344332783417;13121.934390328082;13156.802647960289;2096.926607568743;2128.053016407699;2168.761436242012;2287.553926984239;2629.027259913825;8987.640494380217;9318.767030824216;9688.46713430761;12334.444949977273;13177.813996740244;1778.6087060846594;1833.3399976008627;1861.9348322808771;1863.2733234038735;1877.962440751191;77927;78797;81726.59136704338;82285;82557.58721206416;10189.184865210766;10339.689809305733;10460.790784184426;10507.528945947573;10610.257281990187;12963.481460741465;13429.127106738226;13706.38321275545;13889.444422222998;13893.930530347283;7569.697212111454;7835.5690437026515;8083.434159608771;8156.980377452818;8230.012398512217;7877.606119694107;7897.447178697436;7910.920890791019;7975;7991.200879911962;4629.606483448877;4694.718316900997;4730.195866702668;4767.833125840579;4777.689450185727;1903.200655724599;1939.1177014458387;1950.756155480565;1961.7253584498183;1995.2019192322896;873.2708188662411;944.2729098594044;952.9332946693664;953.8903026151943;980.9705708828747;17407.73888391675;17978.190981405867;18254;18442.907785460986;18722.531936701693;978.2027647467291;1023.779887324214;1029.624187171677;1066.99466502667;1083.6369816111533;10030.29787914839;10374.481275936323;10409.323393979366;10518.526666300035;10541.84187237192;464104;485111;493295;494519;497613;92886;93408.53295733478;94971;95829.04170958341;96041.51979240059;1010.3937637417491;1011.2567263061644;1035.5650626736788;1059.0838924330399;1061.639042725477;16447.374973854472;16522.339106435607;16677.16614169311;16684.332626695283;16776.496705098867;27957.92462829128;29834.403311933205;35507.46738798972;37078.07304817401;37117.62882371142;48283.5171648279;52608.473915261886;52818.47181528136;53020.734896326816;53790.46209537855;8372.748817535483;8461.61922713467;8495.23542881119;8559.657613695383;8685.826283474422;9251.814963700554;12234.26594404303;12554.309512976874;12806.551770687982;13113.868861311264;6582;11038.50326735315;11063.446827658745;11104.389258590854;11359.261647992855;7218.494705370574;11199.272047316897;11260.662180134608;11273.154513411691;11412.429378530875;9697.59384889173;11242;11612.187146899974;11672.416379180837;11712.824307635221;8182.140875208018;8240.258376745882;8431.451955622864;8461.576921154041;8605.870911936452;11319.886801131883;11350.432478375884;11425;11468.197226194086;11950.641480755592 06:03:44 INFO - PROCESS | 1147 | |3;mootools.html;1312.8818406343428;1451.6878871042727;1493.0444515510071;1617.5470868156913;1783.6700210461065;8148.144444833296;8510.404271700976;8518.446300990432;8732.08313127122;8732.869006964886;8516.489010659365;8684.348673849456;8685.218330350268;8700.869486957701;8705.085965973576;1980.8316293115101;2253.312739614417;2278.646809744488;2304.7349554801244;2316.444053427174;2341.812654987597;2346.765323467648;2349.8590084594894;2349.95300093998;2355.3993731598503;2256.6050941085327;2300.907963681459;2303.6199027160496;2308.4228942764307;2320.7795259450327;1939.8351140153034;2174.4563859035243;2226.209695558086;2257.2325409360733;2259.2544460328054;2157.7626461089267;2171.1423987524995;2175.7280339957506;2177.3903307074042;2239.3729755668437;8450.112738162466;8558.572071396406;8559.700410485602;8590.269827064707;8614.138586141398;4939.604831613462;5163.922541161885;5166.715830629314;5186.429492755794;5211.843644690665;3225.12921511193;3227.3545290941906;3327.1183136468853;3327.6838700323674;3390.8304584770663;1124.7694222684331;1137.5961533655598;1146.146121139748;1156.19066653343;1162.7906976744182;12069.879301207051;12119.33343666098;12122.636320910387;12130.878691213064;12143.696407589792;4439.445069366329;4476.306172543261;4590.104929538707;4596.241620132708;4597.080583883237;10224.284300098921;10242.53908574116;10244.436555989492;10258.58965641366;10266.794664106676;4408.7575183365225;5197;5198.350206224222;5203.089459344676;5204.1673332266655;4592.97703511487;4758.095961767253;4764;4806.399200099988;4818.614510839125;3895.552011518655;3928.705347098979;4001.8599349022643;4037.959620403817;4063.79681015948;1198.574506050357;1206.1014544164655;1215.1251099208555;1217.0993464836135;1217.6590554644713;825.9834803303901;901.5852707754507;912.7672443526858;924.9537523123817;931.0921851195166;5642.6614403135945;5704.828855134353;5733.541316694655;5951.226340575698;5959.910601340984;935.4387367579534;981.8232718110665;997.2570435025807;1007.1137399088901;1051.810674078658;3991.4212439196735;4082.2651922653613;4087.5094988600963;4097.364908439196;4137.586241375839;10475.580976760844;10762.677119686421;10861.45692715377;10919.563217471372;10957;10758.193135514868;10781.838272425763;10826.458677066115;10854.240203185858;10886.836697449544;7630.427717921179;8022.438429310009;8027.759167224993;8104.351651867836;8247.835043299221;5661.886762264649;6020.6688632123905;6115.296740874856;6196.47329976939;6208.906866396917;9851.113399794052;9947.552360143956;10081.294309398272;10089.09198172168;10123.59505619767;9436.433813971184;9914.206863450763;9976.351537150062;10013.699589012342;10205.13256373187;6733.091032710521;7258.237885022208;7536.962315188389;7646.158922518407;7730.381569474316;8399.790005249917;8446.915530844859;8489.108643592333;8500.277476414327;8503.532305723245;7379.557226566423;7548.1697013329585;7604.885926711215;7676.385889128968;7699.307062364414;7254.347108760237;7312.41500679955;7347.632618368953;7386.852262954603;7496.9250307498405;6584.8024559263295;6594.934050659432;6649.63427011519;6664.83337916556;6676.532642715158;4872.976674898169;4913.213885778258;5017.874553136201;5103.923441148311;5152.458991805806;5092.821751238689;5155.2782610433815;5192.117340052276;5238.319018527567;5245.9475405246985 06:03:44 INFO - PROCESS | 1147 | |4;prototype.html;312.6795035089032;327.91965968337763;338.5750882642284;338.82550486499457;339.3010398578926;4843.830465933693;4958.231474121508;5057.747112644367;5062.797488100477;5071.898562028758;4995.650304478688;4998.400191976959;5052.84841454756;5060.911903940652;5096.133657278262;4017.5379831319406;4027.1140349123148;4037.818298176589;4044.029432936089;4053.148838743867;3790;3795.053248690465;3966.8809935701975;3977.2102553850737;3985.60143985602;3981.840726370942;3993.4409182714444;3996.1408297216094;4000.9399859002137;4006.1186538961383;3920.5099362579676;3951.585083566242;3958.683305335581;3961.1285517186175;3969.24584328978;3522.172289511963;3564.625714300013;3575.4279315309427;3581.0152208142968;3586.659267369596;4875.219964805614;4889.217725163957;4890.559849613516;4950.232713929347;4953.4303555091265;4486.349479325512;4492.775361231926;4497.145542346943;4527.7736113194205;4531.252343363341;5221.556167725748;5236.842894713165;5238.476152384731;5252.8686782830355;5278.6041046921255;3673.4673472346626;3871.2064026874705;3886.805659717031;3934.878559610497;3957.703172262063;5375.247465354853;5444.863878403032;5455.454454554513;5497.99999999996;5507.889842203133;3990.980045099756;4012.8932310537202;4043.3126368516832;4065.59344065597;4080.224757296104;4003.579624139482;4026.2350153470748;4052.858149964737;4091.324931386288;4104.199681062164;4451.910961780746;4509.391232183613;4533.09609963816;4558.954410455853;4561.29299958507;5280.419153893069;5299.761510731949;5350.946490535045;5361.785528578891;5369.140937449989;1301.3883474766844;1332.8667133286788;1397.0360451288577;1399.762040453105;1409.1615488784157;907.7685190276437;912.7079334612993;916.4180745226696;916.7669484543279;928.5329179895748;4544.363789069533;4581.679282450196;4609.516000819865;4614.569483460071;4636.976815115971;4704.835775543288;4814.7833347498745;4816.662833601685;4827.903441931142;4843.854684359475;4513.691029601445;4534.682572219913;4556.817727290938;4570.337301091389;4581.289900065495;2378.6669866218745;2528.8229823912147;2529.6837895263093;2566.2814411964678;2566.525192839331;4818.614510839125;4898.975505122523;4924.778384972685;4935.333729946411;4945.455999840015;4750.501197374226;4770.640367495247;4825.806967721322;4832.49258827818;4854.563089321908;5250.949810038008;5607.803726869622;5648.209250704905;5683.403242659627;5685.516731077904;5436.700981445901;5508.256385387921;5510.476504732044;5518.255035570147;5548.140038294071;5309.575233981195;5409.918851217313;5428.208691131996;5465.879494703497;5484.232207490874;5615.606907516435;5630.465105814941;5633.802816901389;5651.954388438152;5681.721612637123;3890.7665540067687;3895.24042811649;3901.7463864848696;3923.4311024900658;3949.466821978996;5293.364796224478;5332.9733351333;5486.573490892477;5497.505224529811;5535.861603459945;5347.705876176848;5348.171033489815;5352.250684904195;5352.839414817562;5354.544863686475;5094.258592859159;5276.129438642581;5339.092354299701;5401.837944861661;5410.621256512007;5154.819581314786;5168.922466162935;5194.7272918133785;5259.474052594863;5261.263423120689;5308.389535203501;5334.546563542142;5400.486953739389;5415.891682166256;5424.810131645373;5108.879814876785;5304.336957880265;5308.946910530845;5310.362756469249;5324.307839980777 06:03:44 INFO - PROCESS | 1147 | |5;yui.html;739.2127384335682;753.9886901696478;771.3289438188773;774.8489044636298;795.8965334506515;15130.394784208618;15521.68956620867;15741.842581574181;15783.763243551355;15799.763003554941;13409.664758381045;13569.253691046988;13604.659883502918;13624.683803753362;13659.521916732916;657.1653999420732;768.427521496486;790.1703211627796;790.731151408521;792.4650860669054;791.5685951156605;801.2068052627885;804.1596531624438;804.2199066905092;806.5563939833098;854.8632218844986;856.3106699107216;860.1312674199073;861.1861790607878;862.2584577263548;692.8094773937182;823.0575990490914;843.7215718812777;845.4842546046906;853.3216093205916;616.3497510126814;616.8766246750623;616.9876602467971;617.9443850053472;618.7648693496443;13126.60620181396;13149.408276627479;13160;13169.934150329284;13188.86811131886;13563.864361356358;13799.310034498234;13861.168329900238;13922.443102275896;14179.361928713233;12191.268523888506;12368.381580921008;12467.93766031173;12537.122401431903;12601.873981260162;4312.396264522969;4329.480462344539;4392.648588112943;4408.493023302329;4426.867193984185;72682;73132;73392.26607733908;74680.62659686667;75627.62186189034;10627.734306642396;10688.465576721133;10757.569697212024;10841.78316433667;10843.566257349617;17804;17858.28566857337;17888.642227155386;17954;17969.820301797077;8384.622691978753;8408.957955210184;8440.915590844013;8527.701530446404;8532.829343413097;4668.883277918011;4671.95328046722;4735.83424580138;4790.5448982346625;4920.876978075506;3289.555909952174;3378.071030466592;3381.0871064812363;3382.036119705921;3384.966150338465;591.1162811596605;603.6800495737266;617.8733359661259;621.6518749500294;623.4233334165879;537.3685919045106;596.7970889897456;650.2879347114902;707.3492387003969;725.354434553248;9165.725028249164;9383.155516003593;9467.147956683793;9622.663206787729;9802.705918822447;631.8641492079225;703.3107554596525;755.5504474837463;775.4571799740204;795.3756301303449;4683.672142949961;4825.855224343275;5038.521340472649;5065.316182315414;5135.229715542624;106419;107550.46224768827;109982.45008774905;111024;111601;30134;30403.847980759954;67296;92776.53611731899;93027;82633.17366826255;83605;84110.15889841145;84530.57734711288;84634.57682711547;9292.673945280838;9418.208070900391;9452.196563292197;9469.526523673927;9490.478023708762;47936;48772.2684159745;49046.509534904195;49197.754011229714;49735.75132124316;63111.6844415775;63679.36320636734;64798.35201648112;65008;65528.34471655413;12475.625731228078;12545.811812822632;12848.871511284768;12938.870611294144;13200.339983001004;10268.691939241835;11778.705532361759;13516.324183790575;13991.23048232357;14416.42334306616;12524.749505010031;12841.165324253894;13355.131916425402;14028.719425611227;14351.282435877956;13275.203487790763;13739.931300343434;14244.857551424353;14289.499867504588;14340.139591624536;13351.532696355582;13830.792538111735;14270.072445291024;14316.642083947985;14418.0628259167;10054.69835904924;10144.21133024845;10601.522931468257;10795.838062428913;10894.128469722562;11231.536876597938;11574.05568574474;11823.349715765371;11883.643490695293;11925.940370298093 06:03:44 INFO - PROCESS | 1147 | __end_tp_report 06:03:44 INFO - PROCESS | 1147 | __start_cc_report 06:03:44 INFO - PROCESS | 1147 | _x_x_mozilla_cycle_collect,707 06:03:44 INFO - PROCESS | 1147 | __end_cc_report 06:03:44 INFO - PROCESS | 1147 | __startTimestamp1465391024880__endTimestamp 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | ------- Summary: start ------- 06:03:44 INFO - PROCESS | 1147 | Number of tests: 6 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#0] dojo.html Cycles:165 Average:5205.80 Median:5407.30 stddev:598.41 (11.1%) stddev-sans-first:576.41 06:03:44 INFO - PROCESS | 1147 | Values: 3074.3 3107.9 3130.5 3134.1 3158.0 4824.1 5078.8 5211.8 5259.6 5284.0 5204.3 5208.0 5218.1 5230.4 5277.6 4698.2 4720.4 4861.6 4873.2 4949.2 4847.0 4862.0 4905.8 4910.8 4930.3 4592.1 4595.6 4626.3 4665.0 4712.2 4621.3 4671.2 4686.8 4690.9 4718.9 4618.2 4637.5 4657.3 4662.0 4674.9 4949.7 5080.2 5127.2 5185.7 5197.2 5630.6 5664.6 5672.4 5714.2 5719.7 5666.2 5726.9 5740.7 5743.5 5747.1 5109.2 5214.9 5296.7 5306.0 5366.5 5814.9 5820.2 5822.3 5828.2 5839.4 5262.0 5607.6 5619.3 5619.6 5632.7 5514.0 5555.3 5567.1 5588.8 5648.6 5566.3 5572.3 5586.9 5605.3 5623.8 5273.3 5532.4 5606.4 5617.8 5623.7 4303.0 4303.4 4312.6 4345.1 4350.9 3840.9 3872.5 3883.0 3899.0 3911.7 5061.0 5108.3 5258.6 5261.8 5312.8 5641.7 5658.6 5675.4 5705.5 5723.4 5314.3 5346.1 5349.2 5375.2 5392.3 4470.2 4590.3 4644.0 4695.2 4715.9 5779.1 5795.4 5800.8 5830.5 5839.1 5658.3 5666.2 5678.8 5683.7 5687.0 5481.9 5706.1 5769.3 5818.5 5823.1 5535.6 5542.8 5579.3 5583.0 5587.2 5638.1 5653.2 5653.2 5677.1 5692.5 5305.1 5369.4 5444.3 5513.1 5551.6 5451.7 5509.9 5515.2 5520.3 5528.8 5136.9 5138.7 5396.6 5407.3 5457.1 5489.3 5556.5 5569.7 5617.9 5624.9 5439.8 5456.7 5477.9 5493.7 5506.1 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#1] ext.html Cycles:180 Average:57797.97 Median:39642.50 stddev:112182.78 (283.0%) stddev-sans-first:112415.16 06:03:44 INFO - PROCESS | 1147 | Values: 560.2 572.7 586.0 594.0 598.6 31811.4 35156.1 35173.3 45516.5 46896.0 44412.0 45162.3 45263.5 45421.3 45441.4 8731.0 8913.3 8922.4 8947.1 8962.4 8696.7 8821.2 8837.5 8846.8 8851.4 8816.8 8867.4 8878.3 8882.7 8885.6 8770.6 8825.5 8832.0 8878.3 8880.6 8473.2 8579.9 8693.0 8736.0 8762.7 41089.0 41654.6 41846.2 41948.6 42119.8 3401.1 3411.0 3436.6 3592.5 3982.0 30170.4 31331.2 31351.2 31352.7 31356.7 4032.9 4181.2 4225.3 4307.1 4356.3 337090.0 337667.0 341394.0 341482.0 341942.0 59893.4 60077.4 60319.4 60580.7 60638.0 63006.4 63030.4 63080.8 63220.4 63317.4 15662.8 15980.3 16197.1 16325.6 16329.7 11387.4 11488.6 11597.2 12367.7 12657.8 18691.6 19170.9 19372.6 19526.5 19551.8 6968.6 7143.1 7155.3 7181.2 7182.9 1009.6 1105.7 1130.8 1130.9 1162.2 31822.7 32042.0 32186.0 32212.2 32666.0 1153.7 1157.2 1162.3 1177.0 1181.7 16193.6 16516.9 16798.9 16881.2 16952.9 517206.0 524577.0 525779.0 526956.0 528156.0 58156.0 59284.0 59457.0 59546.4 59802.7 1263.2 1365.3 1398.1 1404.3 1408.5 30519.3 32616.8 32825.3 33304.7 33440.8 44620.8 44793.0 45008.0 45029.0 45031.5 381048.0 381206.0 384873.0 385327.0 386708.0 22659.3 27486.7 27594.7 28798.4 29007.4 47081.3 47095.3 48263.3 48282.0 48343.4 38994.6 39091.6 39508.0 39531.4 39886.0 38814.8 39480.4 39597.2 39865.2 39940.4 39314.8 39394.4 39687.8 39911.0 40391.8 33662.0 34897.5 35013.8 35741.5 35742.6 27204.0 27341.7 27533.0 27652.7 27787.4 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#2] jquery.html Cycles:180 Average:28019.94 Median:37097.85 stddev:80390.57 (216.7%) stddev-sans-first:80589.33 06:03:44 INFO - PROCESS | 1147 | Values: 394.7 396.7 398.7 404.0 417.0 13981.9 17364.7 18579.2 19343.4 19366.3 17271.7 18208.5 18511.4 19058.9 19077.3 5502.5 5608.8 5699.2 5726.3 5751.7 4007.7 5565.9 5688.4 6047.8 6379.3 6386.4 6396.8 6417.6 6419.3 6474.4 6230.1 6306.9 6428.6 6459.0 6469.0 4934.9 5626.7 5641.9 5644.0 5651.2 12841.6 12855.5 13113.3 13121.9 13156.8 2096.9 2128.1 2168.8 2287.6 2629.0 8987.6 9318.8 9688.5 12334.4 13177.8 1778.6 1833.3 1861.9 1863.3 1878.0 77927.0 78797.0 81726.6 82285.0 82557.6 10189.2 10339.7 10460.8 10507.5 10610.3 12963.5 13429.1 13706.4 13889.4 13893.9 7569.7 7835.6 8083.4 8157.0 8230.0 7877.6 7897.4 7910.9 7975.0 7991.2 4629.6 4694.7 4730.2 4767.8 4777.7 1903.2 1939.1 1950.8 1961.7 1995.2 873.3 944.3 952.9 953.9 981.0 17407.7 17978.2 18254.0 18442.9 18722.5 978.2 1023.8 1029.6 1067.0 1083.6 10030.3 10374.5 10409.3 10518.5 10541.8 464104.0 485111.0 493295.0 494519.0 497613.0 92886.0 93408.5 94971.0 95829.0 96041.5 1010.4 1011.3 1035.6 1059.1 1061.6 16447.4 16522.3 16677.2 16684.3 16776.5 27957.9 29834.4 35507.5 37078.1 37117.6 48283.5 52608.5 52818.5 53020.7 53790.5 8372.7 8461.6 8495.2 8559.7 8685.8 9251.8 12234.3 12554.3 12806.6 13113.9 6582.0 11038.5 11063.4 11104.4 11359.3 7218.5 11199.3 11260.7 11273.2 11412.4 9697.6 11242.0 11612.2 11672.4 11712.8 8182.1 8240.3 8431.5 8461.6 8605.9 11319.9 11350.4 11425.0 11468.2 11950.6 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#3] mootools.html Cycles:180 Average:5693.25 Median:4785.20 stddev:3246.17 (67.8%) stddev-sans-first:3238.58 06:03:44 INFO - PROCESS | 1147 | Values: 1312.9 1451.7 1493.0 1617.5 1783.7 8148.1 8510.4 8518.4 8732.1 8732.9 8516.5 8684.3 8685.2 8700.9 8705.1 1980.8 2253.3 2278.6 2304.7 2316.4 2341.8 2346.8 2349.9 2350.0 2355.4 2256.6 2300.9 2303.6 2308.4 2320.8 1939.8 2174.5 2226.2 2257.2 2259.3 2157.8 2171.1 2175.7 2177.4 2239.4 8450.1 8558.6 8559.7 8590.3 8614.1 4939.6 5163.9 5166.7 5186.4 5211.8 3225.1 3227.4 3327.1 3327.7 3390.8 1124.8 1137.6 1146.1 1156.2 1162.8 12069.9 12119.3 12122.6 12130.9 12143.7 4439.4 4476.3 4590.1 4596.2 4597.1 10224.3 10242.5 10244.4 10258.6 10266.8 4408.8 5197.0 5198.4 5203.1 5204.2 4593.0 4758.1 4764.0 4806.4 4818.6 3895.6 3928.7 4001.9 4038.0 4063.8 1198.6 1206.1 1215.1 1217.1 1217.7 826.0 901.6 912.8 925.0 931.1 5642.7 5704.8 5733.5 5951.2 5959.9 935.4 981.8 997.3 1007.1 1051.8 3991.4 4082.3 4087.5 4097.4 4137.6 10475.6 10762.7 10861.5 10919.6 10957.0 10758.2 10781.8 10826.5 10854.2 10886.8 7630.4 8022.4 8027.8 8104.4 8247.8 5661.9 6020.7 6115.3 6196.5 6208.9 9851.1 9947.6 10081.3 10089.1 10123.6 9436.4 9914.2 9976.4 10013.7 10205.1 6733.1 7258.2 7537.0 7646.2 7730.4 8399.8 8446.9 8489.1 8500.3 8503.5 7379.6 7548.2 7604.9 7676.4 7699.3 7254.3 7312.4 7347.6 7386.9 7496.9 6584.8 6594.9 6649.6 6664.8 6676.5 4873.0 4913.2 5017.9 5103.9 5152.5 5092.8 5155.3 5192.1 5238.3 5245.9 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#4] prototype.html Cycles:180 Average:4394.84 Median:4849.21 stddev:1278.34 (26.4%) stddev-sans-first:1244.67 06:03:44 INFO - PROCESS | 1147 | Values: 312.7 327.9 338.6 338.8 339.3 4843.8 4958.2 5057.7 5062.8 5071.9 4995.7 4998.4 5052.8 5060.9 5096.1 4017.5 4027.1 4037.8 4044.0 4053.1 3790.0 3795.1 3966.9 3977.2 3985.6 3981.8 3993.4 3996.1 4000.9 4006.1 3920.5 3951.6 3958.7 3961.1 3969.2 3522.2 3564.6 3575.4 3581.0 3586.7 4875.2 4889.2 4890.6 4950.2 4953.4 4486.3 4492.8 4497.1 4527.8 4531.3 5221.6 5236.8 5238.5 5252.9 5278.6 3673.5 3871.2 3886.8 3934.9 3957.7 5375.2 5444.9 5455.5 5498.0 5507.9 3991.0 4012.9 4043.3 4065.6 4080.2 4003.6 4026.2 4052.9 4091.3 4104.2 4451.9 4509.4 4533.1 4559.0 4561.3 5280.4 5299.8 5350.9 5361.8 5369.1 1301.4 1332.9 1397.0 1399.8 1409.2 907.8 912.7 916.4 916.8 928.5 4544.4 4581.7 4609.5 4614.6 4637.0 4704.8 4814.8 4816.7 4827.9 4843.9 4513.7 4534.7 4556.8 4570.3 4581.3 2378.7 2528.8 2529.7 2566.3 2566.5 4818.6 4899.0 4924.8 4935.3 4945.5 4750.5 4770.6 4825.8 4832.5 4854.6 5250.9 5607.8 5648.2 5683.4 5685.5 5436.7 5508.3 5510.5 5518.3 5548.1 5309.6 5409.9 5428.2 5465.9 5484.2 5615.6 5630.5 5633.8 5652.0 5681.7 3890.8 3895.2 3901.7 3923.4 3949.5 5293.4 5333.0 5486.6 5497.5 5535.9 5347.7 5348.2 5352.3 5352.8 5354.5 5094.3 5276.1 5339.1 5401.8 5410.6 5154.8 5168.9 5194.7 5259.5 5261.3 5308.4 5334.5 5400.5 5415.9 5424.8 5108.9 5304.3 5308.9 5310.4 5324.3 06:03:44 INFO - PROCESS | 1147 | 06:03:44 INFO - PROCESS | 1147 | [#5] yui.html Cycles:180 Average:18920.06 Median:4763.19 stddev:26797.41 (562.6%) stddev-sans-first:26837.81 06:03:44 INFO - PROCESS | 1147 | Values: 739.2 754.0 771.3 774.8 795.9 15130.4 15521.7 15741.8 15783.8 15799.8 13409.7 13569.3 13604.7 13624.7 13659.5 657.2 768.4 790.2 790.7 792.5 791.6 801.2 804.2 804.2 806.6 854.9 856.3 860.1 861.2 862.3 692.8 823.1 843.7 845.5 853.3 616.3 616.9 617.0 617.9 618.8 13126.6 13149.4 13160.0 13169.9 13188.9 13563.9 13799.3 13861.2 13922.4 14179.4 12191.3 12368.4 12467.9 12537.1 12601.9 4312.4 4329.5 4392.6 4408.5 4426.9 72682.0 73132.0 73392.3 74680.6 75627.6 10627.7 10688.5 10757.6 10841.8 10843.6 17804.0 17858.3 17888.6 17954.0 17969.8 8384.6 8409.0 8440.9 8527.7 8532.8 4668.9 4672.0 4735.8 4790.5 4920.9 3289.6 3378.1 3381.1 3382.0 3385.0 591.1 603.7 617.9 621.7 623.4 537.4 596.8 650.3 707.3 725.4 9165.7 9383.2 9467.1 9622.7 9802.7 631.9 703.3 755.6 775.5 795.4 4683.7 4825.9 5038.5 5065.3 5135.2 106419.0 107550.5 109982.5 111024.0 111601.0 30134.0 30403.8 67296.0 92776.5 93027.0 82633.2 83605.0 84110.2 84530.6 84634.6 9292.7 9418.2 9452.2 9469.5 9490.5 47936.0 48772.3 49046.5 49197.8 49735.8 63111.7 63679.4 64798.4 65008.0 65528.3 12475.6 12545.8 12848.9 12938.9 13200.3 10268.7 11778.7 13516.3 13991.2 14416.4 12524.7 12841.2 13355.1 14028.7 14351.3 13275.2 13739.9 14244.9 14289.5 14340.1 13351.5 13830.8 14270.1 14316.6 14418.1 10054.7 10144.2 10601.5 10795.8 10894.1 11231.5 11574.1 11823.3 11883.6 11925.9 06:03:44 INFO - PROCESS | 1147 | -------- Summary: end -------- 06:03:44 INFO - PROCESS | 1147 | 06:03:45 INFO - TEST-INFO | 1147: exit 0 06:03:45 INFO - TEST-OK | dromaeo_css | took 1112018ms 06:03:45 INFO - TEST-START | kraken 06:03:45 INFO - operating with platform_type : linux_ 06:03:45 INFO - Initialising browser for kraken test... 06:03:45 INFO - TEST-INFO | started process 1394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoD1Wsu/profile http://localhost:48348/getInfo.html) 06:03:49 INFO - PROCESS | 1394 | __metrics Screen width/height:1600/1200 06:03:49 INFO - PROCESS | 1394 | colorDepth:24 06:03:49 INFO - PROCESS | 1394 | Browser inner width/height: 1024/697 06:03:49 INFO - PROCESS | 1394 | __metrics 06:03:50 ERROR - PROCESS | 1394 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:03:50 INFO - PROCESS | 1394 | console.error: PushService: 06:03:50 INFO - PROCESS | 1394 | stateChangeProcessEnqueue: Error transitioning state 06:03:50 INFO - PROCESS | 1394 | UnknownError 06:03:51 INFO - TEST-INFO | 1394: exit 0 06:03:51 INFO - Browser initialized. 06:03:51 INFO - Running cycle 1/1 for kraken test... 06:03:51 INFO - TEST-INFO | started process 1474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoD1Wsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:04:02 INFO - PROCESS | 1474 | RSS: Main: 154427392 06:04:02 INFO - PROCESS | 1474 | 06:04:05 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-beat-detection) 06:04:06 INFO - PROCESS | 1474 | RSS: Main: 213680128 06:04:06 INFO - PROCESS | 1474 | 06:04:08 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-dft) 06:04:09 INFO - PROCESS | 1474 | RSS: Main: 202571776 06:04:09 INFO - PROCESS | 1474 | 06:04:12 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-fft) 06:04:12 INFO - PROCESS | 1474 | RSS: Main: 267038720 06:04:12 INFO - PROCESS | 1474 | 06:04:14 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48348/tests/kraken/driver.html?testName=audio-oscillator) 06:04:15 INFO - PROCESS | 1474 | RSS: Main: 177942528 06:04:15 INFO - PROCESS | 1474 | 06:04:17 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:18 INFO - PROCESS | 1474 | RSS: Main: 182624256 06:04:18 INFO - PROCESS | 1474 | 06:04:21 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:21 INFO - PROCESS | 1474 | RSS: Main: 218591232 06:04:21 INFO - PROCESS | 1474 | 06:04:25 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48348/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:25 INFO - PROCESS | 1474 | RSS: Main: 219070464 06:04:25 INFO - PROCESS | 1474 | 06:04:28 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48348/tests/kraken/driver.html?testName=json-parse-financial) 06:04:29 INFO - PROCESS | 1474 | RSS: Main: 218710016 06:04:29 INFO - PROCESS | 1474 | 06:04:30 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:31 INFO - PROCESS | 1474 | RSS: Main: 205201408 06:04:31 INFO - PROCESS | 1474 | 06:04:32 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:33 INFO - PROCESS | 1474 | RSS: Main: 209715200 06:04:33 INFO - PROCESS | 1474 | 06:04:35 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:36 INFO - PROCESS | 1474 | RSS: Main: 217374720 06:04:36 INFO - PROCESS | 1474 | 06:04:38 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:39 INFO - PROCESS | 1474 | RSS: Main: 221659136 06:04:39 INFO - PROCESS | 1474 | 06:04:42 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:42 INFO - PROCESS | 1474 | RSS: Main: 220987392 06:04:42 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | Cycle 1(1): loaded http://localhost:48348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48348/tests/kraken/driver.html?testName=ai-astar) 06:04:44 INFO - PROCESS | 1474 | RSS: Main: 263843840 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | __start_tp_report 06:04:44 INFO - PROCESS | 1474 | _x_x_mozilla_page_load 06:04:44 INFO - PROCESS | 1474 | _x_x_mozilla_page_load_details 06:04:44 INFO - PROCESS | 1474 | |i|pagename|runs| 06:04:44 INFO - PROCESS | 1474 | |0;ai-astar;114;108;113;114;114;113;113;112;112;112 06:04:44 INFO - PROCESS | 1474 | |1;audio-beat-detection;153;140;134;183;138;132;156;135;179;130 06:04:44 INFO - PROCESS | 1474 | |2;audio-dft;163;164;161;162;162;161;163;164;163;163 06:04:44 INFO - PROCESS | 1474 | |3;audio-fft;77;77;78;103;78;77;77;77;100;78 06:04:44 INFO - PROCESS | 1474 | |4;audio-oscillator;86;87;107;88;85;86;113;87;88;122 06:04:44 INFO - PROCESS | 1474 | |5;imaging-gaussian-blur;119;119;120;119;119;119;119;119;118;119 06:04:44 INFO - PROCESS | 1474 | |6;imaging-darkroom;150;148;149;149;151;148;150;149;149;150 06:04:44 INFO - PROCESS | 1474 | |7;imaging-desaturate;95;95;96;96;95;96;96;95;96;96 06:04:44 INFO - PROCESS | 1474 | |8;json-parse-financial;55;55;55;54;55;55;56;56;54;55 06:04:44 INFO - PROCESS | 1474 | |9;json-stringify-tinderbox;63;63;62;61;62;64;62;63;62;63 06:04:44 INFO - PROCESS | 1474 | |10;stanford-crypto-aes;82;82;84;83;84;83;82;85;119;83 06:04:44 INFO - PROCESS | 1474 | |11;stanford-crypto-ccm;137;143;143;136;139;131;136;130;142;131 06:04:44 INFO - PROCESS | 1474 | |12;stanford-crypto-pbkdf2;164;163;163;166;164;161;171;163;162;164 06:04:44 INFO - PROCESS | 1474 | |13;stanford-crypto-sha256-iterative;65;67;67;64;72;65;65;63;64;64 06:04:44 INFO - PROCESS | 1474 | __end_tp_report 06:04:44 INFO - PROCESS | 1474 | __start_cc_report 06:04:44 INFO - PROCESS | 1474 | _x_x_mozilla_cycle_collect,1478 06:04:44 INFO - PROCESS | 1474 | __end_cc_report 06:04:44 INFO - PROCESS | 1474 | __startTimestamp1465391084624__endTimestamp 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | ------- Summary: start ------- 06:04:44 INFO - PROCESS | 1474 | Number of tests: 14 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:1.80 06:04:44 INFO - PROCESS | 1474 | Values: 114.0 108.0 113.0 114.0 114.0 113.0 113.0 112.0 112.0 112.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:146.50 stddev:19.39 (13.2%) stddev-sans-first:20.48 06:04:44 INFO - PROCESS | 1474 | Values: 153.0 140.0 134.0 183.0 138.0 132.0 156.0 135.0 179.0 130.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 06:04:44 INFO - PROCESS | 1474 | Values: 163.0 164.0 161.0 162.0 162.0 161.0 163.0 164.0 163.0 163.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:10.21 (13.3%) stddev-sans-first:10.65 06:04:44 INFO - PROCESS | 1474 | Values: 77.0 77.0 78.0 103.0 78.0 77.0 77.0 77.0 100.0 78.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:86.50 stddev:13.68 (15.8%) stddev-sans-first:14.13 06:04:44 INFO - PROCESS | 1474 | Values: 86.0 87.0 107.0 88.0 85.0 86.0 113.0 87.0 88.0 122.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:119.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:04:44 INFO - PROCESS | 1474 | Values: 119.0 119.0 120.0 119.0 119.0 119.0 119.0 119.0 118.0 119.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:04:44 INFO - PROCESS | 1474 | Values: 150.0 148.0 149.0 149.0 151.0 148.0 150.0 149.0 149.0 150.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:04:44 INFO - PROCESS | 1474 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 06:04:44 INFO - PROCESS | 1474 | Values: 55.0 55.0 55.0 54.0 55.0 55.0 56.0 56.0 54.0 55.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:63.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 06:04:44 INFO - PROCESS | 1474 | Values: 63.0 63.0 62.0 61.0 62.0 64.0 62.0 63.0 62.0 63.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:11.39 (13.7%) stddev-sans-first:11.96 06:04:44 INFO - PROCESS | 1474 | Values: 82.0 82.0 84.0 83.0 84.0 83.0 82.0 85.0 119.0 83.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:138.00 stddev:4.98 (3.6%) stddev-sans-first:5.29 06:04:44 INFO - PROCESS | 1474 | Values: 137.0 143.0 143.0 136.0 139.0 131.0 136.0 130.0 142.0 131.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:2.77 (1.7%) stddev-sans-first:2.93 06:04:44 INFO - PROCESS | 1474 | Values: 164.0 163.0 163.0 166.0 164.0 161.0 171.0 163.0 162.0 164.0 06:04:44 INFO - PROCESS | 1474 | 06:04:44 INFO - PROCESS | 1474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.00 stddev:2.59 (4.0%) stddev-sans-first:2.74 06:04:44 INFO - PROCESS | 1474 | Values: 65.0 67.0 67.0 64.0 72.0 65.0 65.0 63.0 64.0 64.0 06:04:44 INFO - PROCESS | 1474 | -------- Summary: end -------- 06:04:44 INFO - PROCESS | 1474 | 06:04:45 INFO - TEST-INFO | 1474: exit 0 06:04:45 INFO - TEST-OK | kraken | took 59968ms 06:04:45 INFO - SUITE-END | took 1171s 06:04:45 INFO - Completed test suite (00:19:32) 06:04:45 INFO - javascript benchmark 06:04:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3074.2775447769773, 3107.8756849725996, 3130.5460708197306, 3134.0597820653797, 3157.9526307105384, 4824.107540105083, 5078.84763457096, 5211.843644690661, 5259.579233661308, 5284.048871203182, 5204.32343795307, 5207.9739601302035, 5218.086834803904, 5230.424653288135, 5277.577793776498, 4698.154332220199, 4720.433547974248, 4861.611071114302, 4873.22028475444, 4949.208126699728, 4846.975765121187, 4862.0275944811, 4905.803767849282, 4910.803567857281, 4930.260460930871, 4592.10453961476, 4595.632349412039, 4626.259798432268, 4664.976675116636, 4712.222483290253, 4621.306803979396, 4671.182543054952, 4686.81252749893, 4690.906181876378, 4718.9292160617615, 4618.1918164321105, 4637.536246375369, 4657.301404789275, 4661.95338046622, 4674.883127921795, 4949.653524253304, 5080.1617733074, 5127.2052831811125, 5185.688858668492, 5197.220416937452, 5630.634008789416, 5664.603477756558, 5672.432756724335, 5714.200011998323, 5719.71401429931, 5666.1784041314195, 5726.914096288559, 5740.74166662497, 5743.4543718346695, 5747.109198074305, 5109.20807274873, 5214.921776173361, 5296.708681022581, 5305.973470132663, 5366.463353664602, 5814.883702325929, 5820.214271073435, 5822.272215973004, 5828.213191219216, 5839.416058394211, 5262.02652509287, 5607.551395888319, 5619.325680918316, 5619.606627536115, 5632.690202038927, 5513.952349053748, 5555.30558680165, 5567.081431563746, 5588.776448942078, 5648.604597678205, 5566.332040155207, 5572.275604171513, 5586.860328491739, 5605.299337582802, 5623.790884959753, 5273.34083239595, 5532.363778165482, 5606.439356064361, 5617.775288988395, 5623.718814059281, 4303.0, 4303.440552728125, 4312.633426158749, 4345.130973805251, 4350.8694739157245, 3840.8861430185493, 3872.5159355080614, 3883.0292426893275, 3898.9610103899167, 3911.7261791674878, 5061.013102444987, 5108.335916330928, 5258.605604579595, 5261.789528418897, 5312.760925758273, 5641.661500309912, 5658.575606829504, 5675.3757086720425, 5705.5435565154685, 5723.399043100498, 5314.3091398117995, 5346.091164501966, 5349.1976203569775, 5375.16684913839, 5392.299001129828, 4470.150671372428, 4590.311453282035, 4643.95356046442, 4695.201815691341, 4715.882102947454, 5779.075347944308, 5795.420457954255, 5800.8259752207505, 5830.504407125357, 5839.0949402842625, 5658.349289831722, 5666.17840413146, 5678.772849086073, 5683.715814209356, 5687.004774164588, 5481.890362192814, 5706.087026075808, 5769.336526299529, 5818.4763371296785, 5823.126531020212, 5535.612507124623, 5542.7782888684005, 5579.302587176603, 5582.972085139549, 5587.245721827664, 5638.126090455986, 5653.2085508028085, 5653.236813030188, 5677.120046392815, 5692.5445964321925, 5305.124654431976, 5369.436209197978, 5444.3194600674915, 5513.145462453326, 5551.583631227593, 5451.672899626035, 5509.889802204014, 5515.172724091419, 5520.282363292747, 5528.75120619565, 5136.871578210575, 5138.665986710852, 5396.622236443412, 5407.297051383295, 5457.099578569491, 5489.258950041853, 5556.499915007668, 5569.749361278671, 5617.859553511032, 5624.85937851557, 5439.836804895701, 5456.699881506555, 5477.945220547744, 5493.670379777226, 5506.091494903296], "value": 5166.225086020681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.202257371531, 572.6993328502537, 585.9803941142408, 594.0406243916077, 598.5839841310288, 31811.363772724533, 35156.12109697256, 35173.296534069304, 45516.54483455164, 46896.0, 44412.0, 45162.32256516155, 45263.54736452635, 45421.31868021974, 45441.36469082474, 8730.956345218265, 8913.286937045053, 8922.375433719642, 8947.105289471034, 8962.37263391563, 8696.739097827076, 8821.206091451768, 8837.469751814911, 8846.778830529256, 8851.424657397249, 8816.779580510507, 8867.379283450162, 8878.334124940622, 8882.689105881296, 8885.600147993357, 8770.649174033031, 8825.470471771681, 8831.955840220759, 8878.334124940622, 8880.644774209024, 8473.237408633253, 8579.914200858037, 8693.0, 8736.0, 8762.693305734269, 41089.0, 41654.583454165375, 41846.163076738296, 41948.58051419508, 42119.7894010531, 3401.149712571857, 3411.0278570607506, 3436.639152888961, 3592.5329707137903, 3982.0, 30170.396592068035, 31331.216719581964, 31351.216219594466, 31352.686473135433, 31356.686433135834, 4032.858849940238, 4181.226473102455, 4225.302825033866, 4307.095509942916, 4356.302991521341, 337090.0, 337667.0, 341394.0, 341482.0, 341942.0, 59893.40106598965, 60077.399226008056, 60319.39680603226, 60580.69709651423, 60638.0, 63006.369936300965, 63030.369696303365, 63080.79949606614, 63220.36779632237, 63317.36682633115, 15662.843371566367, 15980.280887360097, 16197.109158996132, 16325.591860203353, 16329.673406531803, 11387.37369444672, 11488.59789907366, 11597.18819682614, 12367.69080772988, 12657.810132848015, 18691.626167476574, 19170.90414547946, 19372.61254774925, 19526.511837204183, 19551.80448195528, 6968.581885086911, 7143.142822861186, 7155.284471552803, 7181.245969173266, 7182.928170718331, 1009.5759780892043, 1105.7290963713942, 1130.7681925205313, 1130.9377984210782, 1162.2329262686756, 31822.681773182434, 32042.0, 32186.0, 32212.19469513281, 32666.020019399457, 1153.7231064544617, 1157.2015309436463, 1162.3258510064143, 1176.988230117705, 1181.6809461445362, 16193.59516012109, 16516.917415412845, 16798.916005419895, 16881.15594220284, 16952.884850115403, 517206.0, 524577.0, 525779.0, 526956.0, 528156.0, 58156.0, 59284.0, 59457.0, 59546.40453595408, 59802.70098649479, 1263.1978693529675, 1365.3105181883086, 1398.0632975906167, 1404.3329418526118, 1408.478862820763, 30519.344510827166, 32616.836915815267, 32825.34349313048, 33304.66695333113, 33440.832795835864, 44620.77689611531, 44793.0, 45008.0, 45029.0, 45031.54968450274, 381048.0, 381206.0, 384873.0, 385327.0, 386708.0, 22659.320220393416, 27486.725132749216, 27594.724052759215, 28798.424031519673, 29007.419851602426, 47081.293780592634, 47095.293570595786, 48263.27605085997, 48282.0, 48343.374246930915, 38994.6100538991, 39091.6090839088, 39508.0, 39531.40702889516, 39886.0, 38814.80592597019, 39480.40779388369, 39597.2080558393, 39865.2026959465, 39940.40089398719, 39314.80342598383, 39394.40908386434, 39687.80156099201, 39911.0, 40391.798041009606, 33662.0, 34897.47653785144, 35013.824930875184, 35741.46387804133, 35742.64257357393, 27204.0, 27341.726582733918, 27533.0, 27652.723472765818, 27787.44425111446], "value": 19781.99629426837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.686224451561, 396.68661757211805, 398.6611380326723, 403.9959600403996, 417.0075220974083, 13981.860181398182, 17364.739528907077, 18579.163937622805, 19343.419697409066, 19366.322178723763, 17271.740923886122, 18208.453746387597, 18511.44465666029, 19058.904705476452, 19077.332293369735, 5502.532284755801, 5608.755129958954, 5699.2306038684665, 5726.3414707308775, 5751.65490070595, 4007.73949693269, 5565.860853478655, 5688.374278829346, 6047.848803779897, 6379.298277189506, 6386.425221730044, 6396.808095757135, 6417.647029413381, 6419.325970773071, 6474.352564743512, 6230.096635987802, 6306.873862522747, 6428.550001499897, 6459.031145328191, 6468.967655161718, 4934.925976110361, 5626.690532020737, 5641.915371269434, 5643.971780141114, 5651.18057881609, 12841.614751557468, 12855.485780568766, 13113.344332783417, 13121.934390328082, 13156.802647960289, 2096.926607568743, 2128.053016407699, 2168.761436242012, 2287.553926984239, 2629.027259913825, 8987.640494380217, 9318.767030824216, 9688.46713430761, 12334.444949977273, 13177.813996740244, 1778.6087060846594, 1833.3399976008627, 1861.9348322808771, 1863.2733234038735, 1877.962440751191, 77927.0, 78797.0, 81726.59136704338, 82285.0, 82557.58721206416, 10189.184865210766, 10339.689809305733, 10460.790784184426, 10507.528945947573, 10610.257281990187, 12963.481460741465, 13429.127106738226, 13706.38321275545, 13889.444422222998, 13893.930530347283, 7569.697212111454, 7835.5690437026515, 8083.434159608771, 8156.980377452818, 8230.012398512217, 7877.606119694107, 7897.447178697436, 7910.920890791019, 7975.0, 7991.200879911962, 4629.606483448877, 4694.718316900997, 4730.195866702668, 4767.833125840579, 4777.689450185727, 1903.200655724599, 1939.1177014458387, 1950.756155480565, 1961.7253584498183, 1995.2019192322896, 873.2708188662411, 944.2729098594044, 952.9332946693664, 953.8903026151943, 980.9705708828747, 17407.73888391675, 17978.190981405867, 18254.0, 18442.907785460986, 18722.531936701693, 978.2027647467291, 1023.779887324214, 1029.624187171677, 1066.99466502667, 1083.6369816111533, 10030.29787914839, 10374.481275936323, 10409.323393979366, 10518.526666300035, 10541.84187237192, 464104.0, 485111.0, 493295.0, 494519.0, 497613.0, 92886.0, 93408.53295733478, 94971.0, 95829.04170958341, 96041.51979240059, 1010.3937637417491, 1011.2567263061644, 1035.5650626736788, 1059.0838924330399, 1061.639042725477, 16447.374973854472, 16522.339106435607, 16677.16614169311, 16684.332626695283, 16776.496705098867, 27957.92462829128, 29834.403311933205, 35507.46738798972, 37078.07304817401, 37117.62882371142, 48283.5171648279, 52608.473915261886, 52818.47181528136, 53020.734896326816, 53790.46209537855, 8372.748817535483, 8461.61922713467, 8495.23542881119, 8559.657613695383, 8685.826283474422, 9251.814963700554, 12234.26594404303, 12554.309512976874, 12806.551770687982, 13113.868861311264, 6582.0, 11038.50326735315, 11063.446827658745, 11104.389258590854, 11359.261647992855, 7218.494705370574, 11199.272047316897, 11260.662180134608, 11273.154513411691, 11412.429378530875, 9697.59384889173, 11242.0, 11612.187146899974, 11672.416379180837, 11712.824307635221, 8182.140875208018, 8240.258376745882, 8431.451955622864, 8461.576921154041, 8605.870911936452, 11319.886801131883, 11350.432478375884, 11425.0, 11468.197226194086, 11950.641480755592], "value": 8818.046509600905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.8818406343428, 1451.6878871042727, 1493.0444515510071, 1617.5470868156913, 1783.6700210461065, 8148.144444833296, 8510.404271700976, 8518.446300990432, 8732.08313127122, 8732.869006964886, 8516.489010659365, 8684.348673849456, 8685.218330350268, 8700.869486957701, 8705.085965973576, 1980.8316293115101, 2253.312739614417, 2278.646809744488, 2304.7349554801244, 2316.444053427174, 2341.812654987597, 2346.765323467648, 2349.8590084594894, 2349.95300093998, 2355.3993731598503, 2256.6050941085327, 2300.907963681459, 2303.6199027160496, 2308.4228942764307, 2320.7795259450327, 1939.8351140153034, 2174.4563859035243, 2226.209695558086, 2257.2325409360733, 2259.2544460328054, 2157.7626461089267, 2171.1423987524995, 2175.7280339957506, 2177.3903307074042, 2239.3729755668437, 8450.112738162466, 8558.572071396406, 8559.700410485602, 8590.269827064707, 8614.138586141398, 4939.604831613462, 5163.922541161885, 5166.715830629314, 5186.429492755794, 5211.843644690665, 3225.12921511193, 3227.3545290941906, 3327.1183136468853, 3327.6838700323674, 3390.8304584770663, 1124.7694222684331, 1137.5961533655598, 1146.146121139748, 1156.19066653343, 1162.7906976744182, 12069.879301207051, 12119.33343666098, 12122.636320910387, 12130.878691213064, 12143.696407589792, 4439.445069366329, 4476.306172543261, 4590.104929538707, 4596.241620132708, 4597.080583883237, 10224.284300098921, 10242.53908574116, 10244.436555989492, 10258.58965641366, 10266.794664106676, 4408.7575183365225, 5197.0, 5198.350206224222, 5203.089459344676, 5204.1673332266655, 4592.97703511487, 4758.095961767253, 4764.0, 4806.399200099988, 4818.614510839125, 3895.552011518655, 3928.705347098979, 4001.8599349022643, 4037.959620403817, 4063.79681015948, 1198.574506050357, 1206.1014544164655, 1215.1251099208555, 1217.0993464836135, 1217.6590554644713, 825.9834803303901, 901.5852707754507, 912.7672443526858, 924.9537523123817, 931.0921851195166, 5642.6614403135945, 5704.828855134353, 5733.541316694655, 5951.226340575698, 5959.910601340984, 935.4387367579534, 981.8232718110665, 997.2570435025807, 1007.1137399088901, 1051.810674078658, 3991.4212439196735, 4082.2651922653613, 4087.5094988600963, 4097.364908439196, 4137.586241375839, 10475.580976760844, 10762.677119686421, 10861.45692715377, 10919.563217471372, 10957.0, 10758.193135514868, 10781.838272425763, 10826.458677066115, 10854.240203185858, 10886.836697449544, 7630.427717921179, 8022.438429310009, 8027.759167224993, 8104.351651867836, 8247.835043299221, 5661.886762264649, 6020.6688632123905, 6115.296740874856, 6196.47329976939, 6208.906866396917, 9851.113399794052, 9947.552360143956, 10081.294309398272, 10089.09198172168, 10123.59505619767, 9436.433813971184, 9914.206863450763, 9976.351537150062, 10013.699589012342, 10205.13256373187, 6733.091032710521, 7258.237885022208, 7536.962315188389, 7646.158922518407, 7730.381569474316, 8399.790005249917, 8446.915530844859, 8489.108643592333, 8500.277476414327, 8503.532305723245, 7379.557226566423, 7548.1697013329585, 7604.885926711215, 7676.385889128968, 7699.307062364414, 7254.347108760237, 7312.41500679955, 7347.632618368953, 7386.852262954603, 7496.9250307498405, 6584.8024559263295, 6594.934050659432, 6649.63427011519, 6664.83337916556, 6676.532642715158, 4872.976674898169, 4913.213885778258, 5017.874553136201, 5103.923441148311, 5152.458991805806, 5092.821751238689, 5155.2782610433815, 5192.117340052276, 5238.319018527567, 5245.9475405246985], "value": 4552.781892448358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6795035089032, 327.91965968337763, 338.5750882642284, 338.82550486499457, 339.3010398578926, 4843.830465933693, 4958.231474121508, 5057.747112644367, 5062.797488100477, 5071.898562028758, 4995.650304478688, 4998.400191976959, 5052.84841454756, 5060.911903940652, 5096.133657278262, 4017.5379831319406, 4027.1140349123148, 4037.818298176589, 4044.029432936089, 4053.148838743867, 3790.0, 3795.053248690465, 3966.8809935701975, 3977.2102553850737, 3985.60143985602, 3981.840726370942, 3993.4409182714444, 3996.1408297216094, 4000.9399859002137, 4006.1186538961383, 3920.5099362579676, 3951.585083566242, 3958.683305335581, 3961.1285517186175, 3969.24584328978, 3522.172289511963, 3564.625714300013, 3575.4279315309427, 3581.0152208142968, 3586.659267369596, 4875.219964805614, 4889.217725163957, 4890.559849613516, 4950.232713929347, 4953.4303555091265, 4486.349479325512, 4492.775361231926, 4497.145542346943, 4527.7736113194205, 4531.252343363341, 5221.556167725748, 5236.842894713165, 5238.476152384731, 5252.8686782830355, 5278.6041046921255, 3673.4673472346626, 3871.2064026874705, 3886.805659717031, 3934.878559610497, 3957.703172262063, 5375.247465354853, 5444.863878403032, 5455.454454554513, 5497.99999999996, 5507.889842203133, 3990.980045099756, 4012.8932310537202, 4043.3126368516832, 4065.59344065597, 4080.224757296104, 4003.579624139482, 4026.2350153470748, 4052.858149964737, 4091.324931386288, 4104.199681062164, 4451.910961780746, 4509.391232183613, 4533.09609963816, 4558.954410455853, 4561.29299958507, 5280.419153893069, 5299.761510731949, 5350.946490535045, 5361.785528578891, 5369.140937449989, 1301.3883474766844, 1332.8667133286788, 1397.0360451288577, 1399.762040453105, 1409.1615488784157, 907.7685190276437, 912.7079334612993, 916.4180745226696, 916.7669484543279, 928.5329179895748, 4544.363789069533, 4581.679282450196, 4609.516000819865, 4614.569483460071, 4636.976815115971, 4704.835775543288, 4814.7833347498745, 4816.662833601685, 4827.903441931142, 4843.854684359475, 4513.691029601445, 4534.682572219913, 4556.817727290938, 4570.337301091389, 4581.289900065495, 2378.6669866218745, 2528.8229823912147, 2529.6837895263093, 2566.2814411964678, 2566.525192839331, 4818.614510839125, 4898.975505122523, 4924.778384972685, 4935.333729946411, 4945.455999840015, 4750.501197374226, 4770.640367495247, 4825.806967721322, 4832.49258827818, 4854.563089321908, 5250.949810038008, 5607.803726869622, 5648.209250704905, 5683.403242659627, 5685.516731077904, 5436.700981445901, 5508.256385387921, 5510.476504732044, 5518.255035570147, 5548.140038294071, 5309.575233981195, 5409.918851217313, 5428.208691131996, 5465.879494703497, 5484.232207490874, 5615.606907516435, 5630.465105814941, 5633.802816901389, 5651.954388438152, 5681.721612637123, 3890.7665540067687, 3895.24042811649, 3901.7463864848696, 3923.4311024900658, 3949.466821978996, 5293.364796224478, 5332.9733351333, 5486.573490892477, 5497.505224529811, 5535.861603459945, 5347.705876176848, 5348.171033489815, 5352.250684904195, 5352.839414817562, 5354.544863686475, 5094.258592859159, 5276.129438642581, 5339.092354299701, 5401.837944861661, 5410.621256512007, 5154.819581314786, 5168.922466162935, 5194.7272918133785, 5259.474052594863, 5261.263423120689, 5308.389535203501, 5334.546563542142, 5400.486953739389, 5415.891682166256, 5424.810131645373, 5108.879814876785, 5304.336957880265, 5308.946910530845, 5310.362756469249, 5324.307839980777], "value": 3994.2038751668492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.2127384335682, 753.9886901696478, 771.3289438188773, 774.8489044636298, 795.8965334506515, 15130.394784208618, 15521.68956620867, 15741.842581574181, 15783.763243551355, 15799.763003554941, 13409.664758381045, 13569.253691046988, 13604.659883502918, 13624.683803753362, 13659.521916732916, 657.1653999420732, 768.427521496486, 790.1703211627796, 790.731151408521, 792.4650860669054, 791.5685951156605, 801.2068052627885, 804.1596531624438, 804.2199066905092, 806.5563939833098, 854.8632218844986, 856.3106699107216, 860.1312674199073, 861.1861790607878, 862.2584577263548, 692.8094773937182, 823.0575990490914, 843.7215718812777, 845.4842546046906, 853.3216093205916, 616.3497510126814, 616.8766246750623, 616.9876602467971, 617.9443850053472, 618.7648693496443, 13126.60620181396, 13149.408276627479, 13160.0, 13169.934150329284, 13188.86811131886, 13563.864361356358, 13799.310034498234, 13861.168329900238, 13922.443102275896, 14179.361928713233, 12191.268523888506, 12368.381580921008, 12467.93766031173, 12537.122401431903, 12601.873981260162, 4312.396264522969, 4329.480462344539, 4392.648588112943, 4408.493023302329, 4426.867193984185, 72682.0, 73132.0, 73392.26607733908, 74680.62659686667, 75627.62186189034, 10627.734306642396, 10688.465576721133, 10757.569697212024, 10841.78316433667, 10843.566257349617, 17804.0, 17858.28566857337, 17888.642227155386, 17954.0, 17969.820301797077, 8384.622691978753, 8408.957955210184, 8440.915590844013, 8527.701530446404, 8532.829343413097, 4668.883277918011, 4671.95328046722, 4735.83424580138, 4790.5448982346625, 4920.876978075506, 3289.555909952174, 3378.071030466592, 3381.0871064812363, 3382.036119705921, 3384.966150338465, 591.1162811596605, 603.6800495737266, 617.8733359661259, 621.6518749500294, 623.4233334165879, 537.3685919045106, 596.7970889897456, 650.2879347114902, 707.3492387003969, 725.354434553248, 9165.725028249164, 9383.155516003593, 9467.147956683793, 9622.663206787729, 9802.705918822447, 631.8641492079225, 703.3107554596525, 755.5504474837463, 775.4571799740204, 795.3756301303449, 4683.672142949961, 4825.855224343275, 5038.521340472649, 5065.316182315414, 5135.229715542624, 106419.0, 107550.46224768827, 109982.45008774905, 111024.0, 111601.0, 30134.0, 30403.847980759954, 67296.0, 92776.53611731899, 93027.0, 82633.17366826255, 83605.0, 84110.15889841145, 84530.57734711288, 84634.57682711547, 9292.673945280838, 9418.208070900391, 9452.196563292197, 9469.526523673927, 9490.478023708762, 47936.0, 48772.2684159745, 49046.509534904195, 49197.754011229714, 49735.75132124316, 63111.6844415775, 63679.36320636734, 64798.35201648112, 65008.0, 65528.34471655413, 12475.625731228078, 12545.811812822632, 12848.871511284768, 12938.870611294144, 13200.339983001004, 10268.691939241835, 11778.705532361759, 13516.324183790575, 13991.23048232357, 14416.42334306616, 12524.749505010031, 12841.165324253894, 13355.131916425402, 14028.719425611227, 14351.282435877956, 13275.203487790763, 13739.931300343434, 14244.857551424353, 14289.499867504588, 14340.139591624536, 13351.532696355582, 13830.792538111735, 14270.072445291024, 14316.642083947985, 14418.0628259167, 10054.69835904924, 10144.21133024845, 10601.522931468257, 10795.838062428913, 10894.128469722562, 11231.536876597938, 11574.05568574474, 11823.349715765371, 11883.643490695293, 11925.940370298093], "value": 7263.930765091265, "unit": "score"}], "name": "dromaeo_css", "value": 7013.859156691037, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 114.0, 114.0, 113.0, 113.0, 112.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 140.0, 134.0, 183.0, 138.0, 132.0, 156.0, 135.0, 179.0, 130.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 162.0, 161.0, 163.0, 164.0, 163.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 103.0, 78.0, 77.0, 77.0, 77.0, 100.0, 78.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 107.0, 88.0, 85.0, 86.0, 113.0, 87.0, 88.0, 122.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 120.0, 119.0, 119.0, 119.0, 119.0, 119.0, 118.0, 119.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 149.0, 149.0, 151.0, 148.0, 150.0, 149.0, 149.0, 150.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 56.0, 56.0, 54.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 62.0, 64.0, 62.0, 63.0, 62.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 84.0, 83.0, 84.0, 83.0, 82.0, 85.0, 119.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 143.0, 136.0, 139.0, 131.0, 136.0, 130.0, 142.0, 131.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 166.0, 164.0, 161.0, 171.0, 163.0, 162.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 64.0, 72.0, 65.0, 65.0, 63.0, 64.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1534.7999999999997, "alertThreshold": 2.0}]} 06:04:45 INFO - Return code: 0 06:04:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:04:45 ERROR - # TBPL SUCCESS # 06:04:45 INFO - Running post-action listener: _resource_record_post_action 06:04:45 INFO - ##### 06:04:45 INFO - ##### Finished run-tests step (success) 06:04:45 INFO - ##### 06:04:45 INFO - Running post-run listener: _resource_record_post_run 06:04:45 INFO - Total resource usage - Wall time: 1190s; CPU: 26.0%; Read bytes: 0; Write bytes: 552181760; Read time: 0; Write time: 648876 06:04:45 INFO - TinderboxPrint: CPU usage
25.6% 06:04:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:04:45 INFO - TinderboxPrint: I/O write bytes / time
552,181,760 / 648,876 06:04:45 INFO - TinderboxPrint: CPU idle
7,062.8 (74.3%) 06:04:45 INFO - TinderboxPrint: CPU user
2,396.3 (25.2%) 06:04:45 INFO - TinderboxPrint: Swap in / out
0 / 0 06:04:45 INFO - install - Wall time: 17s; CPU: 27.0%; Read bytes: 0; Write bytes: 255107072; Read time: 0; Write time: 374864 06:04:45 INFO - run-tests - Wall time: 1174s; CPU: 26.0%; Read bytes: 0; Write bytes: 297074688; Read time: 0; Write time: 274012 06:04:46 INFO - Running post-run listener: _upload_blobber_files 06:04:46 INFO - Blob upload gear active. 06:04:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:46 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 06:04:46 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:46 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:46 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:04:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:04:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:50 INFO - (blobuploader) - INFO - Done attempting. 06:04:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:51 INFO - (blobuploader) - INFO - Done attempting. 06:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:52 INFO - (blobuploader) - INFO - Done attempting. 06:04:52 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:52 INFO - Return code: 0 06:04:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df8971e7923465c9fd80bb80a18eae0176ffb6690abf857c6614be8bbd3f536a21110e99e0be175fa3032077efbd165bf4dec5e3f38ef64d042e2c41d5eca0d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebf6c3e1759de42e37224ee2b7928ab93ba34890c45917f3251c8b3708b36ede895813b5364c59610c6a318b24d178788070ab9c5fba5a3709a2089671f662c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6f5169202aa52b3b23881913fe4e69b3257939ab921baaf8b8487967e72c7412f51a55dab56a8f338f5a3cd71c512577a1cd98986c51b900d4ac291efba359f"} 06:04:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:52 INFO - Contents: 06:04:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df8971e7923465c9fd80bb80a18eae0176ffb6690abf857c6614be8bbd3f536a21110e99e0be175fa3032077efbd165bf4dec5e3f38ef64d042e2c41d5eca0d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebf6c3e1759de42e37224ee2b7928ab93ba34890c45917f3251c8b3708b36ede895813b5364c59610c6a318b24d178788070ab9c5fba5a3709a2089671f662c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6f5169202aa52b3b23881913fe4e69b3257939ab921baaf8b8487967e72c7412f51a55dab56a8f338f5a3cd71c512577a1cd98986c51b900d4ac291efba359f"} 06:04:52 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:52 INFO - Copying logs to upload dir... 06:04:52 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.618894 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 06:04:51.660390) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:04:51.663636) ========= 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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df8971e7923465c9fd80bb80a18eae0176ffb6690abf857c6614be8bbd3f536a21110e99e0be175fa3032077efbd165bf4dec5e3f38ef64d042e2c41d5eca0d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebf6c3e1759de42e37224ee2b7928ab93ba34890c45917f3251c8b3708b36ede895813b5364c59610c6a318b24d178788070ab9c5fba5a3709a2089671f662c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6f5169202aa52b3b23881913fe4e69b3257939ab921baaf8b8487967e72c7412f51a55dab56a8f338f5a3cd71c512577a1cd98986c51b900d4ac291efba359f"} build_url:https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005406 build_url: 'https://queue.taskcluster.net/v1/task/N3WIhPEAQvCIcH9V43SbTA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df8971e7923465c9fd80bb80a18eae0176ffb6690abf857c6614be8bbd3f536a21110e99e0be175fa3032077efbd165bf4dec5e3f38ef64d042e2c41d5eca0d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebf6c3e1759de42e37224ee2b7928ab93ba34890c45917f3251c8b3708b36ede895813b5364c59610c6a318b24d178788070ab9c5fba5a3709a2089671f662c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6f5169202aa52b3b23881913fe4e69b3257939ab921baaf8b8487967e72c7412f51a55dab56a8f338f5a3cd71c512577a1cd98986c51b900d4ac291efba359f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 06:04:51.678810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:04:51.679101) ========= 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=d2a8c569965ab8367867b893000001a1-1465389740.959119-100504234 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002162 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 06:04:51.761863) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:04:51.762179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 06:04:51.762476) ========= ========= Total master_lag: 0.19 =========