builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1465506625.23 results: success (0) buildid: 20160609095531 builduid: 0f9345d66527428d978b57a8a271bbda revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.235032) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.235704) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.236032) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.289140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.289541) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:10:25-- 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% 214M=0s 2016-06-09 14:10:25 (214 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081396 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.424523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.424845) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023063 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.460480) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:25.460848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:10:25,612 truncating revision to first 12 chars 2016-06-09 14:10:25,612 Setting DEBUG logging. 2016-06-09 14:10:25,612 attempt 1/10 2016-06-09 14:10:25,612 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a11eb3fab3c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:10:25,916 unpacking tar archive at: mozilla-aurora-a11eb3fab3c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628066 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:26.102093) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:26.102429) ========= script_repo_revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:26.102823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:26.103088) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:10:26.227491) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-09 14:10:26.227899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:26 INFO - MultiFileLogger online at 20160609 14:10:26 in /builds/slave/test 14:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:10:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:26 INFO - {'append_to_log': False, 14:10:26 INFO - 'base_work_dir': '/builds/slave/test', 14:10:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:26 INFO - 'branch': 'Mozilla-Aurora', 14:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:26 INFO - 'config_files': ('talos/linux_config.py',), 14:10:26 INFO - 'default_actions': ('clobber', 14:10:26 INFO - 'read-buildbot-config', 14:10:26 INFO - 'download-and-extract', 14:10:26 INFO - 'populate-webroot', 14:10:26 INFO - 'create-virtualenv', 14:10:26 INFO - 'install', 14:10:26 INFO - 'run-tests'), 14:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:26 INFO - 'download_minidump_stackwalk': True, 14:10:26 INFO - 'download_symbols': 'ondemand', 14:10:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:26 INFO - 'installer_path': 'installer.exe', 14:10:26 INFO - 'log_level': 'info', 14:10:26 INFO - 'log_name': 'talos', 14:10:26 INFO - 'log_to_console': True, 14:10:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:26 INFO - 'opt_config_files': (), 14:10:26 INFO - 'pip_index': False, 14:10:26 INFO - 'sps_profile': False, 14:10:26 INFO - 'sps_profile_interval': 0, 14:10:26 INFO - 'suite': 'dromaeojs-e10s', 14:10:26 INFO - 'system_bits': '32', 14:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:26 INFO - 'title': 'talos-linux64-ix-060', 14:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:26 INFO - 'use_talos_json': True, 14:10:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:26 INFO - 'work_dir': 'build'} 14:10:26 INFO - ##### 14:10:26 INFO - ##### Running clobber step. 14:10:26 INFO - ##### 14:10:26 INFO - Running pre-action listener: _resource_record_pre_action 14:10:26 INFO - Running main action method: clobber 14:10:26 INFO - rmtree: /builds/slave/test/build 14:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:26 INFO - Running post-action listener: _resource_record_post_action 14:10:26 INFO - ##### 14:10:26 INFO - ##### Finished clobber step (success) 14:10:26 INFO - ##### 14:10:26 INFO - ##### 14:10:26 INFO - ##### Running read-buildbot-config step. 14:10:26 INFO - ##### 14:10:26 INFO - Running pre-action listener: _resource_record_pre_action 14:10:26 INFO - Running main action method: read_buildbot_config 14:10:26 INFO - Using buildbot properties: 14:10:26 INFO - { 14:10:26 INFO - "project": "", 14:10:26 INFO - "product": "firefox", 14:10:26 INFO - "script_repo_revision": "production", 14:10:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:10:26 INFO - "repository": "", 14:10:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:10:26 INFO - "buildid": "20160609095531", 14:10:26 INFO - "pgo_build": "True", 14:10:26 INFO - "basedir": "/builds/slave/test", 14:10:26 INFO - "buildnumber": 348, 14:10:26 INFO - "slavename": "talos-linux64-ix-060", 14:10:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:10:26 INFO - "platform": "ubuntu64_hw", 14:10:26 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:10:26 INFO - "branch": "mozilla-aurora", 14:10:26 INFO - "repo_path": "releases/mozilla-aurora", 14:10:26 INFO - "revision": "a11eb3fab3c603e2b13f8185db8e1815b44d8692", 14:10:26 INFO - "stage_platform": "linux64-pgo", 14:10:26 INFO - "builduid": "0f9345d66527428d978b57a8a271bbda", 14:10:26 INFO - "slavebuilddir": "test" 14:10:26 INFO - } 14:10:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 14:10:26 INFO - Running post-action listener: _resource_record_post_action 14:10:26 INFO - ##### 14:10:26 INFO - ##### Finished read-buildbot-config step (success) 14:10:26 INFO - ##### 14:10:26 INFO - ##### 14:10:26 INFO - ##### Running download-and-extract step. 14:10:26 INFO - ##### 14:10:26 INFO - Running pre-action listener: _resource_record_pre_action 14:10:26 INFO - Running main action method: download_and_extract 14:10:26 INFO - mkdir: /builds/slave/test/build/tests 14:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:26 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:10:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:10:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:10:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:10:27 INFO - Downloaded 1361 bytes. 14:10:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 14:10:27 INFO - Using the following test package requirements: 14:10:27 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:10:27 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:27 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:10:27 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'jsshell-linux-x86_64.zip'], 14:10:27 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:27 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 14:10:27 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:10:27 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:10:27 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:27 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 14:10:27 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:27 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:27 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:29 INFO - Downloaded 24473748 bytes. 14:10:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:30 INFO - Return code: 0 14:10:30 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:30 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 14:10:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:31 INFO - Downloaded 24473748 bytes. 14:10:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:32 INFO - Return code: 0 14:10:32 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')]} 14:10:32 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 14:10:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:10:33 INFO - Downloaded 10833369 bytes. 14:10:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:10:34 INFO - Return code: 0 14:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:34 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:10:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:10:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:10:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:10:35 INFO - Downloaded 63559230 bytes. 14:10:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:10:35 INFO - mkdir: /builds/slave/test/properties 14:10:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:35 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:35 INFO - Contents: 14:10:35 INFO - build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 14:10:36 INFO - Running post-action listener: _resource_record_post_action 14:10:36 INFO - Running post-action listener: set_extra_try_arguments 14:10:36 INFO - ##### 14:10:36 INFO - ##### Finished download-and-extract step (success) 14:10:36 INFO - ##### 14:10:36 INFO - ##### 14:10:36 INFO - ##### Running populate-webroot step. 14:10:36 INFO - ##### 14:10:36 INFO - Running pre-action listener: _resource_record_pre_action 14:10:36 INFO - Running main action method: populate_webroot 14:10:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:36 INFO - '--tppagecycles', 14:10:36 INFO - '7'], 14:10:36 INFO - 'tests': ['tsvgm']}}, 14:10:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['damp', 'tps']}, 14:10:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'tests': ['damp', 'tps']}, 14:10:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['dromaeo_dom']}, 14:10:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['a11yr', 14:10:36 INFO - 'ts_paint', 14:10:36 INFO - 'tpaint', 14:10:36 INFO - 'sessionrestore', 14:10:36 INFO - 'sessionrestore_no_auto_restore', 14:10:36 INFO - 'tabpaint']}, 14:10:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['tsvgx', 14:10:36 INFO - 'tsvgr_opacity', 14:10:36 INFO - 'tart', 14:10:36 INFO - 'tscrollx', 14:10:36 INFO - 'cart']}, 14:10:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:36 INFO - 'tsvgr_opacity', 14:10:36 INFO - 'tart', 14:10:36 INFO - 'tscrollx', 14:10:36 INFO - 'cart']}, 14:10:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'talos_options': ['--disable-e10s'], 14:10:36 INFO - 'tests': ['tp5o']}, 14:10:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'tests': ['tp5o']}, 14:10:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'talos_options': ['--disable-e10s', 14:10:36 INFO - '--xperf_path', 14:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:36 INFO - 'tests': ['tp5n']}, 14:10:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:36 INFO - 'talos_options': ['--xperf_path', 14:10:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:36 INFO - 'tests': ['tp5n']}}, 14:10:36 INFO - 'talos.zip': {'path': '', 14:10:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:36 INFO - Running post-action listener: _resource_record_post_action 14:10:36 INFO - ##### 14:10:36 INFO - ##### Finished populate-webroot step (success) 14:10:36 INFO - ##### 14:10:36 INFO - ##### 14:10:36 INFO - ##### Running create-virtualenv step. 14:10:36 INFO - ##### 14:10:36 INFO - Running pre-action listener: _resource_record_pre_action 14:10:36 INFO - Running main action method: create_virtualenv 14:10:36 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:36 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 14:10:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:36 INFO - Using real prefix '/usr' 14:10:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:38 INFO - Installing pip.................done. 14:10:38 INFO - Return code: 0 14:10:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:38 INFO - Using env: {'DISPLAY': ':0', 14:10:38 INFO - 'HOME': '/home/cltbld', 14:10:38 INFO - 'LANG': 'en_US.UTF-8', 14:10:38 INFO - 'LANGUAGE': 'en_US:en', 14:10:38 INFO - 'LOGNAME': 'cltbld', 14:10:38 INFO - 'MAIL': '/var/mail/cltbld', 14:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:38 INFO - 'MOZ_NO_REMOTE': '1', 14:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:38 INFO - 'NO_EM_RESTART': '1', 14:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:38 INFO - 'PWD': '/builds/slave/test', 14:10:38 INFO - 'SHELL': '/bin/bash', 14:10:38 INFO - 'SHLVL': '1', 14:10:38 INFO - 'TERM': 'linux', 14:10:38 INFO - 'TMOUT': '86400', 14:10:38 INFO - 'USER': 'cltbld', 14:10:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:38 INFO - '_': '/tools/buildbot/bin/python'} 14:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:39 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 14:10:39 INFO - Cleaning up... 14:10:39 INFO - Return code: 0 14:10:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:10:39 INFO - Using env: {'DISPLAY': ':0', 14:10:39 INFO - 'HOME': '/home/cltbld', 14:10:39 INFO - 'LANG': 'en_US.UTF-8', 14:10:39 INFO - 'LANGUAGE': 'en_US:en', 14:10:39 INFO - 'LOGNAME': 'cltbld', 14:10:39 INFO - 'MAIL': '/var/mail/cltbld', 14:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:39 INFO - 'MOZ_NO_REMOTE': '1', 14:10:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:39 INFO - 'NO_EM_RESTART': '1', 14:10:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:39 INFO - 'PWD': '/builds/slave/test', 14:10:39 INFO - 'SHELL': '/bin/bash', 14:10:39 INFO - 'SHLVL': '1', 14:10:39 INFO - 'TERM': 'linux', 14:10:39 INFO - 'TMOUT': '86400', 14:10:39 INFO - 'USER': 'cltbld', 14:10:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:39 INFO - '_': '/tools/buildbot/bin/python'} 14:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:39 INFO - Downloading/unpacking psutil>=3.1.1 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:41 INFO - Installing collected packages: psutil 14:10:41 INFO - Running setup.py install for psutil 14:10:41 INFO - building 'psutil._psutil_linux' extension 14:10:41 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 14:10:41 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 14:10:41 INFO - building 'psutil._psutil_posix' extension 14:10:41 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 14:10:41 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 14:10:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:41 INFO - Successfully installed psutil 14:10:41 INFO - Cleaning up... 14:10:41 INFO - Return code: 0 14:10:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:41 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')]} 14:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:41 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')]} 14:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:41 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:41 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 14:10:41 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 14:10:41 INFO - Using env: {'DISPLAY': ':0', 14:10:41 INFO - 'HOME': '/home/cltbld', 14:10:41 INFO - 'LANG': 'en_US.UTF-8', 14:10:41 INFO - 'LANGUAGE': 'en_US:en', 14:10:41 INFO - 'LOGNAME': 'cltbld', 14:10:41 INFO - 'MAIL': '/var/mail/cltbld', 14:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:41 INFO - 'MOZ_NO_REMOTE': '1', 14:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:41 INFO - 'NO_EM_RESTART': '1', 14:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:41 INFO - 'PWD': '/builds/slave/test', 14:10:41 INFO - 'SHELL': '/bin/bash', 14:10:41 INFO - 'SHLVL': '1', 14:10:41 INFO - 'TERM': 'linux', 14:10:41 INFO - 'TMOUT': '86400', 14:10:41 INFO - 'USER': 'cltbld', 14:10:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:41 INFO - '_': '/tools/buildbot/bin/python'} 14:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:43 INFO - Installing collected packages: mozsystemmonitor 14:10:43 INFO - Running setup.py install for mozsystemmonitor 14:10:44 INFO - Successfully installed mozsystemmonitor 14:10:44 INFO - Cleaning up... 14:10:44 INFO - Return code: 0 14:10:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10:44 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')]} 14:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:44 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')]} 14:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:44 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:44 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 14:10:44 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 14:10:44 INFO - Using env: {'DISPLAY': ':0', 14:10:44 INFO - 'HOME': '/home/cltbld', 14:10:44 INFO - 'LANG': 'en_US.UTF-8', 14:10:44 INFO - 'LANGUAGE': 'en_US:en', 14:10:44 INFO - 'LOGNAME': 'cltbld', 14:10:44 INFO - 'MAIL': '/var/mail/cltbld', 14:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:44 INFO - 'MOZ_NO_REMOTE': '1', 14:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:44 INFO - 'NO_EM_RESTART': '1', 14:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:44 INFO - 'PWD': '/builds/slave/test', 14:10:44 INFO - 'SHELL': '/bin/bash', 14:10:44 INFO - 'SHLVL': '1', 14:10:44 INFO - 'TERM': 'linux', 14:10:44 INFO - 'TMOUT': '86400', 14:10:44 INFO - 'USER': 'cltbld', 14:10:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:44 INFO - '_': '/tools/buildbot/bin/python'} 14:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:44 INFO - Downloading/unpacking jsonschema==2.5.1 14:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:46 INFO - warning: no files found matching '*.txt' 14:10:46 INFO - no previously-included directories found matching 'build' 14:10:46 INFO - no previously-included directories found matching 'dist' 14:10:46 INFO - no previously-included directories found matching '.git*' 14:10:46 INFO - Installing collected packages: jsonschema, functools32 14:10:46 INFO - Running setup.py install for functools32 14:10:46 INFO - warning: no files found matching '*.txt' 14:10:46 INFO - no previously-included directories found matching 'build' 14:10:46 INFO - no previously-included directories found matching 'dist' 14:10:46 INFO - no previously-included directories found matching '.git*' 14:10:46 INFO - Successfully installed jsonschema functools32 14:10:46 INFO - Cleaning up... 14:10:46 INFO - Return code: 0 14:10:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:46 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')]} 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 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')]} 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:46 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:46 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 14:10:46 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 14:10:46 INFO - Using env: {'DISPLAY': ':0', 14:10:46 INFO - 'HOME': '/home/cltbld', 14:10:46 INFO - 'LANG': 'en_US.UTF-8', 14:10:46 INFO - 'LANGUAGE': 'en_US:en', 14:10:46 INFO - 'LOGNAME': 'cltbld', 14:10:46 INFO - 'MAIL': '/var/mail/cltbld', 14:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:46 INFO - 'MOZ_NO_REMOTE': '1', 14:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:46 INFO - 'NO_EM_RESTART': '1', 14:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:46 INFO - 'PWD': '/builds/slave/test', 14:10:46 INFO - 'SHELL': '/bin/bash', 14:10:46 INFO - 'SHLVL': '1', 14:10:46 INFO - 'TERM': 'linux', 14:10:46 INFO - 'TMOUT': '86400', 14:10:46 INFO - 'USER': 'cltbld', 14:10:46 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:46 INFO - '_': '/tools/buildbot/bin/python'} 14:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:48 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 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - Downloading docopt-0.6.1.tar.gz 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:49 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:49 INFO - Running setup.py install for blobuploader 14:10:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:49 INFO - Running setup.py install for requests 14:10:50 INFO - Running setup.py install for docopt 14:10:50 INFO - Successfully installed blobuploader requests docopt 14:10:50 INFO - Cleaning up... 14:10:50 INFO - Return code: 0 14:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:50 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:50 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 14:10:50 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 14:10:50 INFO - Using env: {'DISPLAY': ':0', 14:10:50 INFO - 'HOME': '/home/cltbld', 14:10:50 INFO - 'LANG': 'en_US.UTF-8', 14:10:50 INFO - 'LANGUAGE': 'en_US:en', 14:10:50 INFO - 'LOGNAME': 'cltbld', 14:10:50 INFO - 'MAIL': '/var/mail/cltbld', 14:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:50 INFO - 'MOZ_NO_REMOTE': '1', 14:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:50 INFO - 'NO_EM_RESTART': '1', 14:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:50 INFO - 'PWD': '/builds/slave/test', 14:10:50 INFO - 'SHELL': '/bin/bash', 14:10:50 INFO - 'SHLVL': '1', 14:10:50 INFO - 'TERM': 'linux', 14:10:50 INFO - 'TMOUT': '86400', 14:10:50 INFO - 'USER': 'cltbld', 14:10:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:50 INFO - '_': '/tools/buildbot/bin/python'} 14:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:50 INFO - Running setup.py (path:/tmp/pip-G45bHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:50 INFO - Running setup.py (path:/tmp/pip-Ptr9oD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:50 INFO - Running setup.py (path:/tmp/pip-j10JAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:50 INFO - Running setup.py (path:/tmp/pip-EZxiIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:50 INFO - Running setup.py (path:/tmp/pip-v8DtaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:50 INFO - Running setup.py (path:/tmp/pip-xBXjaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:50 INFO - Running setup.py (path:/tmp/pip-klMbh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:50 INFO - Running setup.py (path:/tmp/pip-KIfWff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:50 INFO - Running setup.py (path:/tmp/pip-sIuEvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:51 INFO - Running setup.py (path:/tmp/pip-mqfoLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 INFO - Running setup.py (path:/tmp/pip-TS6f3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 INFO - Running setup.py (path:/tmp/pip-V1Yili-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 INFO - Running setup.py (path:/tmp/pip-DSyLbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 INFO - Running setup.py (path:/tmp/pip-gaSNp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:51 INFO - Running setup.py (path:/tmp/pip-g9GyCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:51 INFO - Running setup.py (path:/tmp/pip-QozSar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:51 INFO - Running setup.py (path:/tmp/pip-JYMnoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:51 INFO - Running setup.py install for manifestparser 14:10:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:51 INFO - Running setup.py install for mozcrash 14:10:51 INFO - Running setup.py install for mozdebug 14:10:51 INFO - Running setup.py install for mozdevice 14:10:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozfile 14:10:52 INFO - Running setup.py install for mozhttpd 14:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozinfo 14:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozInstall 14:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozleak 14:10:52 INFO - Running setup.py install for mozlog 14:10:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for moznetwork 14:10:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozprocess 14:10:52 INFO - Running setup.py install for mozprofile 14:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for mozrunner 14:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for mozscreenshot 14:10:53 INFO - Running setup.py install for moztest 14:10:53 INFO - Running setup.py install for mozversion 14:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:53 INFO - Cleaning up... 14:10:53 INFO - Return code: 0 14:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:53 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:53 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 14:10:53 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 14:10:53 INFO - Using env: {'DISPLAY': ':0', 14:10:53 INFO - 'HOME': '/home/cltbld', 14:10:53 INFO - 'LANG': 'en_US.UTF-8', 14:10:53 INFO - 'LANGUAGE': 'en_US:en', 14:10:53 INFO - 'LOGNAME': 'cltbld', 14:10:53 INFO - 'MAIL': '/var/mail/cltbld', 14:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:53 INFO - 'MOZ_NO_REMOTE': '1', 14:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:53 INFO - 'NO_EM_RESTART': '1', 14:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:53 INFO - 'PWD': '/builds/slave/test', 14:10:53 INFO - 'SHELL': '/bin/bash', 14:10:53 INFO - 'SHLVL': '1', 14:10:53 INFO - 'TERM': 'linux', 14:10:53 INFO - 'TMOUT': '86400', 14:10:53 INFO - 'USER': 'cltbld', 14:10:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:53 INFO - '_': '/tools/buildbot/bin/python'} 14:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:53 INFO - Running setup.py (path:/tmp/pip-fYLvFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:53 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)) 14:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:53 INFO - Running setup.py (path:/tmp/pip-PacrG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:53 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)) 14:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:53 INFO - Running setup.py (path:/tmp/pip-6htMtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:53 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)) 14:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:53 INFO - Running setup.py (path:/tmp/pip-g4eQ4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:53 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)) 14:10:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:53 INFO - Running setup.py (path:/tmp/pip-XSDbPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:54 INFO - Running setup.py (path:/tmp/pip-rFc__3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:54 INFO - Running setup.py (path:/tmp/pip-kCBXyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:54 INFO - Running setup.py (path:/tmp/pip-LqjADr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:54 INFO - Running setup.py (path:/tmp/pip-Ng0hHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:54 INFO - Running setup.py (path:/tmp/pip-Vxtkdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:54 INFO - Running setup.py (path:/tmp/pip-NZ3mIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:54 INFO - Running setup.py (path:/tmp/pip-Ivwt48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:54 INFO - Running setup.py (path:/tmp/pip-yxJ8SQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:54 INFO - Running setup.py (path:/tmp/pip-hZaIgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:54 INFO - Running setup.py (path:/tmp/pip-PiPsK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:54 INFO - Running setup.py (path:/tmp/pip-SvjYOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:54 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)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:54 INFO - Running setup.py (path:/tmp/pip-Fvk5uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:54 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)) 14:10:54 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)) 14:10:54 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)) 14:10:54 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)) 14:10:54 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)) 14:10:54 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)) 14:10:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:56 INFO - Downloading blessings-1.6.tar.gz 14:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:56 INFO - Installing collected packages: blessings 14:10:56 INFO - Running setup.py install for blessings 14:10:57 INFO - Successfully installed blessings 14:10:57 INFO - Cleaning up... 14:10:57 INFO - Return code: 0 14:10:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:57 INFO - Reading from file tmpfile_stdout 14:10:57 INFO - Current package versions: 14:10:57 INFO - argparse == 1.2.1 14:10:57 INFO - blessings == 1.6 14:10:57 INFO - blobuploader == 1.2.4 14:10:57 INFO - docopt == 0.6.1 14:10:57 INFO - functools32 == 3.2.3-2 14:10:57 INFO - jsonschema == 2.5.1 14:10:57 INFO - manifestparser == 1.1 14:10:57 INFO - mozInstall == 1.12 14:10:57 INFO - mozcrash == 0.17 14:10:57 INFO - mozdebug == 0.1 14:10:57 INFO - mozdevice == 0.48 14:10:57 INFO - mozfile == 1.2 14:10:57 INFO - mozhttpd == 0.7 14:10:57 INFO - mozinfo == 0.9 14:10:57 INFO - mozleak == 0.1 14:10:57 INFO - mozlog == 3.2 14:10:57 INFO - moznetwork == 0.27 14:10:57 INFO - mozprocess == 0.22 14:10:57 INFO - mozprofile == 0.28 14:10:57 INFO - mozrunner == 6.11 14:10:57 INFO - mozscreenshot == 0.1 14:10:57 INFO - mozsystemmonitor == 0.3 14:10:57 INFO - moztest == 0.7 14:10:57 INFO - mozversion == 1.4 14:10:57 INFO - psutil == 3.1.1 14:10:57 INFO - requests == 1.2.3 14:10:57 INFO - wsgiref == 0.1.2 14:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:57 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 14:10:57 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 14:10:57 INFO - Using env: {'DISPLAY': ':0', 14:10:57 INFO - 'HOME': '/home/cltbld', 14:10:57 INFO - 'LANG': 'en_US.UTF-8', 14:10:57 INFO - 'LANGUAGE': 'en_US:en', 14:10:57 INFO - 'LOGNAME': 'cltbld', 14:10:57 INFO - 'MAIL': '/var/mail/cltbld', 14:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:57 INFO - 'MOZ_NO_REMOTE': '1', 14:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:57 INFO - 'NO_EM_RESTART': '1', 14:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:57 INFO - 'PWD': '/builds/slave/test', 14:10:57 INFO - 'SHELL': '/bin/bash', 14:10:57 INFO - 'SHLVL': '1', 14:10:57 INFO - 'TERM': 'linux', 14:10:57 INFO - 'TMOUT': '86400', 14:10:57 INFO - 'USER': 'cltbld', 14:10:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:57 INFO - '_': '/tools/buildbot/bin/python'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 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)) 14:10:57 INFO - Cleaning up... 14:10:57 INFO - Return code: 0 14:10:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:57 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 14:10:57 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 14:10:57 INFO - Using env: {'DISPLAY': ':0', 14:10:57 INFO - 'HOME': '/home/cltbld', 14:10:57 INFO - 'LANG': 'en_US.UTF-8', 14:10:57 INFO - 'LANGUAGE': 'en_US:en', 14:10:57 INFO - 'LOGNAME': 'cltbld', 14:10:57 INFO - 'MAIL': '/var/mail/cltbld', 14:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:57 INFO - 'MOZ_NO_REMOTE': '1', 14:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:57 INFO - 'NO_EM_RESTART': '1', 14:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:57 INFO - 'PWD': '/builds/slave/test', 14:10:57 INFO - 'SHELL': '/bin/bash', 14:10:57 INFO - 'SHLVL': '1', 14:10:57 INFO - 'TERM': 'linux', 14:10:57 INFO - 'TMOUT': '86400', 14:10:57 INFO - 'USER': 'cltbld', 14:10:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:57 INFO - '_': '/tools/buildbot/bin/python'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:57 INFO - Cleaning up... 14:10:57 INFO - Return code: 0 14:10:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:57 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 0x7fc5d48eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b64020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', '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 14:10:57 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 14:10:57 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 14:10:57 INFO - Using env: {'DISPLAY': ':0', 14:10:57 INFO - 'HOME': '/home/cltbld', 14:10:57 INFO - 'LANG': 'en_US.UTF-8', 14:10:57 INFO - 'LANGUAGE': 'en_US:en', 14:10:57 INFO - 'LOGNAME': 'cltbld', 14:10:57 INFO - 'MAIL': '/var/mail/cltbld', 14:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:57 INFO - 'MOZ_NO_REMOTE': '1', 14:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:57 INFO - 'NO_EM_RESTART': '1', 14:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:57 INFO - 'PWD': '/builds/slave/test', 14:10:57 INFO - 'SHELL': '/bin/bash', 14:10:57 INFO - 'SHLVL': '1', 14:10:57 INFO - 'TERM': 'linux', 14:10:57 INFO - 'TMOUT': '86400', 14:10:57 INFO - 'USER': 'cltbld', 14:10:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:57 INFO - '_': '/tools/buildbot/bin/python'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 INFO - Downloading/unpacking flake8 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:10:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:10:59 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 14:10:59 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 14:10:59 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 14:10:59 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 14:10:59 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 14:10:59 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 14:11:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:00 INFO - no previously-included directories found matching 'docs/_build' 14:11:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:00 INFO - Running setup.py install for pep8 14:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:00 INFO - no previously-included directories found matching 'docs/_build' 14:11:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:11:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:00 INFO - Cleaning up... 14:11:00 INFO - Return code: 0 14:11:00 INFO - Running post-action listener: _resource_record_post_action 14:11:00 INFO - Running post-action listener: _start_resource_monitoring 14:11:00 INFO - Starting resource monitoring. 14:11:00 INFO - ##### 14:11:00 INFO - ##### Finished create-virtualenv step (success) 14:11:00 INFO - ##### 14:11:00 INFO - ##### 14:11:00 INFO - ##### Running install step. 14:11:00 INFO - ##### 14:11:00 INFO - Running pre-action listener: _resource_record_pre_action 14:11:00 INFO - Running main action method: install 14:11:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:01 INFO - Reading from file tmpfile_stdout 14:11:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:01 INFO - Reading from file tmpfile_stdout 14:11:01 INFO - Output received: 14:11:01 INFO - Usage: mozinstall [options] installer 14:11:01 INFO - Options: 14:11:01 INFO - -h, --help show this help message and exit 14:11:01 INFO - -d DEST, --destination=DEST 14:11:01 INFO - Directory to install application into. [default: 14:11:01 INFO - "/builds/slave/test"] 14:11:01 INFO - --app=APP Application being installed. [default: firefox] 14:11:01 INFO - mkdir: /builds/slave/test/build/application 14:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:11:17 INFO - Reading from file tmpfile_stdout 14:11:17 INFO - Output received: 14:11:17 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:17 INFO - Running post-action listener: _resource_record_post_action 14:11:17 INFO - ##### 14:11:17 INFO - ##### Finished install step (success) 14:11:17 INFO - ##### 14:11:17 INFO - ##### 14:11:17 INFO - ##### Running run-tests step. 14:11:17 INFO - ##### 14:11:17 INFO - Running pre-action listener: _resource_record_pre_action 14:11:17 INFO - Running main action method: run_tests 14:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:17 INFO - Python 2.7.3 14:11:17 INFO - Return code: 0 14:11:17 INFO - grabbing minidump binary from tooltool 14:11:17 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')]} 14:11:17 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 0x2bf62e0>, '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 0x2b62140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b625d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:17 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 14:11:17 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 14:11:17 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 14:11:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:17 INFO - Return code: 0 14:11:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:18 INFO - Return code: 0 14:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:11:18 INFO - Using env: {'DISPLAY': ':0', 14:11:18 INFO - 'HOME': '/home/cltbld', 14:11:18 INFO - 'LANG': 'en_US.UTF-8', 14:11:18 INFO - 'LANGUAGE': 'en_US:en', 14:11:18 INFO - 'LOGNAME': 'cltbld', 14:11:18 INFO - 'MAIL': '/var/mail/cltbld', 14:11:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:18 INFO - 'MOZ_NO_REMOTE': '1', 14:11:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:18 INFO - 'NO_EM_RESTART': '1', 14:11:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:18 INFO - 'PWD': '/builds/slave/test', 14:11:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:18 INFO - 'SHELL': '/bin/bash', 14:11:18 INFO - 'SHLVL': '1', 14:11:18 INFO - 'TERM': 'linux', 14:11:18 INFO - 'TMOUT': '86400', 14:11:18 INFO - 'USER': 'cltbld', 14:11:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822', 14:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:18 INFO - '_': '/tools/buildbot/bin/python'} 14:11:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:11:18 INFO - mozversion application_buildid: 20160609095531 14:11:18 INFO - mozversion application_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 14:11:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:11:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:18 INFO - mozversion application_name: Firefox 14:11:18 INFO - mozversion application_remotingname: firefox-dev 14:11:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:11:18 INFO - mozversion application_vendor: Mozilla 14:11:18 INFO - mozversion application_version: 49.0a2 14:11:18 INFO - mozversion platform_buildid: 20160609095531 14:11:18 INFO - mozversion platform_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 14:11:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:11:18 INFO - mozversion platform_version: 49.0a2 14:11:18 INFO - using testdate: 1465506678 14:11:18 INFO - actual date: 1465506678 14:11:18 INFO - starting webserver on 'localhost:36932' 14:11:18 INFO - SUITE-START | Running 2 tests 14:11:18 INFO - TEST-START | dromaeo_css 14:11:18 INFO - operating with platform_type : linux_ 14:11:18 INFO - Initialising browser for dromaeo_css test... 14:11:18 INFO - TEST-INFO | started process 15117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9osTBc/profile http://localhost:36932/getInfo.html) 14:11:22 INFO - PROCESS | 15117 | __metrics Screen width/height:1600/1200 14:11:22 INFO - PROCESS | 15117 | colorDepth:24 14:11:22 INFO - PROCESS | 15117 | Browser inner width/height: 1024/697 14:11:22 INFO - PROCESS | 15117 | __metrics 14:11:23 ERROR - PROCESS | 15117 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:11:24 INFO - TEST-INFO | 15117: exit 0 14:11:24 INFO - Browser initialized. 14:11:24 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:24 INFO - TEST-INFO | started process 15246 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9osTBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:11:35 INFO - PROCESS | 15246 | RSS: Main: 155684864 14:11:35 INFO - PROCESS | 15246 | 14:12:25 INFO - PROCESS | 15246 | 1465506745575 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] 14:14:33 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36932/tests/dromaeo/cssquery-ext.html) 14:14:34 INFO - PROCESS | 15246 | RSS: Main: 159313920 14:14:34 INFO - PROCESS | 15246 | 14:17:36 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-ext.html (next: http://localhost:36932/tests/dromaeo/cssquery-jquery.html) 14:17:37 INFO - PROCESS | 15246 | RSS: Main: 157663232 14:17:37 INFO - PROCESS | 15246 | 14:20:39 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36932/tests/dromaeo/cssquery-mootools.html) 14:20:39 INFO - PROCESS | 15246 | RSS: Main: 157130752 14:20:39 INFO - PROCESS | 15246 | 14:23:41 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36932/tests/dromaeo/cssquery-prototype.html) 14:23:42 INFO - PROCESS | 15246 | RSS: Main: 157052928 14:23:42 INFO - PROCESS | 15246 | 14:26:44 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36932/tests/dromaeo/cssquery-yui.html) 14:26:45 INFO - PROCESS | 15246 | RSS: Main: 159211520 14:26:45 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | Cycle 1(1): loaded http://localhost:36932/tests/dromaeo/cssquery-yui.html (next: http://localhost:36932/tests/dromaeo/cssquery-dojo.html) 14:29:47 INFO - PROCESS | 15246 | RSS: Main: 158986240 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | __start_tp_report 14:29:47 INFO - PROCESS | 15246 | _x_x_mozilla_page_load 14:29:47 INFO - PROCESS | 15246 | _x_x_mozilla_page_load_details 14:29:47 INFO - PROCESS | 15246 | |i|pagename|runs| 14:29:47 INFO - PROCESS | 15246 | |0;dojo.html;3402.200482886521;3456.7580269381156;3484.4599087141487;3484.8606055757773;3486.808225547594;5763.913541296879;5787.102999035145;5793.507551858092;5842.620229685068;5893.469587737113;5878.52971762259;5913.674747888865;5921.88156236875;5925.4963328117055;5946.791862284821;5222.712750798714;5280.498352656491;5332.120200166968;5349.866253343658;5357.08929481989;5183.17069268917;5216.139337009407;5358.437364076774;5371.274877891493;5385.165299378603;5235.240890070937;5244.711540865251;5255.237990491377;5267.446918073604;5371.75827087782;5246.396664383607;5254.737263136828;5268.631195816294;5283.1546952487415;5299.761510732026;5138.486151384869;5138.74306284688;5162.483751624845;5195.012947539955;5244.737763111829;5539;5539.390667026624;5613.158026296088;5652.74562644682;5670.319561652628;6093.817185484442;6123.2039834821635;6146.7541298348015;6155.907661385083;6160.4455598995855;6043.939560604425;6211.87576248477;6215.160953271341;6215.533834962396;6218.098375735493;5735.541156707453;5748.7987920423;5788.507976821975;5829.387914269026;5844.357120716718;6329.778457753957;6352.110704501373;6369.076483909807;6371;6375.872482550323;5996.490298324691;6043.09353596964;6069.757209711562;6124.234470691164;6130.816075517652;6131.223750760645;6248.250209974832;6248.843778905472;6249.468795152463;6251.687415629201;6151.84620384494;6187.257529096447;6189.35011823761;6191.288001879751;6207.782727604512;6017.909731354033;6033.245844269466;6062.969685151546;6185.443310102022;6199.473044791243;4648.3259927310355;4697.4832768395445;4702.835400760957;4719.764011799465;4722.598579120813;4193.308104162779;4198.895027624273;4206.684498662613;4212.578742125825;4235.745855248695;5900.970495147497;5916.053431450947;5939.792107276311;5943.70281485924;5982.49148822355;6046.3046749624355;6174.722137503823;6205.410486003822;6248.4064013918605;6313.810585682345;5997.70011499432;6032.939670603238;6035.5506469859665;6053.545984051214;6060.727267272895;5202.843914682566;5226.503482169188;5309.734513274321;5353.036453438341;5365.839024829262;6450.161479007793;6499.09012738217;6513.12072870166;6522.445592124723;6526.151600291932;6295.716692748929;6311.779087731908;6311.90532142009;6320.968395158086;6321.30465648769;6170;6302.684865756602;6333.240011198685;6362.204724409449;6456.031595260749;6079.1185278133535;6121.8469538260115;6134.693265336626;6137.202163718688;6145.938540614537;6038.698065096815;6191.535634827496;6231.688415579293;6231.875362492816;6236.064590311489;6089.269287685506;6089.33017368098;6114.844865410725;6117.602355846856;6174.25908890936;6203.565750397609;6204.410580994799;6212.782552610818;6220.284667263141;6237.220347456568;5777.2200752897825;5865;6004.399560044136;6029.246344206974;6046.758129674764;6077.331493535796;6130.765048853506;6144.201253837151;6171.1360409543595;6178.351273116438;5984.670843103671;5999.850003749942;6026.156338112755;6046.27444706638;6073.757049717962 14:29:47 INFO - PROCESS | 15246 | |1;ext.html;605.6578033411122;639.6290151712006;644.3492073006262;644.5681393466377;653.4249860123092;43702.12595748083;44968.550314496846;45489.31766023512;45820;47898.52101478984;46010.76994615022;46662.53337466624;46954.76522617382;47456.288155677605;47875.76062119693;8953.462792232454;9041.728748137566;9106.817863642724;9122.543872806333;9125.863112053325;8781.7804554886;8850.5574721264;8897.33270004749;8901.020887702347;8909.1536304051;8918.286537077018;8918.643254269822;8927.642894284221;8960.103989601053;8972.955135224314;8853;8914.33142514314;8920.018797932222;8920.197182253596;8927.464352138892;8866.689665861728;8920.73237802867;8923.687670931486;8947.239484643813;8998.370114092017;42923.78538107289;43147;43331.13337733228;43452.78273608612;43565.56434435678;3519.582923431103;3648.7081033517256;3714.4428335749585;3755;4315.8057887394825;33375.33249335024;34387.4841877372;34713.13217169566;34855.4771678425;34866.825665871766;4697.600703940135;4775.761211939389;4786.52134786522;4871.975640121812;4898.583620392271;400180;401709;406593.9670301659;407663;408332;71595;72236.27763722296;72917;73082.63458682672;73598.63200683962;41046.79476602598;42265.57734422678;68455;68835.65582172158;69297.65351173312;19671;19814.108365123317;19821.504462388268;19938.501537461678;20006.59986800256;13703.725925481434;13739.381727822072;13743.175409475463;13777.242251676254;13783.793243101361;21194.894025529775;21322.253721119687;21512;21596.676049859263;21768.673469897964;7723.420743444264;7785.610719464004;7893.723719669784;7966.561839098905;8212.794680132925;995.8307087795092;1085.782843431301;1094.2752546160164;1165.2891736041008;1166.9183157179086;30384.5442318361;32835.50746738801;33022.50466243008;33248.1687957803;33647;1154.0940361815933;1236.863944966071;1249.8062800265973;1294.4886769725906;1299.3817457822495;16796.412125575545;17018.404355847735;17338.3064677414;17352.739708904377;17385.304587816347;594370;638006;640054;641810;1003699;63763.6811815938;64280.67859660672;64466.677666611366;65020.34979650143;65333;1472.3227315434806;1483.8367779544242;1486.784416259658;1506.352268524523;1519.6352875310067;33141.50287745734;33345.666543335225;33691.3261734759;33855;34054.82972585121;55295;55485;55676;55754.44245557493;55821.720891395285;394376;394856;396652;400700;406888;30644.08067757971;48524.3016494421;48623.75688121537;48635;48737;49884;49975.500244997085;50349.74825125851;54041.71484435131;55803.720981394836;43969.34045989249;44391.778041110876;45505;45982.7700861507;46366.30450543177;44005;44218.557814421445;44726.552734472236;45002.77498612486;45376.54623453723;45192.54807452015;45977;46177.307340390595;46264.53735462602;46313.53686463092;38710.80644596759;38741.6125838738;39492.2101557973;39732.60267397289;40290.395644065946;30425.847870760503;30815.688823338787;30829.69170308268;30887.845560772053;31334.373312533167 14:29:47 INFO - PROCESS | 15246 | |2;jquery.html;413.7744929013687;415.52837529404127;420.3337709730076;422.90061835468657;428.37457312324005;18292;19522.804771952295;19762.407127786155;20657.896710516463;20824;19144.61710765784;19521;19658.3119590814;19755.802441975575;19785.901070494663;5440.6735595864175;5758.136279558079;5806.709664516758;5832.329282132567;5840.532757379421;5574.526165275936;5723.399043100477;5743.856403589923;5764.942350576483;5794.565407594448;5707.200991861143;5712.400197979194;5733.598648094635;5743.62666426681;5752.424757524235;5634.774609015634;5689.374168841424;5710.457506536894;5711.600187986843;5822.417758224186;5254.500822421864;5261.342332208474;5271.551918086967;5273.288106105665;5274.789008439658;22970.19604313841;23746.287611371685;23819.213558983145;23953.760462395327;24084.27747167588;2431.45292309229;2584.366830126612;2585.6767904012;2655.1636234586044;3091.5826363440874;15139.394424223017;15238.46665366718;15467.458638947695;15607.453739119077;15645.452409165624;2021.7674967378794;2136.295022642524;2147.3128598848375;2157.6871353653632;2186.3331683836423;52477.212841807406;52825.207621885704;59900.10149847756;60409;78621.99999999943;10568.313059651098;10771.353718776898;10774.461276936121;10902.400367979837;10976.341419514854;15827.208639567976;15835.920820395824;15919.602009949844;15970.520884373487;15990.520284391487;8781.912180878237;8973.653951907267;8978.057303983118;9034.186923176945;9087.454752714859;9026.277897768163;9103.725478433025;9123.726288211365;9128.954355228314;9215.861762073575;6863.725450982005;6911.308869113149;6913.71847290393;7044.330788575077;7221.747238846615;1903.8572107092023;1916.281394477071;1932.7100934859602;1932.9710054349196;1967.8979771327815;941.1012483078644;1022.6983040003068;1099.373357186412;1150.8734039255676;1232.5316379775807;19541.706874396896;20139.39581812548;20275.493112672302;20640.793592064187;20909;1061.6337363609543;1091.1870656361061;1093.092733031582;1103.508938522366;1165.7377090154648;11655.88344116565;11718.589849355401;11955.701107472383;11972.98229650472;12032.338221397733;490528;497884;500443;504426;507179;83266.58366708127;91301;92016;92545.5372723132;92788.53605731929;956.579479472982;1067.0823092140752;1088.4394536813547;1104.5471356743697;1118.6364431559775;18352.724709129106;18546.721799172752;18593.34923277679;18813.153408096394;18824;40234.597654023084;40331;40445.797771010955;41821.581784182985;42258.78870605627;52835.471645283054;54906.72546637241;55359.723201383735;55477.1678424832;56251;7795.4543181976715;7937.126916039116;7960.363170946194;8041.517508949481;8177.141400152898;12434.440450179583;13674.31628418595;13769.655758605715;14146.646333841736;14234.35945382481;9016.774580635536;12088.637340879788;12118.091143164474;12392.256464612152;12568.87431125677;12073.939630301793;12244.816327755269;12279.938600306941;12287.1399002069;12620.810687839874;10980.40784086287;11305.378204198849;12338.581063177491;12572.622821315375;12837.614871553867;8077.949866517315;8144.877826832484;8215.34277257806;8399.874001889855;8437.704680336159;11762.70593235176;12634.557790477289;12653.936730316289;12702;12722.6082841415 14:29:47 INFO - PROCESS | 15246 | |3;mootools.html;1540.3761476601976;1562.4765703489334;1771.548255194925;1874.1097978460225;1885.9811401885986;8347.540885251308;9235.99999999999;9318.534073296325;9881.55533001015;9915.603375864966;9618.711438656834;9647.131758141766;9738.464384458852;9747.51262436877;9748.707538773848;2414.8309618326725;2427.1019722702626;2429.0890915906534;2436.8903399347073;2447.400386905211;2481.4788894332214;2497.8501289922665;2504.4490212153296;2510.234378514552;2512.4221429071326;2446.6085426331792;2464.408541949928;2482.615194644824;2487.589547724623;2490.7633774791366;2404.987975060122;2425.6604075429454;2436.098643501898;2463.322586288767;2478.0954951442773;2343.8124950003958;2371.5256948610345;2374.8693821839793;2376.9405764856015;2400.3159099656687;9636.373635713657;9669.419834809863;9678.467684277362;9716.31985760997;9738;5612.07400778871;5789.710514474259;5797.391273916221;5798.623089499169;5799.9130013049835;3638.671884762069;3716.591174970751;3776.6601005909324;3847.8653247136494;3881.7670939743707;1250.3248245947268;1288.7293668329569;1291.5156816193928;2336.7780060894356;2403.339081752532;13799.172049677052;13823.930880345533;13860.93069534656;13872.861271387257;13930.442782288696;4846.29728689338;4897.534734200245;4932.988737308843;4961.925571116436;5019.071471777733;10748.355098694103;10851.51168197433;10859.78280434387;10890.891091089146;10903.83644245337;5621.634593751393;5721.370649228582;5734.455226753452;5739.942600574024;5740.052891272893;4672.859814205579;5162;5233.685978841206;5330.173823057432;5332.200169974535;4094.976255936016;4110.547839737626;4179.811908464127;4190.329547272422;4241.554636763095;1142.5429828068839;1156.809126494119;1164.8252762085756;1173.3312012153162;1176.1355403778216;933.2254228989922;962.4658314635444;974.28390133252;1045.911097556701;1092.1317552545745;6647.4349680276755;6651.567648102858;6652.96673516639;6743.5953842769595;6755.425788807908;1036.2435422141727;1060.2949038889205;1060.4326685223368;1091.8307662312354;1100.1748688483638;4371.144278606966;4439.711418757771;4466.888327791767;4506.729596224237;4580.106879158532;12094.758104837854;12306.938465307616;12321.753564928831;12342.259464432163;12392.070594705434;12052.51789928393;12254;12377.504899804087;12482.375881205904;12526.185797923106;8133.146019667968;8587;8690.739277821676;8888.200061994452;8940.195382415613;6570.704318305592;6581.3747693969;6712.194536655633;6795.354441328066;6798.320167983162;10691.144708423151;10842.783144337227;11034.117270618492;11447.484863181011;11461.598844040418;11291.548338066714;11359.432028398713;11625.12811539121;11687.240329378563;11933.76132477363;7896.368290536629;8409.621567029377;8576.914230857612;8644.438111522732;8745.781355466164;9597.184239339735;9631.807363852544;9657.420554766737;9709.22326213887;9724.756881077747;8538.743837684879;8650.567471626267;8693.30453563726;8723.171298726611;8751.168638979287;8002.639881205476;8072.273495385443;8462.534560599226;8549.487030778173;8630.309575234092;7892.763217103496;7935.0874649413745;7959.602019898866;7980.8802867955865;7992.320652744349;5029;5445.319335083114;5518.06192947208;5586.636868603528;5712.80005199816;5521.558275338044;5537.5569954404355;5586.190002449541;5613.186088017296;5639.379668236409 14:29:47 INFO - PROCESS | 15246 | |4;prototype.html;339.88953590083213;349.0418800392922;349.2717683629632;350.76849279475545;350.8579025494675;5610.24261724667;5767.452092051249;5834.766609335632;5843.824685259444;5897.493565234774;5711.600187986843;5725.141228815669;5763.1355296705415;5775.913361299584;5790.510080665323;4452.376667266585;4456.955430445702;4473.54609751832;4491.797869095883;4502.5047244803045;4413.7793110344355;4449.5995360417555;4485.349624304474;4505.234110201257;4520.615747661453;4408.71343362682;4413.205622987861;4433.933490997638;4469.687121901468;4481.439820022497;4323.286657701476;4461.1523810476065;4503.234450143467;4513.210188217049;4514.300283456069;3896.883093507199;3898.3567711327596;3901.765894046366;3907.199024200032;3909.7263191576603;5611.382747897728;5637.63355381903;5644.238027866227;5657.405972372882;5668.902506072738;5008.123578373807;5101.20931255656;5117.1556693145585;5132.28148059272;5141.820036298749;6042.425969532887;6052.456623561008;6066.8786624267705;6091.725872335755;6125;4286.314189729659;4289.957100429018;4296.033392486696;4299.570042995675;4304.935425968613;6148.96925515374;6300;6318.652474113922;6322.778702745381;6323.197888601772;4341.717788343748;4363.258246098171;4377.956220437819;4378;4391.934120988188;4445.82216711328;4449.375977768092;4449.599536041707;4459.7993090310365;4476.41806565151;4981.476944920803;5091.516305950929;5123.077845987684;5128.358955130609;5148.588112950955;5909.172715819789;6044.486218671374;6070.3929607038945;6083.391660833881;6095.939040609625;1517.673700154472;1524.7712843073627;1533.562934563644;1534.7314220011453;1535.9846401536065;958.3339578992533;959.0217977662745;969.8410399572443;973.2408721197477;987.629638885418;5222.869428264324;5238.816641417532;5251.606129540223;5302.469753024667;5313.335833020872;5515.448455154453;5541.889162216733;5548.392255639843;5562.913907284768;5595.496405323541;5025.195968644999;5215.869603259949;5254.81766602519;5361.6514926530435;5375.650582712111;2959.5077808186115;2969.9257518561776;2974.449726800549;2986.178800829789;2993.6407631084408;5566.805161819317;5640.915386269209;5749.338826035059;5767.077267637158;5782.277215348082;5938.584299099021;6414.1340918976275;6417.133686952295;6422.646754428458;6424.751337032001;6484.239141298036;6497;6497.577657452345;6505.284418713938;6505.447037001813;6020.759169633166;6220.409061139185;6231.753649270255;6346.143270658402;6346.143270658402;6163.322034576104;6199.442050215322;6216.751329946752;6230.563860529719;6276.6547839869245;6248.4376406123665;6387.295020833562;6464.159659244268;6484.967575162094;6508.349165083454;4311.805968731352;4314.223439780744;4323.983863791944;4349.369341445536;4362.28022376317;6029.8191054268445;6081.209442772411;6240.939040363059;6271.592346497463;6308.432241098323;6041.909371359521;6062.454379105901;6068.393160683896;6098.847528811815;6114.969425152845;6085.9695701521205;6088.695565221633;6090.9390906090375;6094.481969032682;6119.938800611937;5642.633228840113;5917.378675239038;5955.344912059757;5956.468500887192;5980.760769569342;6055.818325450244;6107.358727333743;6153.600015998945;6158.445739883432;6183.907241391473;5743.678953840724;6059.939730436102;6060.757569697163;6077.110649184614;6093.542984276109 14:29:47 INFO - PROCESS | 15246 | |5;yui.html;751;776.157868712447;788.0858204482801;793.6349279331507;797.4497596658306;15366.539003829888;15664.216789160553;15691.92154039231;15758.763618545716;15795.368185272604;14694.118352898833;14736.778948315783;14774.852251477481;14804.333804978774;14868.851311486882;704.2218348724663;832.9958350208241;851.5146366571072;859.0936561927165;867.6442658510013;846.5344060766585;851.6252848746532;854.9230569248766;864.5979619476942;866.4757821517985;886.8714036464709;888.7022847346146;897.2687259883207;900.7567956651733;901.3960646366917;843.8776377425239;871.9215270625642;888.693400776731;893.9687110951118;901.4275934781396;634.8730253949228;656.9047488114245;659.3472462262325;662.8210383196558;665.5474277491304;15059.774103388458;15080.245987700571;15095.924520377328;15097.622559435993;15143.242837858174;15369.385224591002;15794.526164215093;15863.286152123183;15933.84066159335;15990.680186396323;12961.481540738454;12996.415161317764;13067.607971760863;13095.803562946563;13125.409356578977;4111.342185250345;4142.420061191406;4147.087640719037;4163.604457576555;4229.386738922839;76517.61741191258;78513;81781;82371;82665;12291.938540307241;12461.875381246253;12524.1233113683;12546.749065018648;12561.434735436927;23204.723740194113;23789.167379141647;23808.40478988039;23897;23910.402239944142;7886.211378862068;8003.719869804529;8198.754037378889;8830.984436789722;9020.8646870297;4709.434867815884;4767.261074533453;4869.9269510957365;5070.670406423645;5150.1502252127975;3814.3706288462095;3931.803409829497;3960.821763020671;3966.4446977423186;3972.7219094663096;661.3089321658878;672.8452455935064;680.4794332335767;687.3332867118887;697.6232834269539;637.4072112935015;670.5875886329969;715.8818794898783;766.9731559395506;799.1648727080099;10747.731306717238;10912.727181820517;11085.722856928642;11155.330680159217;11303.886961130447;713.105053158283;823.3289868756943;828.9088200297963;831.1231650608545;833.1377024779446;4615.907681846412;4638.2115040443205;4686.671932964659;4708.4820669726305;4713.151632706145;116886.41556792162;118424;118944;119068.4046579779;119789;66328;87067.56466217629;94495;100102.4994875021;100679.49660251799;81376;81405;83345.44513354394;83427.5828620853;92795;9593;9921.40471571708;10121.898781012096;10298.536565854705;10323.69821351254;51034.234486483474;51116.48883511117;51455.74272128615;51655.483445166574;52592.737036314575;67950.66024669845;69138;79561.60219198867;80130;80261.99345016421;13750.86249137536;14000.299985000913;14139.222342771247;14180.361883715052;14797;15211.619709507351;15542.30059647296;15759;15822.129782861593;16543.09013004248;14482.348294326992;14569.854301457273;14719.264036797904;14731.926340368229;14758.63103422423;13602.596823351352;13628.434474450773;13995.860041399455;14013.5095271665;14147.43410263578;14138.646533836736;14385.280735962951;14521.128732276096;14814.703705926036;15186.924065380044;11318.094552435621;11493.195476316578;11708.941455292668;11721.179517433698;12012.579559715368;11187.32876027441;11275.887241127484;11295.209335346446;11415.942920285346;11675.591354302558 14:29:47 INFO - PROCESS | 15246 | __end_tp_report 14:29:47 INFO - PROCESS | 15246 | __start_cc_report 14:29:47 INFO - PROCESS | 15246 | _x_x_mozilla_cycle_collect,347 14:29:47 INFO - PROCESS | 15246 | __end_cc_report 14:29:47 INFO - PROCESS | 15246 | __startTimestamp1465507787830__endTimestamp 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | ------- Summary: start ------- 14:29:47 INFO - PROCESS | 15246 | Number of tests: 6 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#0] dojo.html Cycles:165 Average:5771.04 Median:6035.55 stddev:654.53 (10.8%) stddev-sans-first:629.60 14:29:47 INFO - PROCESS | 15246 | Values: 3402.2 3456.8 3484.5 3484.9 3486.8 5763.9 5787.1 5793.5 5842.6 5893.5 5878.5 5913.7 5921.9 5925.5 5946.8 5222.7 5280.5 5332.1 5349.9 5357.1 5183.2 5216.1 5358.4 5371.3 5385.2 5235.2 5244.7 5255.2 5267.4 5371.8 5246.4 5254.7 5268.6 5283.2 5299.8 5138.5 5138.7 5162.5 5195.0 5244.7 5539.0 5539.4 5613.2 5652.7 5670.3 6093.8 6123.2 6146.8 6155.9 6160.4 6043.9 6211.9 6215.2 6215.5 6218.1 5735.5 5748.8 5788.5 5829.4 5844.4 6329.8 6352.1 6369.1 6371.0 6375.9 5996.5 6043.1 6069.8 6124.2 6130.8 6131.2 6248.3 6248.8 6249.5 6251.7 6151.8 6187.3 6189.4 6191.3 6207.8 6017.9 6033.2 6063.0 6185.4 6199.5 4648.3 4697.5 4702.8 4719.8 4722.6 4193.3 4198.9 4206.7 4212.6 4235.7 5901.0 5916.1 5939.8 5943.7 5982.5 6046.3 6174.7 6205.4 6248.4 6313.8 5997.7 6032.9 6035.6 6053.5 6060.7 5202.8 5226.5 5309.7 5353.0 5365.8 6450.2 6499.1 6513.1 6522.4 6526.2 6295.7 6311.8 6311.9 6321.0 6321.3 6170.0 6302.7 6333.2 6362.2 6456.0 6079.1 6121.8 6134.7 6137.2 6145.9 6038.7 6191.5 6231.7 6231.9 6236.1 6089.3 6089.3 6114.8 6117.6 6174.3 6203.6 6204.4 6212.8 6220.3 6237.2 5777.2 5865.0 6004.4 6029.2 6046.8 6077.3 6130.8 6144.2 6171.1 6178.4 5984.7 5999.9 6026.2 6046.3 6073.8 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#1] ext.html Cycles:180 Average:67658.77 Median:45097.66 stddev:141512.79 (313.8%) stddev-sans-first:141820.22 14:29:47 INFO - PROCESS | 15246 | Values: 605.7 639.6 644.3 644.6 653.4 43702.1 44968.6 45489.3 45820.0 47898.5 46010.8 46662.5 46954.8 47456.3 47875.8 8953.5 9041.7 9106.8 9122.5 9125.9 8781.8 8850.6 8897.3 8901.0 8909.2 8918.3 8918.6 8927.6 8960.1 8973.0 8853.0 8914.3 8920.0 8920.2 8927.5 8866.7 8920.7 8923.7 8947.2 8998.4 42923.8 43147.0 43331.1 43452.8 43565.6 3519.6 3648.7 3714.4 3755.0 4315.8 33375.3 34387.5 34713.1 34855.5 34866.8 4697.6 4775.8 4786.5 4872.0 4898.6 400180.0 401709.0 406594.0 407663.0 408332.0 71595.0 72236.3 72917.0 73082.6 73598.6 41046.8 42265.6 68455.0 68835.7 69297.7 19671.0 19814.1 19821.5 19938.5 20006.6 13703.7 13739.4 13743.2 13777.2 13783.8 21194.9 21322.3 21512.0 21596.7 21768.7 7723.4 7785.6 7893.7 7966.6 8212.8 995.8 1085.8 1094.3 1165.3 1166.9 30384.5 32835.5 33022.5 33248.2 33647.0 1154.1 1236.9 1249.8 1294.5 1299.4 16796.4 17018.4 17338.3 17352.7 17385.3 594370.0 638006.0 640054.0 641810.0 1003699.0 63763.7 64280.7 64466.7 65020.3 65333.0 1472.3 1483.8 1486.8 1506.4 1519.6 33141.5 33345.7 33691.3 33855.0 34054.8 55295.0 55485.0 55676.0 55754.4 55821.7 394376.0 394856.0 396652.0 400700.0 406888.0 30644.1 48524.3 48623.8 48635.0 48737.0 49884.0 49975.5 50349.7 54041.7 55803.7 43969.3 44391.8 45505.0 45982.8 46366.3 44005.0 44218.6 44726.6 45002.8 45376.5 45192.5 45977.0 46177.3 46264.5 46313.5 38710.8 38741.6 39492.2 39732.6 40290.4 30425.8 30815.7 30829.7 30887.8 31334.4 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#2] jquery.html Cycles:180 Average:29036.54 Median:24019.02 stddev:81979.49 (341.3%) stddev-sans-first:82181.29 14:29:47 INFO - PROCESS | 15246 | Values: 413.8 415.5 420.3 422.9 428.4 18292.0 19522.8 19762.4 20657.9 20824.0 19144.6 19521.0 19658.3 19755.8 19785.9 5440.7 5758.1 5806.7 5832.3 5840.5 5574.5 5723.4 5743.9 5764.9 5794.6 5707.2 5712.4 5733.6 5743.6 5752.4 5634.8 5689.4 5710.5 5711.6 5822.4 5254.5 5261.3 5271.6 5273.3 5274.8 22970.2 23746.3 23819.2 23953.8 24084.3 2431.5 2584.4 2585.7 2655.2 3091.6 15139.4 15238.5 15467.5 15607.5 15645.5 2021.8 2136.3 2147.3 2157.7 2186.3 52477.2 52825.2 59900.1 60409.0 78622.0 10568.3 10771.4 10774.5 10902.4 10976.3 15827.2 15835.9 15919.6 15970.5 15990.5 8781.9 8973.7 8978.1 9034.2 9087.5 9026.3 9103.7 9123.7 9129.0 9215.9 6863.7 6911.3 6913.7 7044.3 7221.7 1903.9 1916.3 1932.7 1933.0 1967.9 941.1 1022.7 1099.4 1150.9 1232.5 19541.7 20139.4 20275.5 20640.8 20909.0 1061.6 1091.2 1093.1 1103.5 1165.7 11655.9 11718.6 11955.7 11973.0 12032.3 490528.0 497884.0 500443.0 504426.0 507179.0 83266.6 91301.0 92016.0 92545.5 92788.5 956.6 1067.1 1088.4 1104.5 1118.6 18352.7 18546.7 18593.3 18813.2 18824.0 40234.6 40331.0 40445.8 41821.6 42258.8 52835.5 54906.7 55359.7 55477.2 56251.0 7795.5 7937.1 7960.4 8041.5 8177.1 12434.4 13674.3 13769.7 14146.6 14234.4 9016.8 12088.6 12118.1 12392.3 12568.9 12073.9 12244.8 12279.9 12287.1 12620.8 10980.4 11305.4 12338.6 12572.6 12837.6 8077.9 8144.9 8215.3 8399.9 8437.7 11762.7 12634.6 12653.9 12702.0 12722.6 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#3] mootools.html Cycles:180 Average:6381.91 Median:4543.42 stddev:3684.88 (81.1%) stddev-sans-first:3677.26 14:29:47 INFO - PROCESS | 15246 | Values: 1540.4 1562.5 1771.5 1874.1 1886.0 8347.5 9236.0 9318.5 9881.6 9915.6 9618.7 9647.1 9738.5 9747.5 9748.7 2414.8 2427.1 2429.1 2436.9 2447.4 2481.5 2497.9 2504.4 2510.2 2512.4 2446.6 2464.4 2482.6 2487.6 2490.8 2405.0 2425.7 2436.1 2463.3 2478.1 2343.8 2371.5 2374.9 2376.9 2400.3 9636.4 9669.4 9678.5 9716.3 9738.0 5612.1 5789.7 5797.4 5798.6 5799.9 3638.7 3716.6 3776.7 3847.9 3881.8 1250.3 1288.7 1291.5 2336.8 2403.3 13799.2 13823.9 13860.9 13872.9 13930.4 4846.3 4897.5 4933.0 4961.9 5019.1 10748.4 10851.5 10859.8 10890.9 10903.8 5621.6 5721.4 5734.5 5739.9 5740.1 4672.9 5162.0 5233.7 5330.2 5332.2 4095.0 4110.5 4179.8 4190.3 4241.6 1142.5 1156.8 1164.8 1173.3 1176.1 933.2 962.5 974.3 1045.9 1092.1 6647.4 6651.6 6653.0 6743.6 6755.4 1036.2 1060.3 1060.4 1091.8 1100.2 4371.1 4439.7 4466.9 4506.7 4580.1 12094.8 12306.9 12321.8 12342.3 12392.1 12052.5 12254.0 12377.5 12482.4 12526.2 8133.1 8587.0 8690.7 8888.2 8940.2 6570.7 6581.4 6712.2 6795.4 6798.3 10691.1 10842.8 11034.1 11447.5 11461.6 11291.5 11359.4 11625.1 11687.2 11933.8 7896.4 8409.6 8576.9 8644.4 8745.8 9597.2 9631.8 9657.4 9709.2 9724.8 8538.7 8650.6 8693.3 8723.2 8751.2 8002.6 8072.3 8462.5 8549.5 8630.3 7892.8 7935.1 7959.6 7980.9 7992.3 5029.0 5445.3 5518.1 5586.6 5712.8 5521.6 5537.6 5586.2 5613.2 5639.4 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#4] prototype.html Cycles:180 Average:5018.43 Median:5643.44 stddev:1499.36 (26.6%) stddev-sans-first:1461.86 14:29:47 INFO - PROCESS | 15246 | Values: 339.9 349.0 349.3 350.8 350.9 5610.2 5767.5 5834.8 5843.8 5897.5 5711.6 5725.1 5763.1 5775.9 5790.5 4452.4 4457.0 4473.5 4491.8 4502.5 4413.8 4449.6 4485.3 4505.2 4520.6 4408.7 4413.2 4433.9 4469.7 4481.4 4323.3 4461.2 4503.2 4513.2 4514.3 3896.9 3898.4 3901.8 3907.2 3909.7 5611.4 5637.6 5644.2 5657.4 5668.9 5008.1 5101.2 5117.2 5132.3 5141.8 6042.4 6052.5 6066.9 6091.7 6125.0 4286.3 4290.0 4296.0 4299.6 4304.9 6149.0 6300.0 6318.7 6322.8 6323.2 4341.7 4363.3 4378.0 4378.0 4391.9 4445.8 4449.4 4449.6 4459.8 4476.4 4981.5 5091.5 5123.1 5128.4 5148.6 5909.2 6044.5 6070.4 6083.4 6095.9 1517.7 1524.8 1533.6 1534.7 1536.0 958.3 959.0 969.8 973.2 987.6 5222.9 5238.8 5251.6 5302.5 5313.3 5515.4 5541.9 5548.4 5562.9 5595.5 5025.2 5215.9 5254.8 5361.7 5375.7 2959.5 2969.9 2974.4 2986.2 2993.6 5566.8 5640.9 5749.3 5767.1 5782.3 5938.6 6414.1 6417.1 6422.6 6424.8 6484.2 6497.0 6497.6 6505.3 6505.4 6020.8 6220.4 6231.8 6346.1 6346.1 6163.3 6199.4 6216.8 6230.6 6276.7 6248.4 6387.3 6464.2 6485.0 6508.3 4311.8 4314.2 4324.0 4349.4 4362.3 6029.8 6081.2 6240.9 6271.6 6308.4 6041.9 6062.5 6068.4 6098.8 6115.0 6086.0 6088.7 6090.9 6094.5 6119.9 5642.6 5917.4 5955.3 5956.5 5980.8 6055.8 6107.4 6153.6 6158.4 6183.9 5743.7 6059.9 6060.8 6077.1 6093.5 14:29:47 INFO - PROCESS | 15246 | 14:29:47 INFO - PROCESS | 15246 | [#5] yui.html Cycles:180 Average:21141.69 Median:4126.88 stddev:29773.10 (721.4%) stddev-sans-first:29817.25 14:29:47 INFO - PROCESS | 15246 | Values: 751.0 776.2 788.1 793.6 797.4 15366.5 15664.2 15691.9 15758.8 15795.4 14694.1 14736.8 14774.9 14804.3 14868.9 704.2 833.0 851.5 859.1 867.6 846.5 851.6 854.9 864.6 866.5 886.9 888.7 897.3 900.8 901.4 843.9 871.9 888.7 894.0 901.4 634.9 656.9 659.3 662.8 665.5 15059.8 15080.2 15095.9 15097.6 15143.2 15369.4 15794.5 15863.3 15933.8 15990.7 12961.5 12996.4 13067.6 13095.8 13125.4 4111.3 4142.4 4147.1 4163.6 4229.4 76517.6 78513.0 81781.0 82371.0 82665.0 12291.9 12461.9 12524.1 12546.7 12561.4 23204.7 23789.2 23808.4 23897.0 23910.4 7886.2 8003.7 8198.8 8831.0 9020.9 4709.4 4767.3 4869.9 5070.7 5150.2 3814.4 3931.8 3960.8 3966.4 3972.7 661.3 672.8 680.5 687.3 697.6 637.4 670.6 715.9 767.0 799.2 10747.7 10912.7 11085.7 11155.3 11303.9 713.1 823.3 828.9 831.1 833.1 4615.9 4638.2 4686.7 4708.5 4713.2 116886.4 118424.0 118944.0 119068.4 119789.0 66328.0 87067.6 94495.0 100102.5 100679.5 81376.0 81405.0 83345.4 83427.6 92795.0 9593.0 9921.4 10121.9 10298.5 10323.7 51034.2 51116.5 51455.7 51655.5 52592.7 67950.7 69138.0 79561.6 80130.0 80262.0 13750.9 14000.3 14139.2 14180.4 14797.0 15211.6 15542.3 15759.0 15822.1 16543.1 14482.3 14569.9 14719.3 14731.9 14758.6 13602.6 13628.4 13995.9 14013.5 14147.4 14138.6 14385.3 14521.1 14814.7 15186.9 11318.1 11493.2 11708.9 11721.2 12012.6 11187.3 11275.9 11295.2 11415.9 11675.6 14:29:47 INFO - PROCESS | 15246 | -------- Summary: end -------- 14:29:47 INFO - PROCESS | 15246 | 14:29:48 INFO - TEST-INFO | 15246: exit 0 14:29:48 INFO - TEST-OK | dromaeo_css | took 1110215ms 14:29:48 INFO - TEST-START | kraken 14:29:48 INFO - operating with platform_type : linux_ 14:29:48 INFO - Initialising browser for kraken test... 14:29:48 INFO - TEST-INFO | started process 15496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6YTq4d/profile http://localhost:36932/getInfo.html) 14:29:52 INFO - PROCESS | 15496 | __metrics Screen width/height:1600/1200 14:29:52 INFO - PROCESS | 15496 | colorDepth:24 14:29:52 INFO - PROCESS | 15496 | Browser inner width/height: 1024/697 14:29:52 INFO - PROCESS | 15496 | __metrics 14:29:53 ERROR - PROCESS | 15496 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:29:54 INFO - TEST-INFO | 15496: exit 0 14:29:54 INFO - Browser initialized. 14:29:54 INFO - Running cycle 1/1 for kraken test... 14:29:54 INFO - TEST-INFO | started process 15627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6YTq4d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:05 INFO - PROCESS | 15627 | RSS: Main: 156262400 14:30:05 INFO - PROCESS | 15627 | 14:30:08 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:09 INFO - PROCESS | 15627 | RSS: Main: 161292288 14:30:09 INFO - PROCESS | 15627 | 14:30:11 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-dft) 14:30:12 INFO - PROCESS | 15627 | RSS: Main: 160292864 14:30:12 INFO - PROCESS | 15627 | 14:30:15 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-fft) 14:30:16 INFO - PROCESS | 15627 | RSS: Main: 161157120 14:30:16 INFO - PROCESS | 15627 | 14:30:18 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36932/tests/kraken/driver.html?testName=audio-oscillator) 14:30:18 INFO - PROCESS | 15627 | RSS: Main: 160550912 14:30:18 INFO - PROCESS | 15627 | 14:30:20 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:21 INFO - PROCESS | 15627 | RSS: Main: 160522240 14:30:21 INFO - PROCESS | 15627 | 14:30:24 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:25 INFO - PROCESS | 15627 | RSS: Main: 160075776 14:30:25 INFO - PROCESS | 15627 | 14:30:28 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36932/tests/kraken/driver.html?testName=imaging-desaturate) 14:30:29 INFO - PROCESS | 15627 | RSS: Main: 160882688 14:30:29 INFO - PROCESS | 15627 | 14:30:32 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36932/tests/kraken/driver.html?testName=json-parse-financial) 14:30:32 INFO - PROCESS | 15627 | RSS: Main: 160768000 14:30:32 INFO - PROCESS | 15627 | 14:30:34 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:30:34 INFO - PROCESS | 15627 | RSS: Main: 160854016 14:30:34 INFO - PROCESS | 15627 | 14:30:36 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:37 INFO - PROCESS | 15627 | RSS: Main: 160575488 14:30:37 INFO - PROCESS | 15627 | 14:30:39 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:39 INFO - PROCESS | 15627 | RSS: Main: 161882112 14:30:39 INFO - PROCESS | 15627 | 14:30:42 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:43 INFO - PROCESS | 15627 | RSS: Main: 161689600 14:30:43 INFO - PROCESS | 15627 | 14:30:45 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:46 INFO - PROCESS | 15627 | RSS: Main: 161288192 14:30:46 INFO - PROCESS | 15627 | 14:30:47 INFO - PROCESS | 15627 | Cycle 1(1): loaded http://localhost:36932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36932/tests/kraken/driver.html?testName=ai-astar) 14:30:48 INFO - PROCESS | 15627 | RSS: Main: 162021376 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | __start_tp_report 14:30:48 INFO - PROCESS | 15627 | _x_x_mozilla_page_load 14:30:48 INFO - PROCESS | 15627 | _x_x_mozilla_page_load_details 14:30:48 INFO - PROCESS | 15627 | |i|pagename|runs| 14:30:48 INFO - PROCESS | 15627 | |0;ai-astar;113;107;111;110;112;112;111;111;111;110 14:30:48 INFO - PROCESS | 15627 | |1;audio-beat-detection;155;125;151;176;128;154;151;126;173;125 14:30:48 INFO - PROCESS | 15627 | |2;audio-dft;162;160;162;162;161;163;163;163;163;163 14:30:48 INFO - PROCESS | 15627 | |3;audio-fft;75;74;75;166;77;76;74;76;179;77 14:30:48 INFO - PROCESS | 15627 | |4;audio-oscillator;87;85;149;84;88;86;136;86;85;136 14:30:48 INFO - PROCESS | 15627 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;117;117 14:30:48 INFO - PROCESS | 15627 | |6;imaging-darkroom;148;156;147;146;146;148;148;148;147;147 14:30:48 INFO - PROCESS | 15627 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 14:30:48 INFO - PROCESS | 15627 | |8;json-parse-financial;52;53;53;52;55;52;51;52;52;51 14:30:48 INFO - PROCESS | 15627 | |9;json-stringify-tinderbox;61;61;61;60;61;60;61;61;61;61 14:30:48 INFO - PROCESS | 15627 | |10;stanford-crypto-aes;81;75;77;76;77;78;77;77;101;81 14:30:48 INFO - PROCESS | 15627 | |11;stanford-crypto-ccm;123;122;128;123;132;117;125;130;121;120 14:30:48 INFO - PROCESS | 15627 | |12;stanford-crypto-pbkdf2;153;156;153;156;152;154;151;150;162;151 14:30:48 INFO - PROCESS | 15627 | |13;stanford-crypto-sha256-iterative;61;62;62;60;67;62;62;60;61;60 14:30:48 INFO - PROCESS | 15627 | __end_tp_report 14:30:48 INFO - PROCESS | 15627 | __start_cc_report 14:30:48 INFO - PROCESS | 15627 | _x_x_mozilla_cycle_collect,891 14:30:48 INFO - PROCESS | 15627 | __end_cc_report 14:30:48 INFO - PROCESS | 15627 | __startTimestamp1465507848229__endTimestamp 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | ------- Summary: start ------- 14:30:48 INFO - PROCESS | 15627 | Number of tests: 14 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.62 (1.5%) stddev-sans-first:1.51 14:30:48 INFO - PROCESS | 15627 | Values: 113.0 107.0 111.0 110.0 112.0 112.0 111.0 111.0 111.0 110.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:152.50 stddev:19.52 (12.8%) stddev-sans-first:20.45 14:30:48 INFO - PROCESS | 15627 | Values: 155.0 125.0 151.0 176.0 128.0 154.0 151.0 126.0 173.0 125.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 14:30:48 INFO - PROCESS | 15627 | Values: 162.0 160.0 162.0 162.0 161.0 163.0 163.0 163.0 163.0 163.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:41.03 (54.3%) stddev-sans-first:42.88 14:30:48 INFO - PROCESS | 15627 | Values: 75.0 74.0 75.0 166.0 77.0 76.0 74.0 76.0 179.0 77.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:85.50 stddev:26.57 (31.1%) stddev-sans-first:27.61 14:30:48 INFO - PROCESS | 15627 | Values: 87.0 85.0 149.0 84.0 88.0 86.0 136.0 86.0 85.0 136.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:30:48 INFO - PROCESS | 15627 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:2.88 (1.9%) stddev-sans-first:3.06 14:30:48 INFO - PROCESS | 15627 | Values: 148.0 156.0 147.0 146.0 146.0 148.0 148.0 148.0 147.0 147.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:30:48 INFO - PROCESS | 15627 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.16 (2.2%) stddev-sans-first:1.22 14:30:48 INFO - PROCESS | 15627 | Values: 52.0 53.0 53.0 52.0 55.0 52.0 51.0 52.0 52.0 51.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 14:30:48 INFO - PROCESS | 15627 | Values: 61.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:77.00 stddev:7.63 (9.9%) stddev-sans-first:8.08 14:30:48 INFO - PROCESS | 15627 | Values: 81.0 75.0 77.0 76.0 77.0 78.0 77.0 77.0 101.0 81.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:4.68 (3.8%) stddev-sans-first:4.94 14:30:48 INFO - PROCESS | 15627 | Values: 123.0 122.0 128.0 123.0 132.0 117.0 125.0 130.0 121.0 120.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:153.50 stddev:3.52 (2.3%) stddev-sans-first:3.72 14:30:48 INFO - PROCESS | 15627 | Values: 153.0 156.0 153.0 156.0 152.0 154.0 151.0 150.0 162.0 151.0 14:30:48 INFO - PROCESS | 15627 | 14:30:48 INFO - PROCESS | 15627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:2.06 (3.3%) stddev-sans-first:2.17 14:30:48 INFO - PROCESS | 15627 | Values: 61.0 62.0 62.0 60.0 67.0 62.0 62.0 60.0 61.0 60.0 14:30:48 INFO - PROCESS | 15627 | -------- Summary: end -------- 14:30:48 INFO - PROCESS | 15627 | 14:30:49 INFO - TEST-INFO | 15627: exit 0 14:30:49 INFO - TEST-OK | kraken | took 60737ms 14:30:49 INFO - SUITE-END | took 1170s 14:30:49 INFO - Completed test suite (00:19:31) 14:30:49 INFO - javascript benchmark 14:30:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7768.642483505997, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3402.200482886521, 3456.7580269381156, 3484.4599087141487, 3484.8606055757773, 3486.808225547594, 5763.913541296879, 5787.102999035145, 5793.507551858092, 5842.620229685068, 5893.469587737113, 5878.52971762259, 5913.674747888865, 5921.88156236875, 5925.4963328117055, 5946.791862284821, 5222.712750798714, 5280.498352656491, 5332.120200166968, 5349.866253343658, 5357.08929481989, 5183.17069268917, 5216.139337009407, 5358.437364076774, 5371.274877891493, 5385.165299378603, 5235.240890070937, 5244.711540865251, 5255.237990491377, 5267.446918073604, 5371.75827087782, 5246.396664383607, 5254.737263136828, 5268.631195816294, 5283.1546952487415, 5299.761510732026, 5138.486151384869, 5138.74306284688, 5162.483751624845, 5195.012947539955, 5244.737763111829, 5539.0, 5539.390667026624, 5613.158026296088, 5652.74562644682, 5670.319561652628, 6093.817185484442, 6123.2039834821635, 6146.7541298348015, 6155.907661385083, 6160.4455598995855, 6043.939560604425, 6211.87576248477, 6215.160953271341, 6215.533834962396, 6218.098375735493, 5735.541156707453, 5748.7987920423, 5788.507976821975, 5829.387914269026, 5844.357120716718, 6329.778457753957, 6352.110704501373, 6369.076483909807, 6371.0, 6375.872482550323, 5996.490298324691, 6043.09353596964, 6069.757209711562, 6124.234470691164, 6130.816075517652, 6131.223750760645, 6248.250209974832, 6248.843778905472, 6249.468795152463, 6251.687415629201, 6151.84620384494, 6187.257529096447, 6189.35011823761, 6191.288001879751, 6207.782727604512, 6017.909731354033, 6033.245844269466, 6062.969685151546, 6185.443310102022, 6199.473044791243, 4648.3259927310355, 4697.4832768395445, 4702.835400760957, 4719.764011799465, 4722.598579120813, 4193.308104162779, 4198.895027624273, 4206.684498662613, 4212.578742125825, 4235.745855248695, 5900.970495147497, 5916.053431450947, 5939.792107276311, 5943.70281485924, 5982.49148822355, 6046.3046749624355, 6174.722137503823, 6205.410486003822, 6248.4064013918605, 6313.810585682345, 5997.70011499432, 6032.939670603238, 6035.5506469859665, 6053.545984051214, 6060.727267272895, 5202.843914682566, 5226.503482169188, 5309.734513274321, 5353.036453438341, 5365.839024829262, 6450.161479007793, 6499.09012738217, 6513.12072870166, 6522.445592124723, 6526.151600291932, 6295.716692748929, 6311.779087731908, 6311.90532142009, 6320.968395158086, 6321.30465648769, 6170.0, 6302.684865756602, 6333.240011198685, 6362.204724409449, 6456.031595260749, 6079.1185278133535, 6121.8469538260115, 6134.693265336626, 6137.202163718688, 6145.938540614537, 6038.698065096815, 6191.535634827496, 6231.688415579293, 6231.875362492816, 6236.064590311489, 6089.269287685506, 6089.33017368098, 6114.844865410725, 6117.602355846856, 6174.25908890936, 6203.565750397609, 6204.410580994799, 6212.782552610818, 6220.284667263141, 6237.220347456568, 5777.2200752897825, 5865.0, 6004.399560044136, 6029.246344206974, 6046.758129674764, 6077.331493535796, 6130.765048853506, 6144.201253837151, 6171.1360409543595, 6178.351273116438, 5984.670843103671, 5999.850003749942, 6026.156338112755, 6046.27444706638, 6073.757049717962], "value": 5727.494278730627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.6578033411122, 639.6290151712006, 644.3492073006262, 644.5681393466377, 653.4249860123092, 43702.12595748083, 44968.550314496846, 45489.31766023512, 45820.0, 47898.52101478984, 46010.76994615022, 46662.53337466624, 46954.76522617382, 47456.288155677605, 47875.76062119693, 8953.462792232454, 9041.728748137566, 9106.817863642724, 9122.543872806333, 9125.863112053325, 8781.7804554886, 8850.5574721264, 8897.33270004749, 8901.020887702347, 8909.1536304051, 8918.286537077018, 8918.643254269822, 8927.642894284221, 8960.103989601053, 8972.955135224314, 8853.0, 8914.33142514314, 8920.018797932222, 8920.197182253596, 8927.464352138892, 8866.689665861728, 8920.73237802867, 8923.687670931486, 8947.239484643813, 8998.370114092017, 42923.78538107289, 43147.0, 43331.13337733228, 43452.78273608612, 43565.56434435678, 3519.582923431103, 3648.7081033517256, 3714.4428335749585, 3755.0, 4315.8057887394825, 33375.33249335024, 34387.4841877372, 34713.13217169566, 34855.4771678425, 34866.825665871766, 4697.600703940135, 4775.761211939389, 4786.52134786522, 4871.975640121812, 4898.583620392271, 400180.0, 401709.0, 406593.9670301659, 407663.0, 408332.0, 71595.0, 72236.27763722296, 72917.0, 73082.63458682672, 73598.63200683962, 41046.79476602598, 42265.57734422678, 68455.0, 68835.65582172158, 69297.65351173312, 19671.0, 19814.108365123317, 19821.504462388268, 19938.501537461678, 20006.59986800256, 13703.725925481434, 13739.381727822072, 13743.175409475463, 13777.242251676254, 13783.793243101361, 21194.894025529775, 21322.253721119687, 21512.0, 21596.676049859263, 21768.673469897964, 7723.420743444264, 7785.610719464004, 7893.723719669784, 7966.561839098905, 8212.794680132925, 995.8307087795092, 1085.782843431301, 1094.2752546160164, 1165.2891736041008, 1166.9183157179086, 30384.5442318361, 32835.50746738801, 33022.50466243008, 33248.1687957803, 33647.0, 1154.0940361815933, 1236.863944966071, 1249.8062800265973, 1294.4886769725906, 1299.3817457822495, 16796.412125575545, 17018.404355847735, 17338.3064677414, 17352.739708904377, 17385.304587816347, 594370.0, 638006.0, 640054.0, 641810.0, 1003699.0, 63763.6811815938, 64280.67859660672, 64466.677666611366, 65020.34979650143, 65333.0, 1472.3227315434806, 1483.8367779544242, 1486.784416259658, 1506.352268524523, 1519.6352875310067, 33141.50287745734, 33345.666543335225, 33691.3261734759, 33855.0, 34054.82972585121, 55295.0, 55485.0, 55676.0, 55754.44245557493, 55821.720891395285, 394376.0, 394856.0, 396652.0, 400700.0, 406888.0, 30644.08067757971, 48524.3016494421, 48623.75688121537, 48635.0, 48737.0, 49884.0, 49975.500244997085, 50349.74825125851, 54041.71484435131, 55803.720981394836, 43969.34045989249, 44391.778041110876, 45505.0, 45982.7700861507, 46366.30450543177, 44005.0, 44218.557814421445, 44726.552734472236, 45002.77498612486, 45376.54623453723, 45192.54807452015, 45977.0, 46177.307340390595, 46264.53735462602, 46313.53686463092, 38710.80644596759, 38741.6125838738, 39492.2101557973, 39732.60267397289, 40290.395644065946, 30425.847870760503, 30815.688823338787, 30829.69170308268, 30887.845560772053, 31334.373312533167], "value": 21877.59583043617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.7744929013687, 415.52837529404127, 420.3337709730076, 422.90061835468657, 428.37457312324005, 18292.0, 19522.804771952295, 19762.407127786155, 20657.896710516463, 20824.0, 19144.61710765784, 19521.0, 19658.3119590814, 19755.802441975575, 19785.901070494663, 5440.6735595864175, 5758.136279558079, 5806.709664516758, 5832.329282132567, 5840.532757379421, 5574.526165275936, 5723.399043100477, 5743.856403589923, 5764.942350576483, 5794.565407594448, 5707.200991861143, 5712.400197979194, 5733.598648094635, 5743.62666426681, 5752.424757524235, 5634.774609015634, 5689.374168841424, 5710.457506536894, 5711.600187986843, 5822.417758224186, 5254.500822421864, 5261.342332208474, 5271.551918086967, 5273.288106105665, 5274.789008439658, 22970.19604313841, 23746.287611371685, 23819.213558983145, 23953.760462395327, 24084.27747167588, 2431.45292309229, 2584.366830126612, 2585.6767904012, 2655.1636234586044, 3091.5826363440874, 15139.394424223017, 15238.46665366718, 15467.458638947695, 15607.453739119077, 15645.452409165624, 2021.7674967378794, 2136.295022642524, 2147.3128598848375, 2157.6871353653632, 2186.3331683836423, 52477.212841807406, 52825.207621885704, 59900.10149847756, 60409.0, 78621.99999999943, 10568.313059651098, 10771.353718776898, 10774.461276936121, 10902.400367979837, 10976.341419514854, 15827.208639567976, 15835.920820395824, 15919.602009949844, 15970.520884373487, 15990.520284391487, 8781.912180878237, 8973.653951907267, 8978.057303983118, 9034.186923176945, 9087.454752714859, 9026.277897768163, 9103.725478433025, 9123.726288211365, 9128.954355228314, 9215.861762073575, 6863.725450982005, 6911.308869113149, 6913.71847290393, 7044.330788575077, 7221.747238846615, 1903.8572107092023, 1916.281394477071, 1932.7100934859602, 1932.9710054349196, 1967.8979771327815, 941.1012483078644, 1022.6983040003068, 1099.373357186412, 1150.8734039255676, 1232.5316379775807, 19541.706874396896, 20139.39581812548, 20275.493112672302, 20640.793592064187, 20909.0, 1061.6337363609543, 1091.1870656361061, 1093.092733031582, 1103.508938522366, 1165.7377090154648, 11655.88344116565, 11718.589849355401, 11955.701107472383, 11972.98229650472, 12032.338221397733, 490528.0, 497884.0, 500443.0, 504426.0, 507179.0, 83266.58366708127, 91301.0, 92016.0, 92545.5372723132, 92788.53605731929, 956.579479472982, 1067.0823092140752, 1088.4394536813547, 1104.5471356743697, 1118.6364431559775, 18352.724709129106, 18546.721799172752, 18593.34923277679, 18813.153408096394, 18824.0, 40234.597654023084, 40331.0, 40445.797771010955, 41821.581784182985, 42258.78870605627, 52835.471645283054, 54906.72546637241, 55359.723201383735, 55477.1678424832, 56251.0, 7795.4543181976715, 7937.126916039116, 7960.363170946194, 8041.517508949481, 8177.141400152898, 12434.440450179583, 13674.31628418595, 13769.655758605715, 14146.646333841736, 14234.35945382481, 9016.774580635536, 12088.637340879788, 12118.091143164474, 12392.256464612152, 12568.87431125677, 12073.939630301793, 12244.816327755269, 12279.938600306941, 12287.1399002069, 12620.810687839874, 10980.40784086287, 11305.378204198849, 12338.581063177491, 12572.622821315375, 12837.614871553867, 8077.949866517315, 8144.877826832484, 8215.34277257806, 8399.874001889855, 8437.704680336159, 11762.70593235176, 12634.557790477289, 12653.936730316289, 12702.0, 12722.6082841415], "value": 9624.317852955592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1540.3761476601976, 1562.4765703489334, 1771.548255194925, 1874.1097978460225, 1885.9811401885986, 8347.540885251308, 9235.99999999999, 9318.534073296325, 9881.55533001015, 9915.603375864966, 9618.711438656834, 9647.131758141766, 9738.464384458852, 9747.51262436877, 9748.707538773848, 2414.8309618326725, 2427.1019722702626, 2429.0890915906534, 2436.8903399347073, 2447.400386905211, 2481.4788894332214, 2497.8501289922665, 2504.4490212153296, 2510.234378514552, 2512.4221429071326, 2446.6085426331792, 2464.408541949928, 2482.615194644824, 2487.589547724623, 2490.7633774791366, 2404.987975060122, 2425.6604075429454, 2436.098643501898, 2463.322586288767, 2478.0954951442773, 2343.8124950003958, 2371.5256948610345, 2374.8693821839793, 2376.9405764856015, 2400.3159099656687, 9636.373635713657, 9669.419834809863, 9678.467684277362, 9716.31985760997, 9738.0, 5612.07400778871, 5789.710514474259, 5797.391273916221, 5798.623089499169, 5799.9130013049835, 3638.671884762069, 3716.591174970751, 3776.6601005909324, 3847.8653247136494, 3881.7670939743707, 1250.3248245947268, 1288.7293668329569, 1291.5156816193928, 2336.7780060894356, 2403.339081752532, 13799.172049677052, 13823.930880345533, 13860.93069534656, 13872.861271387257, 13930.442782288696, 4846.29728689338, 4897.534734200245, 4932.988737308843, 4961.925571116436, 5019.071471777733, 10748.355098694103, 10851.51168197433, 10859.78280434387, 10890.891091089146, 10903.83644245337, 5621.634593751393, 5721.370649228582, 5734.455226753452, 5739.942600574024, 5740.052891272893, 4672.859814205579, 5162.0, 5233.685978841206, 5330.173823057432, 5332.200169974535, 4094.976255936016, 4110.547839737626, 4179.811908464127, 4190.329547272422, 4241.554636763095, 1142.5429828068839, 1156.809126494119, 1164.8252762085756, 1173.3312012153162, 1176.1355403778216, 933.2254228989922, 962.4658314635444, 974.28390133252, 1045.911097556701, 1092.1317552545745, 6647.4349680276755, 6651.567648102858, 6652.96673516639, 6743.5953842769595, 6755.425788807908, 1036.2435422141727, 1060.2949038889205, 1060.4326685223368, 1091.8307662312354, 1100.1748688483638, 4371.144278606966, 4439.711418757771, 4466.888327791767, 4506.729596224237, 4580.106879158532, 12094.758104837854, 12306.938465307616, 12321.753564928831, 12342.259464432163, 12392.070594705434, 12052.51789928393, 12254.0, 12377.504899804087, 12482.375881205904, 12526.185797923106, 8133.146019667968, 8587.0, 8690.739277821676, 8888.200061994452, 8940.195382415613, 6570.704318305592, 6581.3747693969, 6712.194536655633, 6795.354441328066, 6798.320167983162, 10691.144708423151, 10842.783144337227, 11034.117270618492, 11447.484863181011, 11461.598844040418, 11291.548338066714, 11359.432028398713, 11625.12811539121, 11687.240329378563, 11933.76132477363, 7896.368290536629, 8409.621567029377, 8576.914230857612, 8644.438111522732, 8745.781355466164, 9597.184239339735, 9631.807363852544, 9657.420554766737, 9709.22326213887, 9724.756881077747, 8538.743837684879, 8650.567471626267, 8693.30453563726, 8723.171298726611, 8751.168638979287, 8002.639881205476, 8072.273495385443, 8462.534560599226, 8549.487030778173, 8630.309575234092, 7892.763217103496, 7935.0874649413745, 7959.602019898866, 7980.8802867955865, 7992.320652744349, 5029.0, 5445.319335083114, 5518.06192947208, 5586.636868603528, 5712.80005199816, 5521.558275338044, 5537.5569954404355, 5586.190002449541, 5613.186088017296, 5639.379668236409], "value": 5086.329161556932, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.88953590083213, 349.0418800392922, 349.2717683629632, 350.76849279475545, 350.8579025494675, 5610.24261724667, 5767.452092051249, 5834.766609335632, 5843.824685259444, 5897.493565234774, 5711.600187986843, 5725.141228815669, 5763.1355296705415, 5775.913361299584, 5790.510080665323, 4452.376667266585, 4456.955430445702, 4473.54609751832, 4491.797869095883, 4502.5047244803045, 4413.7793110344355, 4449.5995360417555, 4485.349624304474, 4505.234110201257, 4520.615747661453, 4408.71343362682, 4413.205622987861, 4433.933490997638, 4469.687121901468, 4481.439820022497, 4323.286657701476, 4461.1523810476065, 4503.234450143467, 4513.210188217049, 4514.300283456069, 3896.883093507199, 3898.3567711327596, 3901.765894046366, 3907.199024200032, 3909.7263191576603, 5611.382747897728, 5637.63355381903, 5644.238027866227, 5657.405972372882, 5668.902506072738, 5008.123578373807, 5101.20931255656, 5117.1556693145585, 5132.28148059272, 5141.820036298749, 6042.425969532887, 6052.456623561008, 6066.8786624267705, 6091.725872335755, 6125.0, 4286.314189729659, 4289.957100429018, 4296.033392486696, 4299.570042995675, 4304.935425968613, 6148.96925515374, 6300.0, 6318.652474113922, 6322.778702745381, 6323.197888601772, 4341.717788343748, 4363.258246098171, 4377.956220437819, 4378.0, 4391.934120988188, 4445.82216711328, 4449.375977768092, 4449.599536041707, 4459.7993090310365, 4476.41806565151, 4981.476944920803, 5091.516305950929, 5123.077845987684, 5128.358955130609, 5148.588112950955, 5909.172715819789, 6044.486218671374, 6070.3929607038945, 6083.391660833881, 6095.939040609625, 1517.673700154472, 1524.7712843073627, 1533.562934563644, 1534.7314220011453, 1535.9846401536065, 958.3339578992533, 959.0217977662745, 969.8410399572443, 973.2408721197477, 987.629638885418, 5222.869428264324, 5238.816641417532, 5251.606129540223, 5302.469753024667, 5313.335833020872, 5515.448455154453, 5541.889162216733, 5548.392255639843, 5562.913907284768, 5595.496405323541, 5025.195968644999, 5215.869603259949, 5254.81766602519, 5361.6514926530435, 5375.650582712111, 2959.5077808186115, 2969.9257518561776, 2974.449726800549, 2986.178800829789, 2993.6407631084408, 5566.805161819317, 5640.915386269209, 5749.338826035059, 5767.077267637158, 5782.277215348082, 5938.584299099021, 6414.1340918976275, 6417.133686952295, 6422.646754428458, 6424.751337032001, 6484.239141298036, 6497.0, 6497.577657452345, 6505.284418713938, 6505.447037001813, 6020.759169633166, 6220.409061139185, 6231.753649270255, 6346.143270658402, 6346.143270658402, 6163.322034576104, 6199.442050215322, 6216.751329946752, 6230.563860529719, 6276.6547839869245, 6248.4376406123665, 6387.295020833562, 6464.159659244268, 6484.967575162094, 6508.349165083454, 4311.805968731352, 4314.223439780744, 4323.983863791944, 4349.369341445536, 4362.28022376317, 6029.8191054268445, 6081.209442772411, 6240.939040363059, 6271.592346497463, 6308.432241098323, 6041.909371359521, 6062.454379105901, 6068.393160683896, 6098.847528811815, 6114.969425152845, 6085.9695701521205, 6088.695565221633, 6090.9390906090375, 6094.481969032682, 6119.938800611937, 5642.633228840113, 5917.378675239038, 5955.344912059757, 5956.468500887192, 5980.760769569342, 6055.818325450244, 6107.358727333743, 6153.600015998945, 6158.445739883432, 6183.907241391473, 5743.678953840724, 6059.939730436102, 6060.757569697163, 6077.110649184614, 6093.542984276109], "value": 4534.971614601289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.0, 776.157868712447, 788.0858204482801, 793.6349279331507, 797.4497596658306, 15366.539003829888, 15664.216789160553, 15691.92154039231, 15758.763618545716, 15795.368185272604, 14694.118352898833, 14736.778948315783, 14774.852251477481, 14804.333804978774, 14868.851311486882, 704.2218348724663, 832.9958350208241, 851.5146366571072, 859.0936561927165, 867.6442658510013, 846.5344060766585, 851.6252848746532, 854.9230569248766, 864.5979619476942, 866.4757821517985, 886.8714036464709, 888.7022847346146, 897.2687259883207, 900.7567956651733, 901.3960646366917, 843.8776377425239, 871.9215270625642, 888.693400776731, 893.9687110951118, 901.4275934781396, 634.8730253949228, 656.9047488114245, 659.3472462262325, 662.8210383196558, 665.5474277491304, 15059.774103388458, 15080.245987700571, 15095.924520377328, 15097.622559435993, 15143.242837858174, 15369.385224591002, 15794.526164215093, 15863.286152123183, 15933.84066159335, 15990.680186396323, 12961.481540738454, 12996.415161317764, 13067.607971760863, 13095.803562946563, 13125.409356578977, 4111.342185250345, 4142.420061191406, 4147.087640719037, 4163.604457576555, 4229.386738922839, 76517.61741191258, 78513.0, 81781.0, 82371.0, 82665.0, 12291.938540307241, 12461.875381246253, 12524.1233113683, 12546.749065018648, 12561.434735436927, 23204.723740194113, 23789.167379141647, 23808.40478988039, 23897.0, 23910.402239944142, 7886.211378862068, 8003.719869804529, 8198.754037378889, 8830.984436789722, 9020.8646870297, 4709.434867815884, 4767.261074533453, 4869.9269510957365, 5070.670406423645, 5150.1502252127975, 3814.3706288462095, 3931.803409829497, 3960.821763020671, 3966.4446977423186, 3972.7219094663096, 661.3089321658878, 672.8452455935064, 680.4794332335767, 687.3332867118887, 697.6232834269539, 637.4072112935015, 670.5875886329969, 715.8818794898783, 766.9731559395506, 799.1648727080099, 10747.731306717238, 10912.727181820517, 11085.722856928642, 11155.330680159217, 11303.886961130447, 713.105053158283, 823.3289868756943, 828.9088200297963, 831.1231650608545, 833.1377024779446, 4615.907681846412, 4638.2115040443205, 4686.671932964659, 4708.4820669726305, 4713.151632706145, 116886.41556792162, 118424.0, 118944.0, 119068.4046579779, 119789.0, 66328.0, 87067.56466217629, 94495.0, 100102.4994875021, 100679.49660251799, 81376.0, 81405.0, 83345.44513354394, 83427.5828620853, 92795.0, 9593.0, 9921.40471571708, 10121.898781012096, 10298.536565854705, 10323.69821351254, 51034.234486483474, 51116.48883511117, 51455.74272128615, 51655.483445166574, 52592.737036314575, 67950.66024669845, 69138.0, 79561.60219198867, 80130.0, 80261.99345016421, 13750.86249137536, 14000.299985000913, 14139.222342771247, 14180.361883715052, 14797.0, 15211.619709507351, 15542.30059647296, 15759.0, 15822.129782861593, 16543.09013004248, 14482.348294326992, 14569.854301457273, 14719.264036797904, 14731.926340368229, 14758.63103422423, 13602.596823351352, 13628.434474450773, 13995.860041399455, 14013.5095271665, 14147.43410263578, 14138.646533836736, 14385.280735962951, 14521.128732276096, 14814.703705926036, 15186.924065380044, 11318.094552435621, 11493.195476316578, 11708.941455292668, 11721.179517433698, 12012.579559715368, 11187.32876027441, 11275.887241127484, 11295.209335346446, 11415.942920285346, 11675.591354302558], "value": 7901.618862841829, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 111.0, 110.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 151.0, 176.0, 128.0, 154.0, 151.0, 126.0, 173.0, 125.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 163.0, 163.0, 163.0, 163.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 166.0, 77.0, 76.0, 74.0, 76.0, 179.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 149.0, 84.0, 88.0, 86.0, 136.0, 86.0, 85.0, 136.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 156.0, 147.0, 146.0, 146.0, 148.0, 148.0, 148.0, 147.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 52.0, 55.0, 52.0, 51.0, 52.0, 52.0, 51.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 77.0, 76.0, 77.0, 78.0, 77.0, 77.0, 101.0, 81.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 128.0, 123.0, 132.0, 117.0, 125.0, 130.0, 121.0, 120.0], "value": 124.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 156.0, 153.0, 156.0, 152.0, 154.0, 151.0, 150.0, 162.0, 151.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 60.0, 67.0, 62.0, 62.0, 60.0, 61.0, 60.0], "value": 61.7, "unit": "score"}]}]} 14:30:49 INFO - Return code: 0 14:30:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:49 ERROR - # TBPL SUCCESS # 14:30:49 INFO - Running post-action listener: _resource_record_post_action 14:30:49 INFO - ##### 14:30:49 INFO - ##### Finished run-tests step (success) 14:30:49 INFO - ##### 14:30:49 INFO - Running post-run listener: _resource_record_post_run 14:30:49 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 512598016; Read time: 0; Write time: 447340 14:30:49 INFO - TinderboxPrint: CPU usage
13.4% 14:30:49 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:30:49 INFO - TinderboxPrint: I/O write bytes / time
512,598,016 / 447,340 14:30:49 INFO - TinderboxPrint: CPU idle
8,207.5 (86.6%) 14:30:49 INFO - TinderboxPrint: CPU user
1,213.6 (12.8%) 14:30:49 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 264376320; Read time: 0; Write time: 279056 14:30:49 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 248221696; Read time: 0; Write time: 168284 14:30:50 INFO - Running post-run listener: _upload_blobber_files 14:30:50 INFO - Blob upload gear active. 14:30:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:50 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 14:30:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:50 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:51 INFO - (blobuploader) - INFO - Done attempting. 14:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:54 INFO - (blobuploader) - INFO - Done attempting. 14:30:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:30:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:55 INFO - (blobuploader) - INFO - Done attempting. 14:30:55 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:55 INFO - Return code: 0 14:30:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f84ac7b01e3feeb353fcfb373081223945e37c95c35d6dc0d090d340d4d750bd722dcbb9c9fe90921aa12abecc24263c54434aee2fb5d0600c12e2b04d6e6df1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/144c8d4da4296ad2d438ef7ca4b659438ed590dc4accd5b57ba1a4c3535ce9311ec7ba78df6fa09f08ea18ecaa1b607466120e3be27a9391127155047410e782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be39ebbfce1c8cf0fcc2d666766850ede777213b83ac8beaec0820898c3eb8b45fccd59a95369251e4cf23f65a961b3858b1ae54bebf1bfb6be7cd32b902cb61"} 14:30:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:55 INFO - Contents: 14:30:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f84ac7b01e3feeb353fcfb373081223945e37c95c35d6dc0d090d340d4d750bd722dcbb9c9fe90921aa12abecc24263c54434aee2fb5d0600c12e2b04d6e6df1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/144c8d4da4296ad2d438ef7ca4b659438ed590dc4accd5b57ba1a4c3535ce9311ec7ba78df6fa09f08ea18ecaa1b607466120e3be27a9391127155047410e782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be39ebbfce1c8cf0fcc2d666766850ede777213b83ac8beaec0820898c3eb8b45fccd59a95369251e4cf23f65a961b3858b1ae54bebf1bfb6be7cd32b902cb61"} 14:30:55 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:55 INFO - Copying logs to upload dir... 14:30:55 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.042252 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-09 14:30:55.284844) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:30:55.287947) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f84ac7b01e3feeb353fcfb373081223945e37c95c35d6dc0d090d340d4d750bd722dcbb9c9fe90921aa12abecc24263c54434aee2fb5d0600c12e2b04d6e6df1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/144c8d4da4296ad2d438ef7ca4b659438ed590dc4accd5b57ba1a4c3535ce9311ec7ba78df6fa09f08ea18ecaa1b607466120e3be27a9391127155047410e782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be39ebbfce1c8cf0fcc2d666766850ede777213b83ac8beaec0820898c3eb8b45fccd59a95369251e4cf23f65a961b3858b1ae54bebf1bfb6be7cd32b902cb61"} build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f84ac7b01e3feeb353fcfb373081223945e37c95c35d6dc0d090d340d4d750bd722dcbb9c9fe90921aa12abecc24263c54434aee2fb5d0600c12e2b04d6e6df1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/144c8d4da4296ad2d438ef7ca4b659438ed590dc4accd5b57ba1a4c3535ce9311ec7ba78df6fa09f08ea18ecaa1b607466120e3be27a9391127155047410e782", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/be39ebbfce1c8cf0fcc2d666766850ede777213b83ac8beaec0820898c3eb8b45fccd59a95369251e4cf23f65a961b3858b1ae54bebf1bfb6be7cd32b902cb61"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:30:55.316863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:30:55.317200) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465506624.476907-404560822 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:30:55.400617) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:30:55.400936) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:30:55.401235) ========= ========= Total master_lag: 0.19 =========