builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1466780631.45 results: success (0) buildid: 20160624053027 builduid: d35f1f77e61c4dee83d12912dfad4eed revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.455391) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.455922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.456601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.497906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.498537) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 08:03:51-- 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% 46.2M=0s 2016-06-24 08:03:51 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.612626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.613276) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.666317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:51.666723) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9dac1358aaadcea90aca05b170fc8bc59e097d52 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9dac1358aaadcea90aca05b170fc8bc59e097d52 --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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 08:03:51,921 truncating revision to first 12 chars 2016-06-24 08:03:51,921 Setting DEBUG logging. 2016-06-24 08:03:51,921 attempt 1/10 2016-06-24 08:03:51,921 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9dac1358aaad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 08:03:52,228 unpacking tar archive at: fx-team-9dac1358aaad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:52.296906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:52.297565) ========= script_repo_revision: 9dac1358aaadcea90aca05b170fc8bc59e097d52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:52.298502) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:52.299150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 08:03:52.311191) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 08:03:52.311533) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:03:52 INFO - MultiFileLogger online at 20160624 08:03:52 in /builds/slave/test 08:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:03:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:52 INFO - {'append_to_log': False, 08:03:52 INFO - 'base_work_dir': '/builds/slave/test', 08:03:52 INFO - 'blob_upload_branch': 'Fx-Team', 08:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:52 INFO - 'branch': 'Fx-Team', 08:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:52 INFO - 'config_files': ('talos/linux_config.py',), 08:03:52 INFO - 'default_actions': ('clobber', 08:03:52 INFO - 'read-buildbot-config', 08:03:52 INFO - 'download-and-extract', 08:03:52 INFO - 'populate-webroot', 08:03:52 INFO - 'create-virtualenv', 08:03:52 INFO - 'install', 08:03:52 INFO - 'run-tests'), 08:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:52 INFO - 'download_minidump_stackwalk': True, 08:03:52 INFO - 'download_symbols': 'ondemand', 08:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:52 INFO - 'installer_path': 'installer.exe', 08:03:52 INFO - 'log_level': 'info', 08:03:52 INFO - 'log_name': 'talos', 08:03:52 INFO - 'log_to_console': True, 08:03:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:03:52 INFO - 'opt_config_files': (), 08:03:52 INFO - 'pip_index': False, 08:03:52 INFO - 'sps_profile': False, 08:03:52 INFO - 'sps_profile_interval': 0, 08:03:52 INFO - 'suite': 'dromaeojs', 08:03:52 INFO - 'system_bits': '32', 08:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:52 INFO - 'title': 'talos-linux64-ix-068', 08:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:52 INFO - 'use_talos_json': True, 08:03:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:52 INFO - 'work_dir': 'build'} 08:03:52 INFO - ##### 08:03:52 INFO - ##### Running clobber step. 08:03:52 INFO - ##### 08:03:52 INFO - Running pre-action listener: _resource_record_pre_action 08:03:52 INFO - Running main action method: clobber 08:03:52 INFO - rmtree: /builds/slave/test/build 08:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:53 INFO - Running post-action listener: _resource_record_post_action 08:03:53 INFO - ##### 08:03:53 INFO - ##### Finished clobber step (success) 08:03:53 INFO - ##### 08:03:53 INFO - ##### 08:03:53 INFO - ##### Running read-buildbot-config step. 08:03:53 INFO - ##### 08:03:53 INFO - Running pre-action listener: _resource_record_pre_action 08:03:53 INFO - Running main action method: read_buildbot_config 08:03:53 INFO - Using buildbot properties: 08:03:53 INFO - { 08:03:53 INFO - "project": "", 08:03:53 INFO - "product": "firefox", 08:03:53 INFO - "script_repo_revision": "production", 08:03:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:03:53 INFO - "repository": "", 08:03:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:03:53 INFO - "buildid": "20160624053027", 08:03:53 INFO - "pgo_build": "True", 08:03:53 INFO - "basedir": "/builds/slave/test", 08:03:53 INFO - "buildnumber": 1280, 08:03:53 INFO - "slavename": "talos-linux64-ix-068", 08:03:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:03:53 INFO - "platform": "ubuntu64_hw", 08:03:53 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:03:53 INFO - "branch": "fx-team", 08:03:53 INFO - "repo_path": "integration/fx-team", 08:03:53 INFO - "revision": "9dac1358aaadcea90aca05b170fc8bc59e097d52", 08:03:53 INFO - "stage_platform": "linux64-pgo", 08:03:53 INFO - "builduid": "d35f1f77e61c4dee83d12912dfad4eed", 08:03:53 INFO - "slavebuilddir": "test" 08:03:53 INFO - } 08:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:03:53 INFO - Running post-action listener: _resource_record_post_action 08:03:53 INFO - ##### 08:03:53 INFO - ##### Finished read-buildbot-config step (success) 08:03:53 INFO - ##### 08:03:53 INFO - ##### 08:03:53 INFO - ##### Running download-and-extract step. 08:03:53 INFO - ##### 08:03:53 INFO - Running pre-action listener: _resource_record_pre_action 08:03:53 INFO - Running main action method: download_and_extract 08:03:53 INFO - mkdir: /builds/slave/test/build/tests 08:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:53 INFO - https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:03:57 INFO - Downloaded 1361 bytes. 08:03:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:03:57 INFO - Using the following test package requirements: 08:03:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:03:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:03:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'jsshell-linux-x86_64.zip'], 08:03:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:03:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:03:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:03:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:03:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:03:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:03:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:03:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:03:57 INFO - https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:03:58 INFO - Downloaded 24277247 bytes. 08:03:58 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'] 08:03:58 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 08:03:59 INFO - Return code: 0 08:03:59 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 08:03:59 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')]} 08:03:59 INFO - https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:03:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:03:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:03:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:04:02 INFO - Downloaded 24277247 bytes. 08:04:02 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'] 08:04:02 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 08:04:04 INFO - Return code: 0 08:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:04 INFO - https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:04:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:04:05 INFO - Downloaded 14405518 bytes. 08:04:05 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'] 08:04:05 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 08:04:05 INFO - Return code: 0 08:04:05 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')]} 08:04:05 INFO - https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:04:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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 08:04:06 INFO - Downloaded 60185787 bytes. 08:04:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:06 INFO - mkdir: /builds/slave/test/properties 08:04:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:04:06 INFO - Writing to file /builds/slave/test/properties/build_url 08:04:06 INFO - Contents: 08:04:06 INFO - build_url:https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:04:07 INFO - Running post-action listener: _resource_record_post_action 08:04:07 INFO - Running post-action listener: set_extra_try_arguments 08:04:07 INFO - ##### 08:04:07 INFO - ##### Finished download-and-extract step (success) 08:04:07 INFO - ##### 08:04:07 INFO - ##### 08:04:07 INFO - ##### Running populate-webroot step. 08:04:07 INFO - ##### 08:04:07 INFO - Running pre-action listener: _resource_record_pre_action 08:04:07 INFO - Running main action method: populate_webroot 08:04:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:07 INFO - '--tppagecycles', 08:04:07 INFO - '7'], 08:04:07 INFO - 'tests': ['tsvgm']}}, 08:04:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:04:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:04:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:04:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['damp', 'tps']}, 08:04:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'tests': ['damp', 'tps']}, 08:04:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['dromaeo_dom']}, 08:04:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['basic_compositor_video']}, 08:04:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:04:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'other-e10s': {'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['a11yr', 08:04:07 INFO - 'ts_paint', 08:04:07 INFO - 'tpaint', 08:04:07 INFO - 'sessionrestore', 08:04:07 INFO - 'sessionrestore_no_auto_restore', 08:04:07 INFO - 'tabpaint']}, 08:04:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['tsvgx', 08:04:07 INFO - 'tsvgr_opacity', 08:04:07 INFO - 'tart', 08:04:07 INFO - 'tscrollx', 08:04:07 INFO - 'cart']}, 08:04:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:04:07 INFO - 'tsvgr_opacity', 08:04:07 INFO - 'tart', 08:04:07 INFO - 'tscrollx', 08:04:07 INFO - 'cart']}, 08:04:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'talos_options': ['--disable-e10s'], 08:04:07 INFO - 'tests': ['tp5o']}, 08:04:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'tests': ['tp5o']}, 08:04:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'talos_options': ['--disable-e10s', 08:04:07 INFO - '--xperf_path', 08:04:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:07 INFO - 'tests': ['tp5n']}, 08:04:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:07 INFO - 'talos_options': ['--xperf_path', 08:04:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:07 INFO - 'tests': ['tp5n']}}, 08:04:07 INFO - 'talos.zip': {'path': '', 08:04:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:07 INFO - Running post-action listener: _resource_record_post_action 08:04:07 INFO - ##### 08:04:07 INFO - ##### Finished populate-webroot step (success) 08:04:07 INFO - ##### 08:04:07 INFO - ##### 08:04:07 INFO - ##### Running create-virtualenv step. 08:04:07 INFO - ##### 08:04:07 INFO - Running pre-action listener: _resource_record_pre_action 08:04:07 INFO - Running main action method: create_virtualenv 08:04:07 INFO - Creating virtualenv /builds/slave/test/build/venv 08:04:07 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 08:04:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:04:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:07 INFO - Using real prefix '/usr' 08:04:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:04:08 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:10 INFO - Installing pip.................done. 08:04:10 INFO - Return code: 0 08:04:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:10 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 08:04:10 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 08:04:10 INFO - Using env: {'DISPLAY': ':0', 08:04:10 INFO - 'HOME': '/home/cltbld', 08:04:10 INFO - 'LANG': 'en_US.UTF-8', 08:04:10 INFO - 'LANGUAGE': 'en_US:en', 08:04:10 INFO - 'LOGNAME': 'cltbld', 08:04:10 INFO - 'MAIL': '/var/mail/cltbld', 08:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:10 INFO - 'MOZ_NO_REMOTE': '1', 08:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:10 INFO - 'NO_EM_RESTART': '1', 08:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:10 INFO - 'PWD': '/builds/slave/test', 08:04:10 INFO - 'SHELL': '/bin/bash', 08:04:10 INFO - 'SHLVL': '1', 08:04:10 INFO - 'TERM': 'linux', 08:04:10 INFO - 'TMOUT': '86400', 08:04:10 INFO - 'USER': 'cltbld', 08:04:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:10 INFO - '_': '/tools/buildbot/bin/python'} 08:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:10 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 08:04:10 INFO - Cleaning up... 08:04:10 INFO - Return code: 0 08:04:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:10 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 08:04:10 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 08:04:10 INFO - Using env: {'DISPLAY': ':0', 08:04:10 INFO - 'HOME': '/home/cltbld', 08:04:10 INFO - 'LANG': 'en_US.UTF-8', 08:04:10 INFO - 'LANGUAGE': 'en_US:en', 08:04:10 INFO - 'LOGNAME': 'cltbld', 08:04:10 INFO - 'MAIL': '/var/mail/cltbld', 08:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:10 INFO - 'MOZ_NO_REMOTE': '1', 08:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:10 INFO - 'NO_EM_RESTART': '1', 08:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:10 INFO - 'PWD': '/builds/slave/test', 08:04:10 INFO - 'SHELL': '/bin/bash', 08:04:10 INFO - 'SHLVL': '1', 08:04:10 INFO - 'TERM': 'linux', 08:04:10 INFO - 'TMOUT': '86400', 08:04:10 INFO - 'USER': 'cltbld', 08:04:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:10 INFO - '_': '/tools/buildbot/bin/python'} 08:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:10 INFO - Downloading/unpacking psutil>=3.1.1 08:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:12 INFO - Installing collected packages: psutil 08:04:12 INFO - Running setup.py install for psutil 08:04:12 INFO - building 'psutil._psutil_linux' extension 08:04:12 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 08:04:12 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 08:04:12 INFO - building 'psutil._psutil_posix' extension 08:04:12 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 08:04:13 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 08:04:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:13 INFO - Successfully installed psutil 08:04:13 INFO - Cleaning up... 08:04:13 INFO - Return code: 0 08:04:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:13 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:13 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 08:04:13 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 08:04:13 INFO - Using env: {'DISPLAY': ':0', 08:04:13 INFO - 'HOME': '/home/cltbld', 08:04:13 INFO - 'LANG': 'en_US.UTF-8', 08:04:13 INFO - 'LANGUAGE': 'en_US:en', 08:04:13 INFO - 'LOGNAME': 'cltbld', 08:04:13 INFO - 'MAIL': '/var/mail/cltbld', 08:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:13 INFO - 'MOZ_NO_REMOTE': '1', 08:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:13 INFO - 'NO_EM_RESTART': '1', 08:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:13 INFO - 'PWD': '/builds/slave/test', 08:04:13 INFO - 'SHELL': '/bin/bash', 08:04:13 INFO - 'SHLVL': '1', 08:04:13 INFO - 'TERM': 'linux', 08:04:13 INFO - 'TMOUT': '86400', 08:04:13 INFO - 'USER': 'cltbld', 08:04:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:13 INFO - '_': '/tools/buildbot/bin/python'} 08:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:13 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 08:04:13 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 08:04:13 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 08:04:13 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 08:04:13 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 08:04:13 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 08:04:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:15 INFO - Installing collected packages: mozsystemmonitor 08:04:15 INFO - Running setup.py install for mozsystemmonitor 08:04:15 INFO - Successfully installed mozsystemmonitor 08:04:15 INFO - Cleaning up... 08:04:15 INFO - Return code: 0 08:04:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04:15 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')]} 08:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:15 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')]} 08:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:15 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:15 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 08:04:15 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 08:04:15 INFO - Using env: {'DISPLAY': ':0', 08:04:15 INFO - 'HOME': '/home/cltbld', 08:04:15 INFO - 'LANG': 'en_US.UTF-8', 08:04:15 INFO - 'LANGUAGE': 'en_US:en', 08:04:15 INFO - 'LOGNAME': 'cltbld', 08:04:15 INFO - 'MAIL': '/var/mail/cltbld', 08:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:15 INFO - 'MOZ_NO_REMOTE': '1', 08:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:15 INFO - 'NO_EM_RESTART': '1', 08:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:15 INFO - 'PWD': '/builds/slave/test', 08:04:15 INFO - 'SHELL': '/bin/bash', 08:04:15 INFO - 'SHLVL': '1', 08:04:15 INFO - 'TERM': 'linux', 08:04:15 INFO - 'TMOUT': '86400', 08:04:15 INFO - 'USER': 'cltbld', 08:04:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:15 INFO - '_': '/tools/buildbot/bin/python'} 08:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:04:15 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 08:04:15 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 08:04:15 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 08:04:15 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 08:04:15 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 08:04:15 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 08:04:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04:17 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 08:04:17 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 08:04:17 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 08:04:17 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 08:04:17 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 08:04:17 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 08:04:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:17 INFO - warning: no files found matching '*.txt' 08:04:17 INFO - no previously-included directories found matching 'build' 08:04:17 INFO - no previously-included directories found matching 'dist' 08:04:17 INFO - no previously-included directories found matching '.git*' 08:04:17 INFO - Installing collected packages: jsonschema, functools32 08:04:17 INFO - Running setup.py install for functools32 08:04:18 INFO - warning: no files found matching '*.txt' 08:04:18 INFO - no previously-included directories found matching 'build' 08:04:18 INFO - no previously-included directories found matching 'dist' 08:04:18 INFO - no previously-included directories found matching '.git*' 08:04:18 INFO - Successfully installed jsonschema functools32 08:04:18 INFO - Cleaning up... 08:04:18 INFO - Return code: 0 08:04:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:18 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:18 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 08:04:18 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 08:04:18 INFO - Using env: {'DISPLAY': ':0', 08:04:18 INFO - 'HOME': '/home/cltbld', 08:04:18 INFO - 'LANG': 'en_US.UTF-8', 08:04:18 INFO - 'LANGUAGE': 'en_US:en', 08:04:18 INFO - 'LOGNAME': 'cltbld', 08:04:18 INFO - 'MAIL': '/var/mail/cltbld', 08:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:18 INFO - 'MOZ_NO_REMOTE': '1', 08:04:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:18 INFO - 'NO_EM_RESTART': '1', 08:04:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:18 INFO - 'PWD': '/builds/slave/test', 08:04:18 INFO - 'SHELL': '/bin/bash', 08:04:18 INFO - 'SHLVL': '1', 08:04:18 INFO - 'TERM': 'linux', 08:04:18 INFO - 'TMOUT': '86400', 08:04:18 INFO - 'USER': 'cltbld', 08:04:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:18 INFO - '_': '/tools/buildbot/bin/python'} 08:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:20 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:20 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 08:04:21 INFO - Downloading docopt-0.6.1.tar.gz 08:04:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:21 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:21 INFO - Running setup.py install for blobuploader 08:04:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:21 INFO - Running setup.py install for requests 08:04:21 INFO - Running setup.py install for docopt 08:04:21 INFO - Successfully installed blobuploader requests docopt 08:04:21 INFO - Cleaning up... 08:04:21 INFO - Return code: 0 08:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:21 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')]} 08:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:21 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')]} 08:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:21 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:21 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 08:04:21 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 08:04:21 INFO - Using env: {'DISPLAY': ':0', 08:04:21 INFO - 'HOME': '/home/cltbld', 08:04:21 INFO - 'LANG': 'en_US.UTF-8', 08:04:21 INFO - 'LANGUAGE': 'en_US:en', 08:04:21 INFO - 'LOGNAME': 'cltbld', 08:04:21 INFO - 'MAIL': '/var/mail/cltbld', 08:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:21 INFO - 'MOZ_NO_REMOTE': '1', 08:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:21 INFO - 'NO_EM_RESTART': '1', 08:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:21 INFO - 'PWD': '/builds/slave/test', 08:04:21 INFO - 'SHELL': '/bin/bash', 08:04:21 INFO - 'SHLVL': '1', 08:04:21 INFO - 'TERM': 'linux', 08:04:21 INFO - 'TMOUT': '86400', 08:04:21 INFO - 'USER': 'cltbld', 08:04:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:21 INFO - '_': '/tools/buildbot/bin/python'} 08:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:21 INFO - Running setup.py (path:/tmp/pip-yj8ooR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:21 INFO - Running setup.py (path:/tmp/pip-xXbyE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:22 INFO - Running setup.py (path:/tmp/pip-Hl9wps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:22 INFO - Running setup.py (path:/tmp/pip-tXyxs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:22 INFO - Running setup.py (path:/tmp/pip-6gYT3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:22 INFO - Running setup.py (path:/tmp/pip-v6sfOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:22 INFO - Running setup.py (path:/tmp/pip-rMC7pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:22 INFO - Running setup.py (path:/tmp/pip-USbWs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:22 INFO - Running setup.py (path:/tmp/pip-cj8EQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:22 INFO - Running setup.py (path:/tmp/pip-ychMoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:22 INFO - Running setup.py (path:/tmp/pip-XSjJ1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:22 INFO - Running setup.py (path:/tmp/pip-fQai4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:22 INFO - Running setup.py (path:/tmp/pip-opR3tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:22 INFO - Running setup.py (path:/tmp/pip-M8ARwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:22 INFO - Running setup.py (path:/tmp/pip-Brgb4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:22 INFO - Running setup.py (path:/tmp/pip-sJkNaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:23 INFO - Running setup.py (path:/tmp/pip-vmBXve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:23 INFO - Running setup.py install for manifestparser 08:04:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Running setup.py install for mozcrash 08:04:23 INFO - Running setup.py install for mozdebug 08:04:23 INFO - Running setup.py install for mozdevice 08:04:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Running setup.py install for mozfile 08:04:23 INFO - Running setup.py install for mozhttpd 08:04:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Running setup.py install for mozinfo 08:04:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Running setup.py install for mozInstall 08:04:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:23 INFO - Running setup.py install for mozleak 08:04:24 INFO - Running setup.py install for mozlog 08:04:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Running setup.py install for moznetwork 08:04:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Running setup.py install for mozprocess 08:04:24 INFO - Running setup.py install for mozprofile 08:04:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Running setup.py install for mozrunner 08:04:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Running setup.py install for mozscreenshot 08:04:24 INFO - Running setup.py install for moztest 08:04:24 INFO - Running setup.py install for mozversion 08:04:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:24 INFO - Cleaning up... 08:04:24 INFO - Return code: 0 08:04:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:24 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:24 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 08:04:24 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 08:04:24 INFO - Using env: {'DISPLAY': ':0', 08:04:24 INFO - 'HOME': '/home/cltbld', 08:04:24 INFO - 'LANG': 'en_US.UTF-8', 08:04:24 INFO - 'LANGUAGE': 'en_US:en', 08:04:24 INFO - 'LOGNAME': 'cltbld', 08:04:24 INFO - 'MAIL': '/var/mail/cltbld', 08:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:24 INFO - 'MOZ_NO_REMOTE': '1', 08:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:24 INFO - 'NO_EM_RESTART': '1', 08:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:24 INFO - 'PWD': '/builds/slave/test', 08:04:24 INFO - 'SHELL': '/bin/bash', 08:04:24 INFO - 'SHLVL': '1', 08:04:24 INFO - 'TERM': 'linux', 08:04:24 INFO - 'TMOUT': '86400', 08:04:24 INFO - 'USER': 'cltbld', 08:04:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:24 INFO - '_': '/tools/buildbot/bin/python'} 08:04:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:25 INFO - Running setup.py (path:/tmp/pip-6seANy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:25 INFO - Running setup.py (path:/tmp/pip-XXNGHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:25 INFO - Running setup.py (path:/tmp/pip-c8Ybuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:25 INFO - Running setup.py (path:/tmp/pip-fqJPWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:25 INFO - Running setup.py (path:/tmp/pip-JljQqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:25 INFO - Running setup.py (path:/tmp/pip-l4wnYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:25 INFO - Running setup.py (path:/tmp/pip-cybCYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:25 INFO - Running setup.py (path:/tmp/pip-1_8fgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:25 INFO - Running setup.py (path:/tmp/pip-lCElGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:25 INFO - Running setup.py (path:/tmp/pip-ora524-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:25 INFO - Running setup.py (path:/tmp/pip-P0ryy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:25 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)) 08:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:25 INFO - Running setup.py (path:/tmp/pip-gF3nTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:26 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)) 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:26 INFO - Running setup.py (path:/tmp/pip-DShAx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:26 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)) 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:26 INFO - Running setup.py (path:/tmp/pip-nrJSMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:26 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)) 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:26 INFO - Running setup.py (path:/tmp/pip-u1avjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:26 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)) 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:26 INFO - Running setup.py (path:/tmp/pip-NNdTnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:26 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)) 08:04:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:26 INFO - Running setup.py (path:/tmp/pip-Vj0DfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:26 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 08:04:28 INFO - Downloading blessings-1.6.tar.gz 08:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:28 INFO - Installing collected packages: blessings 08:04:28 INFO - Running setup.py install for blessings 08:04:28 INFO - Successfully installed blessings 08:04:28 INFO - Cleaning up... 08:04:28 INFO - Return code: 0 08:04:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:28 INFO - Reading from file tmpfile_stdout 08:04:28 INFO - Current package versions: 08:04:28 INFO - argparse == 1.2.1 08:04:28 INFO - blessings == 1.6 08:04:28 INFO - blobuploader == 1.2.4 08:04:28 INFO - docopt == 0.6.1 08:04:28 INFO - functools32 == 3.2.3-2 08:04:28 INFO - jsonschema == 2.5.1 08:04:28 INFO - manifestparser == 1.1 08:04:28 INFO - mozInstall == 1.12 08:04:28 INFO - mozcrash == 0.17 08:04:28 INFO - mozdebug == 0.1 08:04:28 INFO - mozdevice == 0.48 08:04:28 INFO - mozfile == 1.2 08:04:28 INFO - mozhttpd == 0.7 08:04:28 INFO - mozinfo == 0.9 08:04:28 INFO - mozleak == 0.1 08:04:28 INFO - mozlog == 3.2 08:04:28 INFO - moznetwork == 0.27 08:04:28 INFO - mozprocess == 0.22 08:04:28 INFO - mozprofile == 0.28 08:04:28 INFO - mozrunner == 6.11 08:04:28 INFO - mozscreenshot == 0.1 08:04:28 INFO - mozsystemmonitor == 0.3 08:04:28 INFO - moztest == 0.7 08:04:28 INFO - mozversion == 1.4 08:04:28 INFO - psutil == 3.1.1 08:04:28 INFO - requests == 1.2.3 08:04:28 INFO - wsgiref == 0.1.2 08:04:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:28 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:28 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 08:04:28 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 08:04:28 INFO - Using env: {'DISPLAY': ':0', 08:04:28 INFO - 'HOME': '/home/cltbld', 08:04:28 INFO - 'LANG': 'en_US.UTF-8', 08:04:28 INFO - 'LANGUAGE': 'en_US:en', 08:04:28 INFO - 'LOGNAME': 'cltbld', 08:04:28 INFO - 'MAIL': '/var/mail/cltbld', 08:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:28 INFO - 'MOZ_NO_REMOTE': '1', 08:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:28 INFO - 'NO_EM_RESTART': '1', 08:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:28 INFO - 'PWD': '/builds/slave/test', 08:04:28 INFO - 'SHELL': '/bin/bash', 08:04:28 INFO - 'SHLVL': '1', 08:04:28 INFO - 'TERM': 'linux', 08:04:28 INFO - 'TMOUT': '86400', 08:04:28 INFO - 'USER': 'cltbld', 08:04:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:28 INFO - '_': '/tools/buildbot/bin/python'} 08:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 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)) 08:04:28 INFO - Cleaning up... 08:04:28 INFO - Return code: 0 08:04:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:28 INFO - Using env: {'DISPLAY': ':0', 08:04:28 INFO - 'HOME': '/home/cltbld', 08:04:28 INFO - 'LANG': 'en_US.UTF-8', 08:04:28 INFO - 'LANGUAGE': 'en_US:en', 08:04:28 INFO - 'LOGNAME': 'cltbld', 08:04:28 INFO - 'MAIL': '/var/mail/cltbld', 08:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:28 INFO - 'MOZ_NO_REMOTE': '1', 08:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:28 INFO - 'NO_EM_RESTART': '1', 08:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:28 INFO - 'PWD': '/builds/slave/test', 08:04:28 INFO - 'SHELL': '/bin/bash', 08:04:28 INFO - 'SHLVL': '1', 08:04:28 INFO - 'TERM': 'linux', 08:04:28 INFO - 'TMOUT': '86400', 08:04:28 INFO - 'USER': 'cltbld', 08:04:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:28 INFO - '_': '/tools/buildbot/bin/python'} 08:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:29 INFO - Cleaning up... 08:04:29 INFO - Return code: 0 08:04:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:29 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 0x7f7de9dd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21dd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', '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 08:04:29 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 08:04:29 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 08:04:29 INFO - Using env: {'DISPLAY': ':0', 08:04:29 INFO - 'HOME': '/home/cltbld', 08:04:29 INFO - 'LANG': 'en_US.UTF-8', 08:04:29 INFO - 'LANGUAGE': 'en_US:en', 08:04:29 INFO - 'LOGNAME': 'cltbld', 08:04:29 INFO - 'MAIL': '/var/mail/cltbld', 08:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:29 INFO - 'MOZ_NO_REMOTE': '1', 08:04:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:29 INFO - 'NO_EM_RESTART': '1', 08:04:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:29 INFO - 'PWD': '/builds/slave/test', 08:04:29 INFO - 'SHELL': '/bin/bash', 08:04:29 INFO - 'SHLVL': '1', 08:04:29 INFO - 'TERM': 'linux', 08:04:29 INFO - 'TMOUT': '86400', 08:04:29 INFO - 'USER': 'cltbld', 08:04:29 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:29 INFO - '_': '/tools/buildbot/bin/python'} 08:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:29 INFO - Downloading/unpacking flake8 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:29 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 08:04:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:04:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:04:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 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 08:04:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:04:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:32 INFO - no previously-included directories found matching 'docs/_build' 08:04:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:04:32 INFO - Running setup.py install for pep8 08:04:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:04:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:04:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:04:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:04:32 INFO - no previously-included directories found matching 'docs/_build' 08:04:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:04:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:04:32 INFO - Cleaning up... 08:04:32 INFO - Return code: 0 08:04:32 INFO - Running post-action listener: _resource_record_post_action 08:04:32 INFO - Running post-action listener: _start_resource_monitoring 08:04:32 INFO - Starting resource monitoring. 08:04:32 INFO - ##### 08:04:32 INFO - ##### Finished create-virtualenv step (success) 08:04:32 INFO - ##### 08:04:32 INFO - ##### 08:04:32 INFO - ##### Running install step. 08:04:32 INFO - ##### 08:04:32 INFO - Running pre-action listener: _resource_record_pre_action 08:04:32 INFO - Running main action method: install 08:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:32 INFO - Reading from file tmpfile_stdout 08:04:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:32 INFO - Reading from file tmpfile_stdout 08:04:32 INFO - Output received: 08:04:32 INFO - Usage: mozinstall [options] installer 08:04:32 INFO - Options: 08:04:32 INFO - -h, --help show this help message and exit 08:04:32 INFO - -d DEST, --destination=DEST 08:04:32 INFO - Directory to install application into. [default: 08:04:32 INFO - "/builds/slave/test"] 08:04:32 INFO - --app=APP Application being installed. [default: firefox] 08:04:32 INFO - mkdir: /builds/slave/test/build/application 08:04:32 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'] 08:04:32 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 08:04:49 INFO - Reading from file tmpfile_stdout 08:04:49 INFO - Output received: 08:04:49 INFO - /builds/slave/test/build/application/firefox/firefox 08:04:49 INFO - Running post-action listener: _resource_record_post_action 08:04:49 INFO - ##### 08:04:49 INFO - ##### Finished install step (success) 08:04:49 INFO - ##### 08:04:49 INFO - ##### 08:04:49 INFO - ##### Running run-tests step. 08:04:49 INFO - ##### 08:04:49 INFO - Running pre-action listener: _resource_record_pre_action 08:04:49 INFO - Running main action method: run_tests 08:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:49 INFO - Python 2.7.3 08:04:49 INFO - Return code: 0 08:04:49 INFO - grabbing minidump binary from tooltool 08:04:49 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')]} 08:04:49 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 0x226c1c0>, '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 0x226d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x226d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:49 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 08:04:49 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 08:04:49 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 08:04:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:49 INFO - Return code: 0 08:04:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:04:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:04:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:04:50 INFO - Return code: 0 08:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 08:04:50 INFO - Using env: {'DISPLAY': ':0', 08:04:50 INFO - 'HOME': '/home/cltbld', 08:04:50 INFO - 'LANG': 'en_US.UTF-8', 08:04:50 INFO - 'LANGUAGE': 'en_US:en', 08:04:50 INFO - 'LOGNAME': 'cltbld', 08:04:50 INFO - 'MAIL': '/var/mail/cltbld', 08:04:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:50 INFO - 'MOZ_NO_REMOTE': '1', 08:04:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:50 INFO - 'NO_EM_RESTART': '1', 08:04:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:50 INFO - 'PWD': '/builds/slave/test', 08:04:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:50 INFO - 'SHELL': '/bin/bash', 08:04:50 INFO - 'SHLVL': '1', 08:04:50 INFO - 'TERM': 'linux', 08:04:50 INFO - 'TMOUT': '86400', 08:04:50 INFO - 'USER': 'cltbld', 08:04:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871', 08:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:50 INFO - '_': '/tools/buildbot/bin/python'} 08:04:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 08:04:50 INFO - mozversion application_buildid: 20160624053027 08:04:50 INFO - mozversion application_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 08:04:50 INFO - mozversion application_display_name: Nightly 08:04:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:50 INFO - mozversion application_name: Firefox 08:04:50 INFO - mozversion application_remotingname: firefox 08:04:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:04:50 INFO - mozversion application_vendor: Mozilla 08:04:50 INFO - mozversion application_version: 50.0a1 08:04:50 INFO - mozversion platform_buildid: 20160624053027 08:04:50 INFO - mozversion platform_changeset: 9dac1358aaadcea90aca05b170fc8bc59e097d52 08:04:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:04:50 INFO - mozversion platform_version: 50.0a1 08:04:50 INFO - using testdate: 1466780690 08:04:50 INFO - actual date: 1466780690 08:04:50 INFO - starting webserver on 'localhost:35750' 08:04:50 INFO - SUITE-START | Running 2 tests 08:04:50 INFO - TEST-START | dromaeo_css 08:04:50 INFO - operating with platform_type : linux_ 08:04:50 INFO - Initialising browser for dromaeo_css test... 08:04:50 INFO - TEST-INFO | started process 19619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtw8lw/profile http://localhost:35750/getInfo.html) 08:04:55 INFO - PROCESS | 19619 | __metrics Screen width/height:1600/1200 08:04:55 INFO - PROCESS | 19619 | colorDepth:24 08:04:55 INFO - PROCESS | 19619 | Browser inner width/height: 1024/697 08:04:55 INFO - PROCESS | 19619 | __metrics 08:04:56 INFO - PROCESS | 19619 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:57 INFO - TEST-INFO | 19619: exit 0 08:04:57 INFO - Browser initialized. 08:04:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:57 INFO - TEST-INFO | started process 19702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNtw8lw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:09 INFO - PROCESS | 19702 | RSS: Main: 173387776 08:05:09 INFO - PROCESS | 19702 | 08:06:00 INFO - PROCESS | 19702 | 1466780760155 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] 08:08:09 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35750/tests/dromaeo/cssquery-ext.html) 08:08:10 INFO - PROCESS | 19702 | RSS: Main: 264077312 08:08:10 INFO - PROCESS | 19702 | 08:11:12 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-ext.html (next: http://localhost:35750/tests/dromaeo/cssquery-jquery.html) 08:11:13 INFO - PROCESS | 19702 | RSS: Main: 263798784 08:11:13 INFO - PROCESS | 19702 | 08:14:15 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35750/tests/dromaeo/cssquery-mootools.html) 08:14:15 INFO - PROCESS | 19702 | RSS: Main: 268857344 08:14:15 INFO - PROCESS | 19702 | 08:17:17 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35750/tests/dromaeo/cssquery-prototype.html) 08:17:18 INFO - PROCESS | 19702 | RSS: Main: 266895360 08:17:18 INFO - PROCESS | 19702 | 08:20:21 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35750/tests/dromaeo/cssquery-yui.html) 08:20:21 INFO - PROCESS | 19702 | RSS: Main: 251953152 08:20:21 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | Cycle 1(1): loaded http://localhost:35750/tests/dromaeo/cssquery-yui.html (next: http://localhost:35750/tests/dromaeo/cssquery-dojo.html) 08:23:24 INFO - PROCESS | 19702 | RSS: Main: 307625984 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | __start_tp_report 08:23:24 INFO - PROCESS | 19702 | _x_x_mozilla_page_load 08:23:24 INFO - PROCESS | 19702 | _x_x_mozilla_page_load_details 08:23:24 INFO - PROCESS | 19702 | |i|pagename|runs| 08:23:24 INFO - PROCESS | 19702 | |0;dojo.html;3073.2163298358914;3079.276370053037;3098.5662007318992;3106.8757249710006;3144.7484201263887;5147.433782283946;5246.921296180561;5299.364076310843;5379;5422.620416570841;5326.254324394578;5333.413324534308;5339.652922560031;5347.518723314901;5384.165454354572;4810.230363141898;4857.247126695368;4893.730844803535;4907.509249075099;5042.82350117746;4936.259561065833;4944.307796908436;4974.900501989958;4991.875203119915;5006.374203224597;4750.643701722367;4772.236442169236;4797.016611594632;4821.445533763627;4858.489858564871;4775.5224477551965;4781.784819683123;4786.688865223749;4789.544993225638;4899.240617704261;4788.257820037899;4812.941152946346;4834.250691142878;4839.467658557556;4875.512448755132;5187.662801917863;5231.869203269949;5263.947360526384;5290.074237008546;5339.65292256006;5659.773609055633;5691.288588926384;5694.402087780765;5695;5717.2281741965135;5758.021136406821;5769.509591684712;5770.971145144289;5777.133429985493;5777.508911742507;5217.243499692561;5315.229291752674;5381.165919282478;5383.192521121863;5430.185472179205;5948.256467941507;5956.702164891738;5957.225560677084;5957.255343082114;5957.880842383128;5394.703291318937;5707.286589176353;5711.628744131701;5712.371639119693;5715.714214289269;5586.52514536269;5639.520640745583;5642.746076426571;5686.9715651421475;5687.118496633028;5648.039833228361;5649.519790817826;5655.3779084300695;5655.519280861173;5668.178114173422;5438.211459338374;5621.4378562144275;5677.3471050829685;5677.772889084473;5683.829485115453;4357.0196705740955;4367.737935723803;4391.3193455014525;4432.601065904019;4433.645308375322;3902.70729695274;3925.293447179478;3933.5869733678123;3935.6064393560414;3960.663343615767;5235.764390602432;5238.135707608279;5288.286081379041;5432.158015507603;5475.616706830563;5604.32748070226;5640.182173584889;5666.9716651416475;5669.773209071674;5707.086866101404;5338.3593968724;5351.384590772033;5353.170258609922;5354.732263386815;5361.463853614685;4799.18413869643;4886.242632391985;4910.312556242129;4915.705057696549;4948.307236986825;5936.406359364116;5937.940620593825;5940.227770389822;5950.137230101611;5977.372375900555;5750.281214848144;5765.913511297418;5766.250387449605;5769.8557536061935;5771.5671324649975;5649.576281778801;5756.71216439168;5773.220615216892;5809.883802324014;5908.763649454146;5576.498115169654;5593;5597.356304024926;5598.916016259678;5603;5652.3217213934595;5689.431056894277;5696.886062278649;5701.971490142689;5702.572307076903;5383.67697938125;5529.557635389078;5559.388467268516;5593.300837395325;5618.887622247614;5607.943920560742;5613.410591887956;5614.6631202128;5616.4383561645145;5623.493885550321;5291.735413229246;5420.539254163283;5455.099908515051;5468.343798744176;5515.338159420895;5537.058700020925;5581.246531718329;5583.888322233452;5646;5664.150377443417;5473.562115030708;5485.149801780571;5495;5496.1755736639825;5527.585431092603 08:23:24 INFO - PROCESS | 19702 | |1;ext.html;606.963582185069;609.9878002439951;612.5222326585259;615.6460035479599;628.5945565110505;30218;40715.38926916099;42048.369274460834;42123.78938105305;45799.77100114503;44488.11023779523;44838.10323793522;44926.550734492645;44964.77517612407;44976;8871.24594409476;9003.639854405816;9020.278377729766;9024.052474490183;9027.548622568878;8793.604287807031;8831.11688831115;8854.158854908806;8863.379563430562;8946.194842464178;8900.976387715431;8937.150970657776;8978.461292322449;8981.101889811032;8985.101489851028;8798.988116366603;8853.73438796837;8901.554922253927;8906.242969347613;8913.1086891311;8867.955660221722;8942.195202431747;8959.552022398919;8972.461652300883;8972.730818075468;41994;42057.369139462935;42262;42293.57706422927;42475.787621061696;3347.715444187247;3523.6476352364816;3933.98033009836;4103.261412945669;4255.255330317182;31442.37115257705;31725.682743172503;32114.357712845613;32571.837140814143;32888.835555822305;4311.55143128962;4333.501647310568;4336.154449882274;4531.8187272509385;4537.523560026216;347072;347893;348983.2550837255;349890;350153;55481.44518554844;55639.443605564236;55834;55889;55970.16044759332;57458.42541574614;57803;57818.421815782145;57886.7105664469;57941.710291448275;13149.737005259842;13798.103123296954;14052.789208161887;14375.496857610142;14402;11096.833547496793;11197.216194866282;11204.775904481865;11253.66239012831;11273.267237629529;16147.434839780552;16181.757273640906;16194;16230;16243;5156.510131537498;6528.151340325728;6543.345665433419;6633;6823.396501822068;1003.6888564545014;1037.7768779712399;1063.9308444951207;1116.609186784619;1175.7707247086908;30978.69021309758;31603.20991975173;31618.683813161573;32020;32267.495156407094;1070.5236169904474;1088.7931293054294;1099.0438318662814;1120.4341807387218;1170;16060.598485037734;16327.428540001043;16366.263518141712;16457.25942332598;16692.58268543296;527179.8256139576;532951.028672851;533343;533569;537445;53546.46453535493;54500.729956202755;54531.454685452634;54573.72713136409;54597.72701136548;1233.6792433967232;1335.8797708206114;1372.3755691160497;1375.3329635126956;1383.8408583013083;29673.554896676134;31045.68954310428;31851.20371990719;32035;32436;48241.517584823705;48279.517204827505;48627.270590940454;48798;48816;334405;334437;335596;337195;337383;24398.87800560986;26203;26956.73043269542;27117;28342.43315133727;44878.77560612176;45090.82547712165;45821.31268030916;46087.308690369;46517.53482465132;38834;38865.41701874418;39041;39784;40111.19777604373;37094.8145259272;37883.431748523246;38203.617963820005;38653.80673096729;38685.22629547337;38364.61635383611;38942.4158637615;38963.80518097391;39831.601683982786;39888;34155.65844341525;35015.64984350124;35536;35791.64208357883;35829.64170358263;26435.339116522242;26496.86751566307;26866.194014179608;27010;27044.32389190286 08:23:24 INFO - PROCESS | 19702 | |2;jquery.html;384.204696278703;388.52793855465603;393.11941251596426;396.3856023164095;409.02855717670514;17685.469435916926;18595.721064184047;20327;20351.287704930313;20353.592928141446;12705.491780328799;12720.300383478905;16591.585210369718;18668.53328666784;19146.521336966583;4985.177445721461;5156.664816786897;5165.302684137631;5178.6892786432745;5196.506331898464;3804.391297392418;5660.801871934483;5871;5945.88108237835;6023.6385816851125;5574.275344205248;5922.674252916088;5972.910406343908;5975.193348897908;6025.668588227646;4113.321301985169;5831.533477321826;5956.106584012389;5968.104784282349;5972.0444728843395;5495.175723641446;5820.3888591698105;5826.359100498984;5830.970845145789;5836.795712150054;21654.24210152637;21780.564388712297;22271.220507282167;22391.440213994618;22467.775322246733;2191.835612329082;2341.2976107167783;2435.610302351633;2479.2810085075307;2904.419116176752;10733.248672592921;10834.241603087787;10903.618373356974;13700.45198192071;14946;1843.732658764485;1894.355918987537;1897.3359324236544;1911.6176764646987;1947.1724517080327;72891;76385;76818.61590692066;83410.16589834084;84293.15706842976;9103.408278461879;9377.95311023454;9762.90237097634;10061.79876402468;11110.166737494721;12862.935685321514;13333.533326333532;13371;13446.46214151423;13456.596302110953;7231.698294307075;7301.452391070691;7331.839117263058;7402.481826272109;7438.442116841258;6808.319168083152;7013.824654383681;7181.35367816899;7228.494005419675;7325.560466371928;4053.6015074799147;4152.294110001307;4206.978965105216;4233;4252.978735106367;1719.4785555260112;1872.3072463188707;2078.4284321811624;2082.115101082034;2106.599746048246;878.8813510176172;947.8293907096651;959.9728290728854;991.0832479956011;998.3410948773775;18292.817071829377;18866.811331886507;19735.605287894163;19918.103685334194;20049;984.8128855517429;988.5897352598591;1009.7071849163807;1023.5854478936043;1036.7719101797593;10521.947390263;10991.450427478754;11048.613298534512;11073.224874258725;11122.777544449065;477093;477672;483973;484845;490097;86493;89546.55226723955;89733;89843;89947.55026224827;943.42451104826;987.6395115782831;988.960441582343;989.9653512126897;1002.754325190333;17006.234719437904;17257.913710431367;17312.933134711697;17517;17596.208170632097;40902.81068409156;40960;41311;42300.78849605732;42628;56101.719491402284;57346.85306293934;57635.13547296878;57911.420885792286;58720.412795871496;8822;8989.775255618662;9054.683086091954;9057.592408341772;9217.953910230406;10005.599776008878;13369.66575835612;13520.12119212248;13721.931390343383;13954.37205325783;11287.492062857027;11562.595309164139;11855.525778968744;11985.580504682643;12303.077269205025;11612.88387116118;11714.648560543197;11927.46326415296;11944.820827687417;11958.222715523463;11100.111991040536;11101.5559377624;11977.64067077989;12198.14612977083;12293.323867187391;8833.116688331116;8865.51239681798;8870.2460290876;8879.378443509151;9148.862767058366;10277.897221027693;11151.498182581641;11221;11224.775504490028;11394.145439092266 08:23:24 INFO - PROCESS | 19702 | |3;mootools.html;1141.292398712798;1418.0924208506553;1481.9777703334453;1573.9134347610877;1774.112943528236;8287.875681864776;8711.869321960168;8722.302215822727;8941.687040953568;8957;8703.608337624806;8905.465672059665;8921;8924.107589241088;8924.643014279422;2178.575177840318;2206.58074965756;2213.634750266212;2213.734351877777;2214.3910424633273;2300.5168914527967;2329.080013394708;2333.0434521846046;2338.368640467073;2340.5903966805827;2300.4478925058033;2315.8378913476063;2319.895604697793;2320.4894923116885;2325.6395258734924;2245.6743772152945;2268.534950335177;2269;2273.5225602623386;2274.3859158027403;2262.264763951706;2270.0238897274166;2270.2167752125492;2271.716035495563;2274.8862556872255;8732.257758090569;8963.641454341818;8969.282457403457;9029.909700902972;9031.683891063782;5034.773435195425;5129.204973229155;5137.357830271216;5148.2535032420465;5149.124648809711;3131.6085489313837;3157.589513363248;3177.380410819891;3189.4418476766473;3224.1133688235923;1052.9420881851495;1057.7567159553269;1067.7864427114607;1074.570171931226;1078.7626722121122;12364.752704945851;12558.372081395893;12564.81152782709;12595.685107872376;12597.055220858472;4373.2565463871215;4379.5401482843845;4383.517813040563;4409.140217657526;4449.7997590108525;9832.262580306506;9851.507424628884;9854.16239619626;9855.802883942424;9858.80282394348;5006.224035274538;5014.272930425141;5022.020705962375;5022.070916880389;5022.824201152942;4141.585841415895;4302.698811083194;4668.253079507331;4699.083678682624;4733.36099626546;3822.9235415291537;3863.768173909574;3881;3906.6679332257077;3961.3463778476803;1115.4255558387438;1132.2187690493533;1133.7732453509332;1138.0554140063894;1141.9257748246337;780.1262585903823;811.8254575266346;894.2890402130322;895.6641259527677;937.8499440089553;5872.471477567039;5907.084401917709;6064.666443345658;6100.633961962297;6173.166622505994;454.372965307873;454.91793101735345;458.58956234170233;468.047523290103;473.16250237080175;4129.834806607762;4310.784460777011;4325.978370108192;4339.218940590661;4370.21336159488;10524.105451036748;11073.335599864035;11126.554937802397;11140.61007864737;11163.83254251187;10968.725781855357;10999.780004400027;11011.889881101086;11025.117990560735;11034.613788517363;7877.684892604231;8183.508989460652;8185.836283274421;8371.204735550113;8442.07137214906;6077.4226448487325;6109.297430795337;6241.251049874044;6249.187605611241;6339.651319177489;10085.092341689284;10270.383776973405;10318.48407579633;10362.792744144925;10367.63713270032;10264;10447.791044179226;10626.946865265625;10649.307794993301;10678;7001.579905205704;7768.495047821873;7964.123946365779;8032.718854840053;8281.420300579142;8548.74353769388;8809.735707928772;8814.779630509289;8853.645854165761;8855.822883542165;7753.147153812964;7818.452708310364;7882.566458844819;8015.559144247122;8133.552654603817;7646.617669116633;7744.007020063048;7758.573278469513;7908.960455197687;8003.599820009093;6919.411849992807;7097.077379940574;7202.855942881218;7284.271572842674;7286.890696639449;5002.399712034434;5229.346331708536;5344.732763361739;5440.42875498067;5490.780368785204;5298.973505132604;5301.840944771663;5387;5447.291852059366;5465.480779325958 08:23:24 INFO - PROCESS | 19702 | |4;prototype.html;320.0813664782075;320.8796701237036;327.74435939966827;332.0569582386023;333.07903646417645;5352.5182733553975;5374.5700343972485;5382.38102618199;5384.892302153955;5393.460653934604;5245.79016839327;5251.632385733;5262.552683021948;5322.547583455401;5371.75827087781;3919.176972835708;4003.15933653933;4139.875803725893;4168.353905144692;4182.6235638792505;4095.242380159665;4136.627703506684;4141.8964525886795;4159.9376009359885;4179.599834055595;3949.2299001694537;4050.8784736457806;4090.9386359204486;4093.713440059197;4125.319322311815;4033.69747268956;4114.382842573608;4152.750834949913;4189.916201675949;4214.599613036757;3723.2181241938956;3735.2156047230114;3735.234276973214;3739.0183202902504;3757.398816189424;5149.562287205592;5167.966406718671;5173.611979101544;5180.715060671661;5211.530962213419;4504.234280172379;4752.287156926454;4766.142094423002;4770.570648641604;4799.760011999421;5509.815389691195;5520.447955204448;5530.944690553083;5531.363893152299;5580.86047848803;4093.570175131628;4093.9385909211387;4101.569335219789;4101.789971958279;4103.794810259505;5565.443455654443;5745.827625171251;5757.82726518201;5776;5800.448957349003;4035.6973227008093;4056.776877271778;4064.6748260139116;4077.85727499542;4088;4105.486814148231;4107.199096176217;4115.156392939441;4131.586841315844;4157.898156988401;4540.387047748578;4689.812407503661;4728.787204575802;4750.596199323097;4771.141194585008;5534.723263836872;5538.307711536058;5539.169124631338;5547.2511210986;5555.30558680165;1444.2129039673403;1456.8178977627797;1471.5879553724974;1471.9558413247619;1473.7420951333474;942.5193151492651;953.498240271575;968.7093871838421;969.2246203037541;972.6060945317158;5273.419923808378;5290.735463226823;5291.153415453509;5292.417834038252;5341.893162136813;5673.574481913873;5687.914681279784;5688.146777983336;5708.7155390036905;5713.485786279255;5210.47895210476;5331.920021199685;5343.679379237258;5347.385050719217;5399.83800485986;2938.6620538637903;2970.3465237647683;2979.582858399826;2980.7182911348327;2995.2961054152256;5393.298871146726;5734.849431463202;5746.735718142002;5768.913466298009;5803.477687008105;5702.857428564319;5724.484796368347;5733.0540460823495;5736.770529178786;5757.65454072757;5687.729555505518;5741.88516229673;5743.62666426681;5781.624194427349;5797.333306669787;5309.33633295838;5521.254630624814;5541;5616.5787565931905;5619.550435965195;5367.731613419235;5448.237246785374;5529.557635389239;5529.778808847601;5562.582806289463;5698.857528561819;5728.627639203439;5740.483356497935;5781.913271301018;5819.476247137778;3869.6130386961077;3954.762714237155;3958.6738442620895;3986.60133986599;3992.6606238468894;5441.564674826083;5510.201020852034;5512.834614961557;5516.503514683698;5520.834374968757;5482.040642887399;5524.281843360337;5529.64057336288;5540.861478463071;5547.140193269888;5497.285352904097;5532.640378375393;5555.611107222618;5556.972215138899;5558.583106267127;5176.637635365489;5335.306410166653;5358.46415358461;5417.729113544228;5423.945760542344;5489.149181876815;5498.422665620213;5542.695151766691;5557.166425036277;5564.304461942257;5297.841064767909;5435.39101231419;5443.183522471661;5459.12653975362;5459.508644222039 08:23:24 INFO - PROCESS | 19702 | |5;yui.html;722.649514985232;780.7618676303729;802.7511471443853;807.5477732469814;817.9959100204499;14598.124112553254;15766;15783.605409864746;15801.288941997609;15807.683846323096;14324.212168330738;14698.853011469882;15104;15120.621984450394;15153.242337883117;789.668339297495;798.6246464161864;804.9154838741936;806.5281810141074;806.6612022950375;657.950653700972;773.6595897804976;800.8238187598719;802.8594995875699;805.3999770171231;824.6454024769376;826.0252901576138;826.8511667899776;827.3339961331126;827.3670641958906;680.1735890892589;823.9505629662209;824.0934971531327;824.8061705499202;825.1088824070019;584.1792281844016;607.5686262753451;609.856683679335;609.9664518451483;610.7862248213135;13509;13569.118007329493;13601.795973060413;13622.046456748032;13648.385822638005;13837.723245535033;14256.247757981619;14327.212003339811;14501.927490362586;14859.182744949023;12421.31682757457;12751;12847.614571562868;12988.805167922394;13067.150635208682;4288.935665965013;4339.934900976488;4376.496702879178;4396.89007774805;4582.564656357641;77036.61481692611;77777.61111194464;78037.21962780414;78142.6092869532;79143;10774.78450430987;10907.83638245427;10962;11043.337399756041;11113;19790;20992.956021376816;21059.262925797524;21065;21132.47168820761;8314.210150035737;8339.082700902896;8418.200270974248;8604.182602652738;8686.348523860735;4574.908501829945;4594.1730488512385;4694.084653492536;4717.245240761462;4882.902341953141;3506.4564992426212;3596.3886139356373;3622.9275414491563;3633.400488919299;3645.2527231917393;600.906859436788;619.6282230661657;628.669948277149;628.8365025093509;632.4023797511308;555.9082751346064;586.2408181405091;623.9223386124196;663.571996062537;668.2715839734713;8913.28693704502;9102.226310763526;9178.036306187754;9304.8604270936;9985.20118390527;529.7907326606046;561.7640590951728;677.204284965164;705.3722187253348;710.8009757267973;4273.337632666941;4426.380306757057;4527.592516673515;4595.954040459553;4620.981025413838;94396.52801736085;97704;98873;106180.46909765402;111710.44144779387;94727.52636236913;95154;95623;95709;96660;55111.44888551063;60740.69629651823;64240.678796606655;71195;75435.62282188554;9565.330426870052;10030.899691002996;10095.899041009496;10183.083522482715;10348.793024139626;51556.87544996316;51887.481125188264;51947.220791687396;52663;54795;71435.64282178556;75665;75846;76476.61761691156;76679;12878.549250776177;13077.41151648159;13124.540641077516;13383.933080334926;13635.795463067863;14984.700305994038;15048.849511504744;15178.089314641156;15275.770863436835;15307.46423875159;14019.50931717385;14232.359543820347;14490.85509144895;14572.05281656689;15095.39618415251;13910.860891390956;13983.580492585239;14131.788023179866;14454;14612.634684132556;12338.753224935272;13068.215907045607;13466.730665386442;13622.38699258516;14068.648283792987;10605.89394106049;10716.410597417216;10732.839007415052;11203.551857925917;11489;10718.35689858611;11166.609168679057;11503.367314797766;11890.405479725807;12051.457684404048 08:23:24 INFO - PROCESS | 19702 | __end_tp_report 08:23:24 INFO - PROCESS | 19702 | __start_cc_report 08:23:24 INFO - PROCESS | 19702 | _x_x_mozilla_cycle_collect,813 08:23:24 INFO - PROCESS | 19702 | __end_cc_report 08:23:24 INFO - PROCESS | 19702 | __startTimestamp1466781804885__endTimestamp 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | ------- Summary: start ------- 08:23:24 INFO - PROCESS | 19702 | Number of tests: 6 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#0] dojo.html Cycles:165 Average:5293.09 Median:5475.62 stddev:594.34 (10.9%) stddev-sans-first:570.07 08:23:24 INFO - PROCESS | 19702 | Values: 3073.2 3079.3 3098.6 3106.9 3144.7 5147.4 5246.9 5299.4 5379.0 5422.6 5326.3 5333.4 5339.7 5347.5 5384.2 4810.2 4857.2 4893.7 4907.5 5042.8 4936.3 4944.3 4974.9 4991.9 5006.4 4750.6 4772.2 4797.0 4821.4 4858.5 4775.5 4781.8 4786.7 4789.5 4899.2 4788.3 4812.9 4834.3 4839.5 4875.5 5187.7 5231.9 5263.9 5290.1 5339.7 5659.8 5691.3 5694.4 5695.0 5717.2 5758.0 5769.5 5771.0 5777.1 5777.5 5217.2 5315.2 5381.2 5383.2 5430.2 5948.3 5956.7 5957.2 5957.3 5957.9 5394.7 5707.3 5711.6 5712.4 5715.7 5586.5 5639.5 5642.7 5687.0 5687.1 5648.0 5649.5 5655.4 5655.5 5668.2 5438.2 5621.4 5677.3 5677.8 5683.8 4357.0 4367.7 4391.3 4432.6 4433.6 3902.7 3925.3 3933.6 3935.6 3960.7 5235.8 5238.1 5288.3 5432.2 5475.6 5604.3 5640.2 5667.0 5669.8 5707.1 5338.4 5351.4 5353.2 5354.7 5361.5 4799.2 4886.2 4910.3 4915.7 4948.3 5936.4 5937.9 5940.2 5950.1 5977.4 5750.3 5765.9 5766.3 5769.9 5771.6 5649.6 5756.7 5773.2 5809.9 5908.8 5576.5 5593.0 5597.4 5598.9 5603.0 5652.3 5689.4 5696.9 5702.0 5702.6 5383.7 5529.6 5559.4 5593.3 5618.9 5607.9 5613.4 5614.7 5616.4 5623.5 5291.7 5420.5 5455.1 5468.3 5515.3 5537.1 5581.2 5583.9 5646.0 5664.2 5473.6 5485.1 5495.0 5496.2 5527.6 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#1] ext.html Cycles:180 Average:56346.43 Median:39807.80 stddev:110226.23 (276.9%) stddev-sans-first:110455.99 08:23:24 INFO - PROCESS | 19702 | Values: 607.0 610.0 612.5 615.6 628.6 30218.0 40715.4 42048.4 42123.8 45799.8 44488.1 44838.1 44926.6 44964.8 44976.0 8871.2 9003.6 9020.3 9024.1 9027.5 8793.6 8831.1 8854.2 8863.4 8946.2 8901.0 8937.2 8978.5 8981.1 8985.1 8799.0 8853.7 8901.6 8906.2 8913.1 8868.0 8942.2 8959.6 8972.5 8972.7 41994.0 42057.4 42262.0 42293.6 42475.8 3347.7 3523.6 3934.0 4103.3 4255.3 31442.4 31725.7 32114.4 32571.8 32888.8 4311.6 4333.5 4336.2 4531.8 4537.5 347072.0 347893.0 348983.3 349890.0 350153.0 55481.4 55639.4 55834.0 55889.0 55970.2 57458.4 57803.0 57818.4 57886.7 57941.7 13149.7 13798.1 14052.8 14375.5 14402.0 11096.8 11197.2 11204.8 11253.7 11273.3 16147.4 16181.8 16194.0 16230.0 16243.0 5156.5 6528.2 6543.3 6633.0 6823.4 1003.7 1037.8 1063.9 1116.6 1175.8 30978.7 31603.2 31618.7 32020.0 32267.5 1070.5 1088.8 1099.0 1120.4 1170.0 16060.6 16327.4 16366.3 16457.3 16692.6 527179.8 532951.0 533343.0 533569.0 537445.0 53546.5 54500.7 54531.5 54573.7 54597.7 1233.7 1335.9 1372.4 1375.3 1383.8 29673.6 31045.7 31851.2 32035.0 32436.0 48241.5 48279.5 48627.3 48798.0 48816.0 334405.0 334437.0 335596.0 337195.0 337383.0 24398.9 26203.0 26956.7 27117.0 28342.4 44878.8 45090.8 45821.3 46087.3 46517.5 38834.0 38865.4 39041.0 39784.0 40111.2 37094.8 37883.4 38203.6 38653.8 38685.2 38364.6 38942.4 38963.8 39831.6 39888.0 34155.7 35015.6 35536.0 35791.6 35829.6 26435.3 26496.9 26866.2 27010.0 27044.3 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#2] jquery.html Cycles:180 Average:28438.72 Median:2224.99 stddev:79571.57 (3576.3%) stddev-sans-first:79766.91 08:23:24 INFO - PROCESS | 19702 | Values: 384.2 388.5 393.1 396.4 409.0 17685.5 18595.7 20327.0 20351.3 20353.6 12705.5 12720.3 16591.6 18668.5 19146.5 4985.2 5156.7 5165.3 5178.7 5196.5 3804.4 5660.8 5871.0 5945.9 6023.6 5574.3 5922.7 5972.9 5975.2 6025.7 4113.3 5831.5 5956.1 5968.1 5972.0 5495.2 5820.4 5826.4 5831.0 5836.8 21654.2 21780.6 22271.2 22391.4 22467.8 2191.8 2341.3 2435.6 2479.3 2904.4 10733.2 10834.2 10903.6 13700.5 14946.0 1843.7 1894.4 1897.3 1911.6 1947.2 72891.0 76385.0 76818.6 83410.2 84293.2 9103.4 9378.0 9762.9 10061.8 11110.2 12862.9 13333.5 13371.0 13446.5 13456.6 7231.7 7301.5 7331.8 7402.5 7438.4 6808.3 7013.8 7181.4 7228.5 7325.6 4053.6 4152.3 4207.0 4233.0 4253.0 1719.5 1872.3 2078.4 2082.1 2106.6 878.9 947.8 960.0 991.1 998.3 18292.8 18866.8 19735.6 19918.1 20049.0 984.8 988.6 1009.7 1023.6 1036.8 10521.9 10991.5 11048.6 11073.2 11122.8 477093.0 477672.0 483973.0 484845.0 490097.0 86493.0 89546.6 89733.0 89843.0 89947.6 943.4 987.6 989.0 990.0 1002.8 17006.2 17257.9 17312.9 17517.0 17596.2 40902.8 40960.0 41311.0 42300.8 42628.0 56101.7 57346.9 57635.1 57911.4 58720.4 8822.0 8989.8 9054.7 9057.6 9218.0 10005.6 13369.7 13520.1 13721.9 13954.4 11287.5 11562.6 11855.5 11985.6 12303.1 11612.9 11714.6 11927.5 11944.8 11958.2 11100.1 11101.6 11977.6 12198.1 12293.3 8833.1 8865.5 8870.2 8879.4 9148.9 10277.9 11151.5 11221.0 11224.8 11394.1 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#3] mootools.html Cycles:180 Average:5809.72 Median:2568.15 stddev:3392.78 (132.1%) stddev-sans-first:3384.16 08:23:24 INFO - PROCESS | 19702 | Values: 1141.3 1418.1 1482.0 1573.9 1774.1 8287.9 8711.9 8722.3 8941.7 8957.0 8703.6 8905.5 8921.0 8924.1 8924.6 2178.6 2206.6 2213.6 2213.7 2214.4 2300.5 2329.1 2333.0 2338.4 2340.6 2300.4 2315.8 2319.9 2320.5 2325.6 2245.7 2268.5 2269.0 2273.5 2274.4 2262.3 2270.0 2270.2 2271.7 2274.9 8732.3 8963.6 8969.3 9029.9 9031.7 5034.8 5129.2 5137.4 5148.3 5149.1 3131.6 3157.6 3177.4 3189.4 3224.1 1052.9 1057.8 1067.8 1074.6 1078.8 12364.8 12558.4 12564.8 12595.7 12597.1 4373.3 4379.5 4383.5 4409.1 4449.8 9832.3 9851.5 9854.2 9855.8 9858.8 5006.2 5014.3 5022.0 5022.1 5022.8 4141.6 4302.7 4668.3 4699.1 4733.4 3822.9 3863.8 3881.0 3906.7 3961.3 1115.4 1132.2 1133.8 1138.1 1141.9 780.1 811.8 894.3 895.7 937.8 5872.5 5907.1 6064.7 6100.6 6173.2 454.4 454.9 458.6 468.0 473.2 4129.8 4310.8 4326.0 4339.2 4370.2 10524.1 11073.3 11126.6 11140.6 11163.8 10968.7 10999.8 11011.9 11025.1 11034.6 7877.7 8183.5 8185.8 8371.2 8442.1 6077.4 6109.3 6241.3 6249.2 6339.7 10085.1 10270.4 10318.5 10362.8 10367.6 10264.0 10447.8 10626.9 10649.3 10678.0 7001.6 7768.5 7964.1 8032.7 8281.4 8548.7 8809.7 8814.8 8853.6 8855.8 7753.1 7818.5 7882.6 8015.6 8133.6 7646.6 7744.0 7758.6 7909.0 8003.6 6919.4 7097.1 7202.9 7284.3 7286.9 5002.4 5229.3 5344.7 5440.4 5490.8 5299.0 5301.8 5387.0 5447.3 5465.5 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#4] prototype.html Cycles:180 Average:4647.42 Median:5345.53 stddev:1347.52 (25.2%) stddev-sans-first:1311.58 08:23:24 INFO - PROCESS | 19702 | Values: 320.1 320.9 327.7 332.1 333.1 5352.5 5374.6 5382.4 5384.9 5393.5 5245.8 5251.6 5262.6 5322.5 5371.8 3919.2 4003.2 4139.9 4168.4 4182.6 4095.2 4136.6 4141.9 4159.9 4179.6 3949.2 4050.9 4090.9 4093.7 4125.3 4033.7 4114.4 4152.8 4189.9 4214.6 3723.2 3735.2 3735.2 3739.0 3757.4 5149.6 5168.0 5173.6 5180.7 5211.5 4504.2 4752.3 4766.1 4770.6 4799.8 5509.8 5520.4 5530.9 5531.4 5580.9 4093.6 4093.9 4101.6 4101.8 4103.8 5565.4 5745.8 5757.8 5776.0 5800.4 4035.7 4056.8 4064.7 4077.9 4088.0 4105.5 4107.2 4115.2 4131.6 4157.9 4540.4 4689.8 4728.8 4750.6 4771.1 5534.7 5538.3 5539.2 5547.3 5555.3 1444.2 1456.8 1471.6 1472.0 1473.7 942.5 953.5 968.7 969.2 972.6 5273.4 5290.7 5291.2 5292.4 5341.9 5673.6 5687.9 5688.1 5708.7 5713.5 5210.5 5331.9 5343.7 5347.4 5399.8 2938.7 2970.3 2979.6 2980.7 2995.3 5393.3 5734.8 5746.7 5768.9 5803.5 5702.9 5724.5 5733.1 5736.8 5757.7 5687.7 5741.9 5743.6 5781.6 5797.3 5309.3 5521.3 5541.0 5616.6 5619.6 5367.7 5448.2 5529.6 5529.8 5562.6 5698.9 5728.6 5740.5 5781.9 5819.5 3869.6 3954.8 3958.7 3986.6 3992.7 5441.6 5510.2 5512.8 5516.5 5520.8 5482.0 5524.3 5529.6 5540.9 5547.1 5497.3 5532.6 5555.6 5557.0 5558.6 5176.6 5335.3 5358.5 5417.7 5423.9 5489.1 5498.4 5542.7 5557.2 5564.3 5297.8 5435.4 5443.2 5459.1 5459.5 08:23:24 INFO - PROCESS | 19702 | 08:23:24 INFO - PROCESS | 19702 | [#5] yui.html Cycles:180 Average:19881.50 Median:4595.06 stddev:27613.25 (600.9%) stddev-sans-first:27653.23 08:23:24 INFO - PROCESS | 19702 | Values: 722.6 780.8 802.8 807.5 818.0 14598.1 15766.0 15783.6 15801.3 15807.7 14324.2 14698.9 15104.0 15120.6 15153.2 789.7 798.6 804.9 806.5 806.7 658.0 773.7 800.8 802.9 805.4 824.6 826.0 826.9 827.3 827.4 680.2 824.0 824.1 824.8 825.1 584.2 607.6 609.9 610.0 610.8 13509.0 13569.1 13601.8 13622.0 13648.4 13837.7 14256.2 14327.2 14501.9 14859.2 12421.3 12751.0 12847.6 12988.8 13067.2 4288.9 4339.9 4376.5 4396.9 4582.6 77036.6 77777.6 78037.2 78142.6 79143.0 10774.8 10907.8 10962.0 11043.3 11113.0 19790.0 20993.0 21059.3 21065.0 21132.5 8314.2 8339.1 8418.2 8604.2 8686.3 4574.9 4594.2 4694.1 4717.2 4882.9 3506.5 3596.4 3622.9 3633.4 3645.3 600.9 619.6 628.7 628.8 632.4 555.9 586.2 623.9 663.6 668.3 8913.3 9102.2 9178.0 9304.9 9985.2 529.8 561.8 677.2 705.4 710.8 4273.3 4426.4 4527.6 4596.0 4621.0 94396.5 97704.0 98873.0 106180.5 111710.4 94727.5 95154.0 95623.0 95709.0 96660.0 55111.4 60740.7 64240.7 71195.0 75435.6 9565.3 10030.9 10095.9 10183.1 10348.8 51556.9 51887.5 51947.2 52663.0 54795.0 71435.6 75665.0 75846.0 76476.6 76679.0 12878.5 13077.4 13124.5 13383.9 13635.8 14984.7 15048.8 15178.1 15275.8 15307.5 14019.5 14232.4 14490.9 14572.1 15095.4 13910.9 13983.6 14131.8 14454.0 14612.6 12338.8 13068.2 13466.7 13622.4 14068.6 10605.9 10716.4 10732.8 11203.6 11489.0 10718.4 11166.6 11503.4 11890.4 12051.5 08:23:24 INFO - PROCESS | 19702 | -------- Summary: end -------- 08:23:24 INFO - PROCESS | 19702 | 08:23:25 INFO - TEST-INFO | 19702: exit 0 08:23:25 INFO - TEST-OK | dromaeo_css | took 1114754ms 08:23:25 INFO - TEST-START | kraken 08:23:25 INFO - operating with platform_type : linux_ 08:23:25 INFO - Initialising browser for kraken test... 08:23:25 INFO - TEST-INFO | started process 19887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD8ABi/profile http://localhost:35750/getInfo.html) 08:23:29 INFO - PROCESS | 19887 | __metrics Screen width/height:1600/1200 08:23:29 INFO - PROCESS | 19887 | colorDepth:24 08:23:29 INFO - PROCESS | 19887 | Browser inner width/height: 1024/697 08:23:29 INFO - PROCESS | 19887 | __metrics 08:23:30 INFO - PROCESS | 19887 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:31 INFO - TEST-INFO | 19887: exit 0 08:23:31 INFO - Browser initialized. 08:23:31 INFO - Running cycle 1/1 for kraken test... 08:23:31 INFO - TEST-INFO | started process 19969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHD8ABi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:43 INFO - PROCESS | 19969 | RSS: Main: 174559232 08:23:43 INFO - PROCESS | 19969 | 08:23:46 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35750/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:47 INFO - PROCESS | 19969 | RSS: Main: 232230912 08:23:47 INFO - PROCESS | 19969 | 08:23:50 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35750/tests/kraken/driver.html?testName=audio-dft) 08:23:50 INFO - PROCESS | 19969 | RSS: Main: 222318592 08:23:50 INFO - PROCESS | 19969 | 08:23:53 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35750/tests/kraken/driver.html?testName=audio-fft) 08:23:54 INFO - PROCESS | 19969 | RSS: Main: 286482432 08:23:54 INFO - PROCESS | 19969 | 08:23:56 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35750/tests/kraken/driver.html?testName=audio-oscillator) 08:23:57 INFO - PROCESS | 19969 | RSS: Main: 196235264 08:23:57 INFO - PROCESS | 19969 | 08:23:59 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35750/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:59 INFO - PROCESS | 19969 | RSS: Main: 201150464 08:23:59 INFO - PROCESS | 19969 | 08:24:02 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35750/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:03 INFO - PROCESS | 19969 | RSS: Main: 237064192 08:24:03 INFO - PROCESS | 19969 | 08:24:06 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35750/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:07 INFO - PROCESS | 19969 | RSS: Main: 238153728 08:24:07 INFO - PROCESS | 19969 | 08:24:10 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35750/tests/kraken/driver.html?testName=json-parse-financial) 08:24:10 INFO - PROCESS | 19969 | RSS: Main: 237637632 08:24:10 INFO - PROCESS | 19969 | 08:24:12 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35750/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:13 INFO - PROCESS | 19969 | RSS: Main: 226181120 08:24:13 INFO - PROCESS | 19969 | 08:24:14 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:15 INFO - PROCESS | 19969 | RSS: Main: 230727680 08:24:15 INFO - PROCESS | 19969 | 08:24:17 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:18 INFO - PROCESS | 19969 | RSS: Main: 236077056 08:24:18 INFO - PROCESS | 19969 | 08:24:20 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:21 INFO - PROCESS | 19969 | RSS: Main: 238727168 08:24:21 INFO - PROCESS | 19969 | 08:24:23 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:24 INFO - PROCESS | 19969 | RSS: Main: 240701440 08:24:24 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | Cycle 1(1): loaded http://localhost:35750/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35750/tests/kraken/driver.html?testName=ai-astar) 08:24:26 INFO - PROCESS | 19969 | RSS: Main: 282869760 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | __start_tp_report 08:24:26 INFO - PROCESS | 19969 | _x_x_mozilla_page_load 08:24:26 INFO - PROCESS | 19969 | _x_x_mozilla_page_load_details 08:24:26 INFO - PROCESS | 19969 | |i|pagename|runs| 08:24:26 INFO - PROCESS | 19969 | |0;ai-astar;100;115;110;111;113;110;111;112;111;110 08:24:26 INFO - PROCESS | 19969 | |1;audio-beat-detection;156;125;127;177;126;127;158;132;178;126 08:24:26 INFO - PROCESS | 19969 | |2;audio-dft;162;161;161;161;161;162;162;162;159;161 08:24:26 INFO - PROCESS | 19969 | |3;audio-fft;77;74;76;141;76;76;75;74;109;76 08:24:26 INFO - PROCESS | 19969 | |4;audio-oscillator;84;84;109;85;86;84;125;85;88;121 08:24:26 INFO - PROCESS | 19969 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 08:24:26 INFO - PROCESS | 19969 | |6;imaging-darkroom;147;146;147;146;145;146;147;146;146;145 08:24:26 INFO - PROCESS | 19969 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;95 08:24:26 INFO - PROCESS | 19969 | |8;json-parse-financial;55;52;52;53;58;52;53;53;53;53 08:24:26 INFO - PROCESS | 19969 | |9;json-stringify-tinderbox;62;61;62;61;61;62;62;62;62;68 08:24:26 INFO - PROCESS | 19969 | |10;stanford-crypto-aes;80;81;86;78;78;81;80;82;98;79 08:24:26 INFO - PROCESS | 19969 | |11;stanford-crypto-ccm;122;130;128;121;129;118;128;119;127;132 08:24:26 INFO - PROCESS | 19969 | |12;stanford-crypto-pbkdf2;161;164;161;162;163;163;163;162;162;162 08:24:26 INFO - PROCESS | 19969 | |13;stanford-crypto-sha256-iterative;63;72;70;63;63;68;64;64;62;72 08:24:26 INFO - PROCESS | 19969 | __end_tp_report 08:24:26 INFO - PROCESS | 19969 | __start_cc_report 08:24:26 INFO - PROCESS | 19969 | _x_x_mozilla_cycle_collect,1631 08:24:26 INFO - PROCESS | 19969 | __end_cc_report 08:24:26 INFO - PROCESS | 19969 | __startTimestamp1466781866490__endTimestamp 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | ------- Summary: start ------- 08:24:26 INFO - PROCESS | 19969 | Number of tests: 14 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.95 (3.6%) stddev-sans-first:1.67 08:24:26 INFO - PROCESS | 19969 | Values: 100.0 115.0 110.0 111.0 113.0 110.0 111.0 112.0 111.0 110.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:144.00 stddev:21.88 (15.2%) stddev-sans-first:22.71 08:24:26 INFO - PROCESS | 19969 | Values: 156.0 125.0 127.0 177.0 126.0 127.0 158.0 132.0 178.0 126.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:24:26 INFO - PROCESS | 19969 | Values: 162.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 159.0 161.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#3] audio-fft Cycles:10 Average:85.40 Median:76.00 stddev:22.21 (29.2%) stddev-sans-first:23.35 08:24:26 INFO - PROCESS | 19969 | Values: 77.0 74.0 76.0 141.0 76.0 76.0 75.0 74.0 109.0 76.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.50 stddev:16.55 (19.6%) stddev-sans-first:17.06 08:24:26 INFO - PROCESS | 19969 | Values: 84.0 84.0 109.0 85.0 86.0 84.0 125.0 85.0 88.0 121.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:24:26 INFO - PROCESS | 19969 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 08:24:26 INFO - PROCESS | 19969 | Values: 147.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 145.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:24:26 INFO - PROCESS | 19969 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.84 (3.5%) stddev-sans-first:1.86 08:24:26 INFO - PROCESS | 19969 | Values: 55.0 52.0 52.0 53.0 58.0 52.0 53.0 53.0 53.0 53.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:2.06 (3.3%) stddev-sans-first:2.18 08:24:26 INFO - PROCESS | 19969 | Values: 62.0 61.0 62.0 61.0 61.0 62.0 62.0 62.0 62.0 68.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:5.98 (7.4%) stddev-sans-first:6.29 08:24:26 INFO - PROCESS | 19969 | Values: 80.0 81.0 86.0 78.0 78.0 81.0 80.0 82.0 98.0 79.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:128.00 stddev:4.95 (3.9%) stddev-sans-first:5.09 08:24:26 INFO - PROCESS | 19969 | Values: 122.0 130.0 128.0 121.0 129.0 118.0 128.0 119.0 127.0 132.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:0.88 08:24:26 INFO - PROCESS | 19969 | Values: 161.0 164.0 161.0 162.0 163.0 163.0 163.0 162.0 162.0 162.0 08:24:26 INFO - PROCESS | 19969 | 08:24:26 INFO - PROCESS | 19969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:3.98 (6.0%) stddev-sans-first:4.07 08:24:26 INFO - PROCESS | 19969 | Values: 63.0 72.0 70.0 63.0 63.0 68.0 64.0 64.0 62.0 72.0 08:24:26 INFO - PROCESS | 19969 | -------- Summary: end -------- 08:24:26 INFO - PROCESS | 19969 | 08:24:27 INFO - TEST-INFO | 19969: exit 0 08:24:27 INFO - TEST-OK | kraken | took 61932ms 08:24:27 INFO - SUITE-END | took 1176s 08:24:27 INFO - Completed test suite (00:19:36) 08:24:27 INFO - javascript benchmark 08:24:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.2163298358914, 3079.276370053037, 3098.5662007318992, 3106.8757249710006, 3144.7484201263887, 5147.433782283946, 5246.921296180561, 5299.364076310843, 5379.0, 5422.620416570841, 5326.254324394578, 5333.413324534308, 5339.652922560031, 5347.518723314901, 5384.165454354572, 4810.230363141898, 4857.247126695368, 4893.730844803535, 4907.509249075099, 5042.82350117746, 4936.259561065833, 4944.307796908436, 4974.900501989958, 4991.875203119915, 5006.374203224597, 4750.643701722367, 4772.236442169236, 4797.016611594632, 4821.445533763627, 4858.489858564871, 4775.5224477551965, 4781.784819683123, 4786.688865223749, 4789.544993225638, 4899.240617704261, 4788.257820037899, 4812.941152946346, 4834.250691142878, 4839.467658557556, 4875.512448755132, 5187.662801917863, 5231.869203269949, 5263.947360526384, 5290.074237008546, 5339.65292256006, 5659.773609055633, 5691.288588926384, 5694.402087780765, 5695.0, 5717.2281741965135, 5758.021136406821, 5769.509591684712, 5770.971145144289, 5777.133429985493, 5777.508911742507, 5217.243499692561, 5315.229291752674, 5381.165919282478, 5383.192521121863, 5430.185472179205, 5948.256467941507, 5956.702164891738, 5957.225560677084, 5957.255343082114, 5957.880842383128, 5394.703291318937, 5707.286589176353, 5711.628744131701, 5712.371639119693, 5715.714214289269, 5586.52514536269, 5639.520640745583, 5642.746076426571, 5686.9715651421475, 5687.118496633028, 5648.039833228361, 5649.519790817826, 5655.3779084300695, 5655.519280861173, 5668.178114173422, 5438.211459338374, 5621.4378562144275, 5677.3471050829685, 5677.772889084473, 5683.829485115453, 4357.0196705740955, 4367.737935723803, 4391.3193455014525, 4432.601065904019, 4433.645308375322, 3902.70729695274, 3925.293447179478, 3933.5869733678123, 3935.6064393560414, 3960.663343615767, 5235.764390602432, 5238.135707608279, 5288.286081379041, 5432.158015507603, 5475.616706830563, 5604.32748070226, 5640.182173584889, 5666.9716651416475, 5669.773209071674, 5707.086866101404, 5338.3593968724, 5351.384590772033, 5353.170258609922, 5354.732263386815, 5361.463853614685, 4799.18413869643, 4886.242632391985, 4910.312556242129, 4915.705057696549, 4948.307236986825, 5936.406359364116, 5937.940620593825, 5940.227770389822, 5950.137230101611, 5977.372375900555, 5750.281214848144, 5765.913511297418, 5766.250387449605, 5769.8557536061935, 5771.5671324649975, 5649.576281778801, 5756.71216439168, 5773.220615216892, 5809.883802324014, 5908.763649454146, 5576.498115169654, 5593.0, 5597.356304024926, 5598.916016259678, 5603.0, 5652.3217213934595, 5689.431056894277, 5696.886062278649, 5701.971490142689, 5702.572307076903, 5383.67697938125, 5529.557635389078, 5559.388467268516, 5593.300837395325, 5618.887622247614, 5607.943920560742, 5613.410591887956, 5614.6631202128, 5616.4383561645145, 5623.493885550321, 5291.735413229246, 5420.539254163283, 5455.099908515051, 5468.343798744176, 5515.338159420895, 5537.058700020925, 5581.246531718329, 5583.888322233452, 5646.0, 5664.150377443417, 5473.562115030708, 5485.149801780571, 5495.0, 5496.1755736639825, 5527.585431092603], "value": 5253.613714465754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.963582185069, 609.9878002439951, 612.5222326585259, 615.6460035479599, 628.5945565110505, 30218.0, 40715.38926916099, 42048.369274460834, 42123.78938105305, 45799.77100114503, 44488.11023779523, 44838.10323793522, 44926.550734492645, 44964.77517612407, 44976.0, 8871.24594409476, 9003.639854405816, 9020.278377729766, 9024.052474490183, 9027.548622568878, 8793.604287807031, 8831.11688831115, 8854.158854908806, 8863.379563430562, 8946.194842464178, 8900.976387715431, 8937.150970657776, 8978.461292322449, 8981.101889811032, 8985.101489851028, 8798.988116366603, 8853.73438796837, 8901.554922253927, 8906.242969347613, 8913.1086891311, 8867.955660221722, 8942.195202431747, 8959.552022398919, 8972.461652300883, 8972.730818075468, 41994.0, 42057.369139462935, 42262.0, 42293.57706422927, 42475.787621061696, 3347.715444187247, 3523.6476352364816, 3933.98033009836, 4103.261412945669, 4255.255330317182, 31442.37115257705, 31725.682743172503, 32114.357712845613, 32571.837140814143, 32888.835555822305, 4311.55143128962, 4333.501647310568, 4336.154449882274, 4531.8187272509385, 4537.523560026216, 347072.0, 347893.0, 348983.2550837255, 349890.0, 350153.0, 55481.44518554844, 55639.443605564236, 55834.0, 55889.0, 55970.16044759332, 57458.42541574614, 57803.0, 57818.421815782145, 57886.7105664469, 57941.710291448275, 13149.737005259842, 13798.103123296954, 14052.789208161887, 14375.496857610142, 14402.0, 11096.833547496793, 11197.216194866282, 11204.775904481865, 11253.66239012831, 11273.267237629529, 16147.434839780552, 16181.757273640906, 16194.0, 16230.0, 16243.0, 5156.510131537498, 6528.151340325728, 6543.345665433419, 6633.0, 6823.396501822068, 1003.6888564545014, 1037.7768779712399, 1063.9308444951207, 1116.609186784619, 1175.7707247086908, 30978.69021309758, 31603.20991975173, 31618.683813161573, 32020.0, 32267.495156407094, 1070.5236169904474, 1088.7931293054294, 1099.0438318662814, 1120.4341807387218, 1170.0, 16060.598485037734, 16327.428540001043, 16366.263518141712, 16457.25942332598, 16692.58268543296, 527179.8256139576, 532951.028672851, 533343.0, 533569.0, 537445.0, 53546.46453535493, 54500.729956202755, 54531.454685452634, 54573.72713136409, 54597.72701136548, 1233.6792433967232, 1335.8797708206114, 1372.3755691160497, 1375.3329635126956, 1383.8408583013083, 29673.554896676134, 31045.68954310428, 31851.20371990719, 32035.0, 32436.0, 48241.517584823705, 48279.517204827505, 48627.270590940454, 48798.0, 48816.0, 334405.0, 334437.0, 335596.0, 337195.0, 337383.0, 24398.87800560986, 26203.0, 26956.73043269542, 27117.0, 28342.43315133727, 44878.77560612176, 45090.82547712165, 45821.31268030916, 46087.308690369, 46517.53482465132, 38834.0, 38865.41701874418, 39041.0, 39784.0, 40111.19777604373, 37094.8145259272, 37883.431748523246, 38203.617963820005, 38653.80673096729, 38685.22629547337, 38364.61635383611, 38942.4158637615, 38963.80518097391, 39831.601683982786, 39888.0, 34155.65844341525, 35015.64984350124, 35536.0, 35791.64208357883, 35829.64170358263, 26435.339116522242, 26496.86751566307, 26866.194014179608, 27010.0, 27044.32389190286], "value": 19370.04343479315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.204696278703, 388.52793855465603, 393.11941251596426, 396.3856023164095, 409.02855717670514, 17685.469435916926, 18595.721064184047, 20327.0, 20351.287704930313, 20353.592928141446, 12705.491780328799, 12720.300383478905, 16591.585210369718, 18668.53328666784, 19146.521336966583, 4985.177445721461, 5156.664816786897, 5165.302684137631, 5178.6892786432745, 5196.506331898464, 3804.391297392418, 5660.801871934483, 5871.0, 5945.88108237835, 6023.6385816851125, 5574.275344205248, 5922.674252916088, 5972.910406343908, 5975.193348897908, 6025.668588227646, 4113.321301985169, 5831.533477321826, 5956.106584012389, 5968.104784282349, 5972.0444728843395, 5495.175723641446, 5820.3888591698105, 5826.359100498984, 5830.970845145789, 5836.795712150054, 21654.24210152637, 21780.564388712297, 22271.220507282167, 22391.440213994618, 22467.775322246733, 2191.835612329082, 2341.2976107167783, 2435.610302351633, 2479.2810085075307, 2904.419116176752, 10733.248672592921, 10834.241603087787, 10903.618373356974, 13700.45198192071, 14946.0, 1843.732658764485, 1894.355918987537, 1897.3359324236544, 1911.6176764646987, 1947.1724517080327, 72891.0, 76385.0, 76818.61590692066, 83410.16589834084, 84293.15706842976, 9103.408278461879, 9377.95311023454, 9762.90237097634, 10061.79876402468, 11110.166737494721, 12862.935685321514, 13333.533326333532, 13371.0, 13446.46214151423, 13456.596302110953, 7231.698294307075, 7301.452391070691, 7331.839117263058, 7402.481826272109, 7438.442116841258, 6808.319168083152, 7013.824654383681, 7181.35367816899, 7228.494005419675, 7325.560466371928, 4053.6015074799147, 4152.294110001307, 4206.978965105216, 4233.0, 4252.978735106367, 1719.4785555260112, 1872.3072463188707, 2078.4284321811624, 2082.115101082034, 2106.599746048246, 878.8813510176172, 947.8293907096651, 959.9728290728854, 991.0832479956011, 998.3410948773775, 18292.817071829377, 18866.811331886507, 19735.605287894163, 19918.103685334194, 20049.0, 984.8128855517429, 988.5897352598591, 1009.7071849163807, 1023.5854478936043, 1036.7719101797593, 10521.947390263, 10991.450427478754, 11048.613298534512, 11073.224874258725, 11122.777544449065, 477093.0, 477672.0, 483973.0, 484845.0, 490097.0, 86493.0, 89546.55226723955, 89733.0, 89843.0, 89947.55026224827, 943.42451104826, 987.6395115782831, 988.960441582343, 989.9653512126897, 1002.754325190333, 17006.234719437904, 17257.913710431367, 17312.933134711697, 17517.0, 17596.208170632097, 40902.81068409156, 40960.0, 41311.0, 42300.78849605732, 42628.0, 56101.719491402284, 57346.85306293934, 57635.13547296878, 57911.420885792286, 58720.412795871496, 8822.0, 8989.775255618662, 9054.683086091954, 9057.592408341772, 9217.953910230406, 10005.599776008878, 13369.66575835612, 13520.12119212248, 13721.931390343383, 13954.37205325783, 11287.492062857027, 11562.595309164139, 11855.525778968744, 11985.580504682643, 12303.077269205025, 11612.88387116118, 11714.648560543197, 11927.46326415296, 11944.820827687417, 11958.222715523463, 11100.111991040536, 11101.5559377624, 11977.64067077989, 12198.14612977083, 12293.323867187391, 8833.116688331116, 8865.51239681798, 8870.2460290876, 8879.378443509151, 9148.862767058366, 10277.897221027693, 11151.498182581641, 11221.0, 11224.775504490028, 11394.145439092266], "value": 9025.387216295998, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1141.292398712798, 1418.0924208506553, 1481.9777703334453, 1573.9134347610877, 1774.112943528236, 8287.875681864776, 8711.869321960168, 8722.302215822727, 8941.687040953568, 8957.0, 8703.608337624806, 8905.465672059665, 8921.0, 8924.107589241088, 8924.643014279422, 2178.575177840318, 2206.58074965756, 2213.634750266212, 2213.734351877777, 2214.3910424633273, 2300.5168914527967, 2329.080013394708, 2333.0434521846046, 2338.368640467073, 2340.5903966805827, 2300.4478925058033, 2315.8378913476063, 2319.895604697793, 2320.4894923116885, 2325.6395258734924, 2245.6743772152945, 2268.534950335177, 2269.0, 2273.5225602623386, 2274.3859158027403, 2262.264763951706, 2270.0238897274166, 2270.2167752125492, 2271.716035495563, 2274.8862556872255, 8732.257758090569, 8963.641454341818, 8969.282457403457, 9029.909700902972, 9031.683891063782, 5034.773435195425, 5129.204973229155, 5137.357830271216, 5148.2535032420465, 5149.124648809711, 3131.6085489313837, 3157.589513363248, 3177.380410819891, 3189.4418476766473, 3224.1133688235923, 1052.9420881851495, 1057.7567159553269, 1067.7864427114607, 1074.570171931226, 1078.7626722121122, 12364.752704945851, 12558.372081395893, 12564.81152782709, 12595.685107872376, 12597.055220858472, 4373.2565463871215, 4379.5401482843845, 4383.517813040563, 4409.140217657526, 4449.7997590108525, 9832.262580306506, 9851.507424628884, 9854.16239619626, 9855.802883942424, 9858.80282394348, 5006.224035274538, 5014.272930425141, 5022.020705962375, 5022.070916880389, 5022.824201152942, 4141.585841415895, 4302.698811083194, 4668.253079507331, 4699.083678682624, 4733.36099626546, 3822.9235415291537, 3863.768173909574, 3881.0, 3906.6679332257077, 3961.3463778476803, 1115.4255558387438, 1132.2187690493533, 1133.7732453509332, 1138.0554140063894, 1141.9257748246337, 780.1262585903823, 811.8254575266346, 894.2890402130322, 895.6641259527677, 937.8499440089553, 5872.471477567039, 5907.084401917709, 6064.666443345658, 6100.633961962297, 6173.166622505994, 454.372965307873, 454.91793101735345, 458.58956234170233, 468.047523290103, 473.16250237080175, 4129.834806607762, 4310.784460777011, 4325.978370108192, 4339.218940590661, 4370.21336159488, 10524.105451036748, 11073.335599864035, 11126.554937802397, 11140.61007864737, 11163.83254251187, 10968.725781855357, 10999.780004400027, 11011.889881101086, 11025.117990560735, 11034.613788517363, 7877.684892604231, 8183.508989460652, 8185.836283274421, 8371.204735550113, 8442.07137214906, 6077.4226448487325, 6109.297430795337, 6241.251049874044, 6249.187605611241, 6339.651319177489, 10085.092341689284, 10270.383776973405, 10318.48407579633, 10362.792744144925, 10367.63713270032, 10264.0, 10447.791044179226, 10626.946865265625, 10649.307794993301, 10678.0, 7001.579905205704, 7768.495047821873, 7964.123946365779, 8032.718854840053, 8281.420300579142, 8548.74353769388, 8809.735707928772, 8814.779630509289, 8853.645854165761, 8855.822883542165, 7753.147153812964, 7818.452708310364, 7882.566458844819, 8015.559144247122, 8133.552654603817, 7646.617669116633, 7744.007020063048, 7758.573278469513, 7908.960455197687, 8003.599820009093, 6919.411849992807, 7097.077379940574, 7202.855942881218, 7284.271572842674, 7286.890696639449, 5002.399712034434, 5229.346331708536, 5344.732763361739, 5440.42875498067, 5490.780368785204, 5298.973505132604, 5301.840944771663, 5387.0, 5447.291852059366, 5465.480779325958], "value": 4509.037514242366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.0813664782075, 320.8796701237036, 327.74435939966827, 332.0569582386023, 333.07903646417645, 5352.5182733553975, 5374.5700343972485, 5382.38102618199, 5384.892302153955, 5393.460653934604, 5245.79016839327, 5251.632385733, 5262.552683021948, 5322.547583455401, 5371.75827087781, 3919.176972835708, 4003.15933653933, 4139.875803725893, 4168.353905144692, 4182.6235638792505, 4095.242380159665, 4136.627703506684, 4141.8964525886795, 4159.9376009359885, 4179.599834055595, 3949.2299001694537, 4050.8784736457806, 4090.9386359204486, 4093.713440059197, 4125.319322311815, 4033.69747268956, 4114.382842573608, 4152.750834949913, 4189.916201675949, 4214.599613036757, 3723.2181241938956, 3735.2156047230114, 3735.234276973214, 3739.0183202902504, 3757.398816189424, 5149.562287205592, 5167.966406718671, 5173.611979101544, 5180.715060671661, 5211.530962213419, 4504.234280172379, 4752.287156926454, 4766.142094423002, 4770.570648641604, 4799.760011999421, 5509.815389691195, 5520.447955204448, 5530.944690553083, 5531.363893152299, 5580.86047848803, 4093.570175131628, 4093.9385909211387, 4101.569335219789, 4101.789971958279, 4103.794810259505, 5565.443455654443, 5745.827625171251, 5757.82726518201, 5776.0, 5800.448957349003, 4035.6973227008093, 4056.776877271778, 4064.6748260139116, 4077.85727499542, 4088.0, 4105.486814148231, 4107.199096176217, 4115.156392939441, 4131.586841315844, 4157.898156988401, 4540.387047748578, 4689.812407503661, 4728.787204575802, 4750.596199323097, 4771.141194585008, 5534.723263836872, 5538.307711536058, 5539.169124631338, 5547.2511210986, 5555.30558680165, 1444.2129039673403, 1456.8178977627797, 1471.5879553724974, 1471.9558413247619, 1473.7420951333474, 942.5193151492651, 953.498240271575, 968.7093871838421, 969.2246203037541, 972.6060945317158, 5273.419923808378, 5290.735463226823, 5291.153415453509, 5292.417834038252, 5341.893162136813, 5673.574481913873, 5687.914681279784, 5688.146777983336, 5708.7155390036905, 5713.485786279255, 5210.47895210476, 5331.920021199685, 5343.679379237258, 5347.385050719217, 5399.83800485986, 2938.6620538637903, 2970.3465237647683, 2979.582858399826, 2980.7182911348327, 2995.2961054152256, 5393.298871146726, 5734.849431463202, 5746.735718142002, 5768.913466298009, 5803.477687008105, 5702.857428564319, 5724.484796368347, 5733.0540460823495, 5736.770529178786, 5757.65454072757, 5687.729555505518, 5741.88516229673, 5743.62666426681, 5781.624194427349, 5797.333306669787, 5309.33633295838, 5521.254630624814, 5541.0, 5616.5787565931905, 5619.550435965195, 5367.731613419235, 5448.237246785374, 5529.557635389239, 5529.778808847601, 5562.582806289463, 5698.857528561819, 5728.627639203439, 5740.483356497935, 5781.913271301018, 5819.476247137778, 3869.6130386961077, 3954.762714237155, 3958.6738442620895, 3986.60133986599, 3992.6606238468894, 5441.564674826083, 5510.201020852034, 5512.834614961557, 5516.503514683698, 5520.834374968757, 5482.040642887399, 5524.281843360337, 5529.64057336288, 5540.861478463071, 5547.140193269888, 5497.285352904097, 5532.640378375393, 5555.611107222618, 5556.972215138899, 5558.583106267127, 5176.637635365489, 5335.306410166653, 5358.46415358461, 5417.729113544228, 5423.945760542344, 5489.149181876815, 5498.422665620213, 5542.695151766691, 5557.166425036277, 5564.304461942257, 5297.841064767909, 5435.39101231419, 5443.183522471661, 5459.12653975362, 5459.508644222039], "value": 4218.928548050467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.649514985232, 780.7618676303729, 802.7511471443853, 807.5477732469814, 817.9959100204499, 14598.124112553254, 15766.0, 15783.605409864746, 15801.288941997609, 15807.683846323096, 14324.212168330738, 14698.853011469882, 15104.0, 15120.621984450394, 15153.242337883117, 789.668339297495, 798.6246464161864, 804.9154838741936, 806.5281810141074, 806.6612022950375, 657.950653700972, 773.6595897804976, 800.8238187598719, 802.8594995875699, 805.3999770171231, 824.6454024769376, 826.0252901576138, 826.8511667899776, 827.3339961331126, 827.3670641958906, 680.1735890892589, 823.9505629662209, 824.0934971531327, 824.8061705499202, 825.1088824070019, 584.1792281844016, 607.5686262753451, 609.856683679335, 609.9664518451483, 610.7862248213135, 13509.0, 13569.118007329493, 13601.795973060413, 13622.046456748032, 13648.385822638005, 13837.723245535033, 14256.247757981619, 14327.212003339811, 14501.927490362586, 14859.182744949023, 12421.31682757457, 12751.0, 12847.614571562868, 12988.805167922394, 13067.150635208682, 4288.935665965013, 4339.934900976488, 4376.496702879178, 4396.89007774805, 4582.564656357641, 77036.61481692611, 77777.61111194464, 78037.21962780414, 78142.6092869532, 79143.0, 10774.78450430987, 10907.83638245427, 10962.0, 11043.337399756041, 11113.0, 19790.0, 20992.956021376816, 21059.262925797524, 21065.0, 21132.47168820761, 8314.210150035737, 8339.082700902896, 8418.200270974248, 8604.182602652738, 8686.348523860735, 4574.908501829945, 4594.1730488512385, 4694.084653492536, 4717.245240761462, 4882.902341953141, 3506.4564992426212, 3596.3886139356373, 3622.9275414491563, 3633.400488919299, 3645.2527231917393, 600.906859436788, 619.6282230661657, 628.669948277149, 628.8365025093509, 632.4023797511308, 555.9082751346064, 586.2408181405091, 623.9223386124196, 663.571996062537, 668.2715839734713, 8913.28693704502, 9102.226310763526, 9178.036306187754, 9304.8604270936, 9985.20118390527, 529.7907326606046, 561.7640590951728, 677.204284965164, 705.3722187253348, 710.8009757267973, 4273.337632666941, 4426.380306757057, 4527.592516673515, 4595.954040459553, 4620.981025413838, 94396.52801736085, 97704.0, 98873.0, 106180.46909765402, 111710.44144779387, 94727.52636236913, 95154.0, 95623.0, 95709.0, 96660.0, 55111.44888551063, 60740.69629651823, 64240.678796606655, 71195.0, 75435.62282188554, 9565.330426870052, 10030.899691002996, 10095.899041009496, 10183.083522482715, 10348.793024139626, 51556.87544996316, 51887.481125188264, 51947.220791687396, 52663.0, 54795.0, 71435.64282178556, 75665.0, 75846.0, 76476.61761691156, 76679.0, 12878.549250776177, 13077.41151648159, 13124.540641077516, 13383.933080334926, 13635.795463067863, 14984.700305994038, 15048.849511504744, 15178.089314641156, 15275.770863436835, 15307.46423875159, 14019.50931717385, 14232.359543820347, 14490.85509144895, 14572.05281656689, 15095.39618415251, 13910.860891390956, 13983.580492585239, 14131.788023179866, 14454.0, 14612.634684132556, 12338.753224935272, 13068.215907045607, 13466.730665386442, 13622.38699258516, 14068.648283792987, 10605.89394106049, 10716.410597417216, 10732.839007415052, 11203.551857925917, 11489.0, 10718.35689858611, 11166.609168679057, 11503.367314797766, 11890.405479725807, 12051.457684404048], "value": 7428.127819297033, "unit": "score"}], "name": "dromaeo_css", "value": 7115.587750009058, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 115.0, 110.0, 111.0, 113.0, 110.0, 111.0, 112.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 127.0, 177.0, 126.0, 127.0, 158.0, 132.0, 178.0, 126.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 159.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 76.0, 141.0, 76.0, 76.0, 75.0, 74.0, 109.0, 76.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 85.0, 86.0, 84.0, 125.0, 85.0, 88.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 52.0, 53.0, 58.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 68.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 86.0, 78.0, 78.0, 81.0, 80.0, 82.0, 98.0, 79.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 128.0, 121.0, 129.0, 118.0, 128.0, 119.0, 127.0, 132.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 70.0, 63.0, 63.0, 68.0, 64.0, 64.0, 62.0, 72.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1504.6999999999998, "alertThreshold": 2.0}]} 08:24:27 INFO - Return code: 0 08:24:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:27 INFO - # TBPL SUCCESS # 08:24:27 INFO - Running post-action listener: _resource_record_post_action 08:24:27 INFO - ##### 08:24:27 INFO - ##### Finished run-tests step (success) 08:24:27 INFO - ##### 08:24:27 INFO - Running post-run listener: _resource_record_post_run 08:24:27 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 16384; Write bytes: 551030784; Read time: 408; Write time: 683288 08:24:27 INFO - TinderboxPrint: CPU usage
13.2% 08:24:27 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 408 08:24:27 INFO - TinderboxPrint: I/O write bytes / time
551,030,784 / 683,288 08:24:27 INFO - TinderboxPrint: CPU idle
8,276.0 (86.8%) 08:24:27 INFO - TinderboxPrint: CPU user
1,210.2 (12.7%) 08:24:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:24:27 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 4096; Write bytes: 257060864; Read time: 180; Write time: 428644 08:24:27 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 12288; Write bytes: 293969920; Read time: 228; Write time: 254644 08:24:28 INFO - Running post-run listener: _upload_blobber_files 08:24:28 INFO - Blob upload gear active. 08:24:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:28 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 08:24:28 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:28 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:32 INFO - (blobuploader) - INFO - Done attempting. 08:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:32 INFO - (blobuploader) - INFO - Done attempting. 08:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:33 INFO - (blobuploader) - INFO - Done attempting. 08:24:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:33 INFO - Return code: 0 08:24:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80bf062ef3c1bc51c56e072b4288b108faa4b0ed177e3f3e177059527031c023f0815cd5b63657f4b1d28dc80954e44162c014921223fb65b588140c1dc84042", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a7b3b990ec2b62e11aa6953aa1a802045339ab5ee6bb48df51451ccce59aeb6d87a08acd7258f0e963458ec3417cb8f35e1ce0e2dc2a8ac63f394d193d742f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1979aba8b2b6560ea0d32a933645678f20a566ab993c605d41ff3dacf8917cfca9923e9fe9d657595525c8370974f717366011d941f4b48adfe44d7a52db3ac5"} 08:24:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:33 INFO - Contents: 08:24:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80bf062ef3c1bc51c56e072b4288b108faa4b0ed177e3f3e177059527031c023f0815cd5b63657f4b1d28dc80954e44162c014921223fb65b588140c1dc84042", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a7b3b990ec2b62e11aa6953aa1a802045339ab5ee6bb48df51451ccce59aeb6d87a08acd7258f0e963458ec3417cb8f35e1ce0e2dc2a8ac63f394d193d742f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1979aba8b2b6560ea0d32a933645678f20a566ab993c605d41ff3dacf8917cfca9923e9fe9d657595525c8370974f717366011d941f4b48adfe44d7a52db3ac5"} 08:24:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:33 INFO - Copying logs to upload dir... 08:24:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.333027 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-24 08:24:33.643976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 08:24:33.647504) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/80bf062ef3c1bc51c56e072b4288b108faa4b0ed177e3f3e177059527031c023f0815cd5b63657f4b1d28dc80954e44162c014921223fb65b588140c1dc84042", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a7b3b990ec2b62e11aa6953aa1a802045339ab5ee6bb48df51451ccce59aeb6d87a08acd7258f0e963458ec3417cb8f35e1ce0e2dc2a8ac63f394d193d742f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1979aba8b2b6560ea0d32a933645678f20a566ab993c605d41ff3dacf8917cfca9923e9fe9d657595525c8370974f717366011d941f4b48adfe44d7a52db3ac5"} build_url:https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/JmNEPTWLR_O0F7fVJzR-mw/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/Fx-Team/sha512/80bf062ef3c1bc51c56e072b4288b108faa4b0ed177e3f3e177059527031c023f0815cd5b63657f4b1d28dc80954e44162c014921223fb65b588140c1dc84042", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a7b3b990ec2b62e11aa6953aa1a802045339ab5ee6bb48df51451ccce59aeb6d87a08acd7258f0e963458ec3417cb8f35e1ce0e2dc2a8ac63f394d193d742f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1979aba8b2b6560ea0d32a933645678f20a566ab993c605d41ff3dacf8917cfca9923e9fe9d657595525c8370974f717366011d941f4b48adfe44d7a52db3ac5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 08:24:33.677424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:24:33.678192) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1466779946.885769-1688040871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004589 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 08:24:33.763687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 08:24:33.764435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 08:24:33.765182) ========= ========= Total master_lag: 0.17 =========