builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-061 starttime: 1469874474.47 results: success (0) buildid: 20160729170826 builduid: 5bb96b5f7e074e778445d151ad800bd4 revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.469000) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.469475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.469796) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.484421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.484715) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-30 03:27:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-07-30 03:27:55 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.626004) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.626340) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:54.675620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:27:54.675980) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 589e1f984537e280ff84591e94afdc3c5bfe2710 --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 589e1f984537e280ff84591e94afdc3c5bfe2710 --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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-30 03:27:55,646 truncating revision to first 12 chars 2016-07-30 03:27:55,646 Setting DEBUG logging. 2016-07-30 03:27:55,646 attempt 1/10 2016-07-30 03:27:55,646 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/589e1f984537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-30 03:27:57,058 unpacking tar archive at: mozilla-aurora-589e1f984537/testing/mozharness/ program finished with exit code 0 elapsedTime=1.766262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-30 03:27:56.459631) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:56.460395) ========= script_repo_revision: 589e1f984537e280ff84591e94afdc3c5bfe2710 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:56.461334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:56.462055) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-30 03:27:56.473095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-30 03:27:56.473604) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:57 INFO - MultiFileLogger online at 20160730 03:27:57 in /builds/slave/test 03:27:57 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 03:27:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:57 INFO - {'append_to_log': False, 03:27:57 INFO - 'base_work_dir': '/builds/slave/test', 03:27:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:27:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:57 INFO - 'branch': 'Mozilla-Aurora', 03:27:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:57 INFO - 'config_files': ('talos/linux_config.py',), 03:27:57 INFO - 'default_actions': ('clobber', 03:27:57 INFO - 'read-buildbot-config', 03:27:57 INFO - 'download-and-extract', 03:27:57 INFO - 'populate-webroot', 03:27:57 INFO - 'create-virtualenv', 03:27:57 INFO - 'install', 03:27:57 INFO - 'run-tests'), 03:27:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:57 INFO - 'download_minidump_stackwalk': True, 03:27:57 INFO - 'download_symbols': 'ondemand', 03:27:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:57 INFO - 'installer_path': 'installer.exe', 03:27:57 INFO - 'log_level': 'info', 03:27:57 INFO - 'log_name': 'talos', 03:27:57 INFO - 'log_to_console': True, 03:27:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:57 INFO - 'opt_config_files': (), 03:27:57 INFO - 'pip_index': False, 03:27:57 INFO - 'sps_profile': False, 03:27:57 INFO - 'sps_profile_interval': 0, 03:27:57 INFO - 'suite': 'dromaeojs-e10s', 03:27:57 INFO - 'system_bits': '32', 03:27:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:57 INFO - 'title': 'talos-linux64-ix-061', 03:27:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:57 INFO - 'use_talos_json': True, 03:27:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:57 INFO - 'work_dir': 'build'} 03:27:57 INFO - ##### 03:27:57 INFO - ##### Running clobber step. 03:27:57 INFO - ##### 03:27:57 INFO - Running pre-action listener: _resource_record_pre_action 03:27:57 INFO - Running main action method: clobber 03:27:57 INFO - rmtree: /builds/slave/test/build 03:27:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:58 INFO - Running post-action listener: _resource_record_post_action 03:27:58 INFO - ##### 03:27:58 INFO - ##### Finished clobber step (success) 03:27:58 INFO - ##### 03:27:58 INFO - ##### 03:27:58 INFO - ##### Running read-buildbot-config step. 03:27:58 INFO - ##### 03:27:58 INFO - Running pre-action listener: _resource_record_pre_action 03:27:58 INFO - Running main action method: read_buildbot_config 03:27:58 INFO - Using buildbot properties: 03:27:58 INFO - { 03:27:58 INFO - "project": "", 03:27:58 INFO - "product": "firefox", 03:27:58 INFO - "script_repo_revision": "production", 03:27:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:27:58 INFO - "repository": "", 03:27:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:27:58 INFO - "buildid": "20160729170826", 03:27:58 INFO - "pgo_build": "True", 03:27:58 INFO - "basedir": "/builds/slave/test", 03:27:58 INFO - "buildnumber": 420, 03:27:58 INFO - "slavename": "talos-linux64-ix-061", 03:27:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:58 INFO - "platform": "ubuntu64_hw", 03:27:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:27:58 INFO - "branch": "mozilla-aurora", 03:27:58 INFO - "repo_path": "releases/mozilla-aurora", 03:27:58 INFO - "revision": "589e1f984537e280ff84591e94afdc3c5bfe2710", 03:27:58 INFO - "stage_platform": "linux64-pgo", 03:27:58 INFO - "builduid": "5bb96b5f7e074e778445d151ad800bd4", 03:27:58 INFO - "slavebuilddir": "test" 03:27:58 INFO - } 03:27:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:27:58 INFO - Running post-action listener: _resource_record_post_action 03:27:58 INFO - ##### 03:27:58 INFO - ##### Finished read-buildbot-config step (success) 03:27:58 INFO - ##### 03:27:58 INFO - ##### 03:27:58 INFO - ##### Running download-and-extract step. 03:27:58 INFO - ##### 03:27:58 INFO - Running pre-action listener: _resource_record_pre_action 03:27:58 INFO - Running main action method: download_and_extract 03:27:58 INFO - mkdir: /builds/slave/test/build/tests 03:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:58 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:27:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:27:59 INFO - Downloaded 1361 bytes. 03:27:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:27:59 INFO - Using the following test package requirements: 03:27:59 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:59 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:27:59 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:27:59 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'jsshell-linux-x86_64.zip'], 03:27:59 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:27:59 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:27:59 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:27:59 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:27:59 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:27:59 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:27:59 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:27:59 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:27:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:27:59 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:00 INFO - Downloaded 24496939 bytes. 03:28:00 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'] 03:28:00 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 03:28:01 INFO - Return code: 0 03:28:01 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 03:28:01 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')]} 03:28:01 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:02 INFO - Downloaded 24496939 bytes. 03:28:02 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'] 03:28:02 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 03:28:03 INFO - Return code: 0 03:28:03 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')]} 03:28:03 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:28:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:28:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:04 INFO - Downloaded 10833369 bytes. 03:28:04 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'] 03:28:04 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 03:28:04 INFO - Return code: 0 03:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:04 INFO - https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:28:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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 03:28:06 INFO - Downloaded 63648271 bytes. 03:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:06 INFO - mkdir: /builds/slave/test/properties 03:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:06 INFO - Contents: 03:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:28:06 INFO - Running post-action listener: _resource_record_post_action 03:28:06 INFO - Running post-action listener: set_extra_try_arguments 03:28:06 INFO - ##### 03:28:06 INFO - ##### Finished download-and-extract step (success) 03:28:06 INFO - ##### 03:28:06 INFO - ##### 03:28:06 INFO - ##### Running populate-webroot step. 03:28:06 INFO - ##### 03:28:06 INFO - Running pre-action listener: _resource_record_pre_action 03:28:06 INFO - Running main action method: populate_webroot 03:28:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:28:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:28:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:28:06 INFO - '--tppagecycles', 03:28:06 INFO - '7'], 03:28:06 INFO - 'tests': ['tsvgm']}}, 03:28:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:28:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:28:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['damp', 'tps']}, 03:28:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'tests': ['damp', 'tps']}, 03:28:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['dromaeo_dom']}, 03:28:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['a11yr', 03:28:06 INFO - 'ts_paint', 03:28:06 INFO - 'tpaint', 03:28:06 INFO - 'sessionrestore', 03:28:06 INFO - 'sessionrestore_no_auto_restore', 03:28:06 INFO - 'tabpaint']}, 03:28:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['tsvgx', 03:28:06 INFO - 'tsvgr_opacity', 03:28:06 INFO - 'tart', 03:28:06 INFO - 'tscrollx', 03:28:06 INFO - 'cart']}, 03:28:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:06 INFO - 'tsvgr_opacity', 03:28:06 INFO - 'tart', 03:28:06 INFO - 'tscrollx', 03:28:06 INFO - 'cart']}, 03:28:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'talos_options': ['--disable-e10s'], 03:28:06 INFO - 'tests': ['tp5o']}, 03:28:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'tests': ['tp5o']}, 03:28:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'talos_options': ['--disable-e10s', 03:28:06 INFO - '--xperf_path', 03:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:06 INFO - 'tests': ['tp5n']}, 03:28:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:28:06 INFO - 'talos_options': ['--xperf_path', 03:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:06 INFO - 'tests': ['tp5n']}}, 03:28:06 INFO - 'talos.zip': {'path': '', 03:28:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:28:06 INFO - Running post-action listener: _resource_record_post_action 03:28:06 INFO - ##### 03:28:06 INFO - ##### Finished populate-webroot step (success) 03:28:06 INFO - ##### 03:28:06 INFO - ##### 03:28:06 INFO - ##### Running create-virtualenv step. 03:28:06 INFO - ##### 03:28:06 INFO - Running pre-action listener: _resource_record_pre_action 03:28:06 INFO - Running main action method: create_virtualenv 03:28:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:06 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 03:28:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:06 INFO - Using real prefix '/usr' 03:28:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:09 INFO - Installing pip.................done. 03:28:09 INFO - Return code: 0 03:28:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:09 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')]} 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:09 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')]} 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:09 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:09 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 03:28:09 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 03:28:09 INFO - Using env: {'DISPLAY': ':0', 03:28:09 INFO - 'HOME': '/home/cltbld', 03:28:09 INFO - 'LANG': 'en_US.UTF-8', 03:28:09 INFO - 'LANGUAGE': 'en_US:en', 03:28:09 INFO - 'LOGNAME': 'cltbld', 03:28:09 INFO - 'MAIL': '/var/mail/cltbld', 03:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:09 INFO - 'MOZ_NO_REMOTE': '1', 03:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:09 INFO - 'NO_EM_RESTART': '1', 03:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:09 INFO - 'PWD': '/builds/slave/test', 03:28:09 INFO - 'SHELL': '/bin/bash', 03:28:09 INFO - 'SHLVL': '1', 03:28:09 INFO - 'TERM': 'linux', 03:28:09 INFO - 'TMOUT': '86400', 03:28:09 INFO - 'USER': 'cltbld', 03:28:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:09 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:09 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 03:28:09 INFO - Cleaning up... 03:28:09 INFO - Return code: 0 03:28:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:09 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')]} 03:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:09 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')]} 03:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:09 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:09 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 03:28:09 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 03:28:09 INFO - Using env: {'DISPLAY': ':0', 03:28:09 INFO - 'HOME': '/home/cltbld', 03:28:09 INFO - 'LANG': 'en_US.UTF-8', 03:28:09 INFO - 'LANGUAGE': 'en_US:en', 03:28:09 INFO - 'LOGNAME': 'cltbld', 03:28:09 INFO - 'MAIL': '/var/mail/cltbld', 03:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:09 INFO - 'MOZ_NO_REMOTE': '1', 03:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:09 INFO - 'NO_EM_RESTART': '1', 03:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:09 INFO - 'PWD': '/builds/slave/test', 03:28:09 INFO - 'SHELL': '/bin/bash', 03:28:09 INFO - 'SHLVL': '1', 03:28:09 INFO - 'TERM': 'linux', 03:28:09 INFO - 'TMOUT': '86400', 03:28:09 INFO - 'USER': 'cltbld', 03:28:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:09 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:09 INFO - Downloading/unpacking psutil>=3.1.1 03:28:09 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 03:28:09 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 03:28:09 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 03:28:09 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 03:28:09 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 03:28:09 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 03:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:11 INFO - Installing collected packages: psutil 03:28:11 INFO - Running setup.py install for psutil 03:28:11 INFO - building 'psutil._psutil_linux' extension 03:28:11 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 03:28:11 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 03:28:11 INFO - building 'psutil._psutil_posix' extension 03:28:11 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 03:28:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:12 INFO - Successfully installed psutil 03:28:12 INFO - Cleaning up... 03:28:12 INFO - Return code: 0 03:28:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:12 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:12 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 03:28:12 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 03:28:12 INFO - Using env: {'DISPLAY': ':0', 03:28:12 INFO - 'HOME': '/home/cltbld', 03:28:12 INFO - 'LANG': 'en_US.UTF-8', 03:28:12 INFO - 'LANGUAGE': 'en_US:en', 03:28:12 INFO - 'LOGNAME': 'cltbld', 03:28:12 INFO - 'MAIL': '/var/mail/cltbld', 03:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:12 INFO - 'MOZ_NO_REMOTE': '1', 03:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:12 INFO - 'NO_EM_RESTART': '1', 03:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:12 INFO - 'PWD': '/builds/slave/test', 03:28:12 INFO - 'SHELL': '/bin/bash', 03:28:12 INFO - 'SHLVL': '1', 03:28:12 INFO - 'TERM': 'linux', 03:28:12 INFO - 'TMOUT': '86400', 03:28:12 INFO - 'USER': 'cltbld', 03:28:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:12 INFO - '_': '/tools/buildbot/bin/python'} 03:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:12 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 03:28:12 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 03:28:12 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 03:28:12 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 03:28:12 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 03:28:12 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 03:28:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:28:14 INFO - Installing collected packages: mozsystemmonitor 03:28:14 INFO - Running setup.py install for mozsystemmonitor 03:28:14 INFO - Successfully installed mozsystemmonitor 03:28:14 INFO - Cleaning up... 03:28:14 INFO - Return code: 0 03:28:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:14 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:14 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 03:28:14 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 03:28:14 INFO - Using env: {'DISPLAY': ':0', 03:28:14 INFO - 'HOME': '/home/cltbld', 03:28:14 INFO - 'LANG': 'en_US.UTF-8', 03:28:14 INFO - 'LANGUAGE': 'en_US:en', 03:28:14 INFO - 'LOGNAME': 'cltbld', 03:28:14 INFO - 'MAIL': '/var/mail/cltbld', 03:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:14 INFO - 'MOZ_NO_REMOTE': '1', 03:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:14 INFO - 'NO_EM_RESTART': '1', 03:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:14 INFO - 'PWD': '/builds/slave/test', 03:28:14 INFO - 'SHELL': '/bin/bash', 03:28:14 INFO - 'SHLVL': '1', 03:28:14 INFO - 'TERM': 'linux', 03:28:14 INFO - 'TMOUT': '86400', 03:28:14 INFO - 'USER': 'cltbld', 03:28:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:14 INFO - '_': '/tools/buildbot/bin/python'} 03:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:28:14 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 03:28:14 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 03:28:14 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 03:28:14 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 03:28:14 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 03:28:14 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 03:28:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:28:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:28:16 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 03:28:16 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 03:28:16 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 03:28:16 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 03:28:16 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 03:28:16 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 03:28:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:28:16 INFO - warning: no files found matching '*.txt' 03:28:16 INFO - no previously-included directories found matching 'build' 03:28:16 INFO - no previously-included directories found matching 'dist' 03:28:16 INFO - no previously-included directories found matching '.git*' 03:28:16 INFO - Installing collected packages: jsonschema, functools32 03:28:16 INFO - Running setup.py install for functools32 03:28:16 INFO - warning: no files found matching '*.txt' 03:28:16 INFO - no previously-included directories found matching 'build' 03:28:16 INFO - no previously-included directories found matching 'dist' 03:28:16 INFO - no previously-included directories found matching '.git*' 03:28:16 INFO - Successfully installed jsonschema functools32 03:28:16 INFO - Cleaning up... 03:28:17 INFO - Return code: 0 03:28:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:17 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:17 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 03:28:17 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 03:28:17 INFO - Using env: {'DISPLAY': ':0', 03:28:17 INFO - 'HOME': '/home/cltbld', 03:28:17 INFO - 'LANG': 'en_US.UTF-8', 03:28:17 INFO - 'LANGUAGE': 'en_US:en', 03:28:17 INFO - 'LOGNAME': 'cltbld', 03:28:17 INFO - 'MAIL': '/var/mail/cltbld', 03:28:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:17 INFO - 'MOZ_NO_REMOTE': '1', 03:28:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:17 INFO - 'NO_EM_RESTART': '1', 03:28:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:17 INFO - 'PWD': '/builds/slave/test', 03:28:17 INFO - 'SHELL': '/bin/bash', 03:28:17 INFO - 'SHLVL': '1', 03:28:17 INFO - 'TERM': 'linux', 03:28:17 INFO - 'TMOUT': '86400', 03:28:17 INFO - 'USER': 'cltbld', 03:28:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:17 INFO - '_': '/tools/buildbot/bin/python'} 03:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:28:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:28:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:28:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 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 03:28:19 INFO - Downloading docopt-0.6.1.tar.gz 03:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:28:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:28:19 INFO - Running setup.py install for blobuploader 03:28:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:28:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:28:19 INFO - Running setup.py install for requests 03:28:20 INFO - Running setup.py install for docopt 03:28:20 INFO - Successfully installed blobuploader requests docopt 03:28:20 INFO - Cleaning up... 03:28:20 INFO - Return code: 0 03:28:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:20 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:20 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 03:28:20 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 03:28:20 INFO - Using env: {'DISPLAY': ':0', 03:28:20 INFO - 'HOME': '/home/cltbld', 03:28:20 INFO - 'LANG': 'en_US.UTF-8', 03:28:20 INFO - 'LANGUAGE': 'en_US:en', 03:28:20 INFO - 'LOGNAME': 'cltbld', 03:28:20 INFO - 'MAIL': '/var/mail/cltbld', 03:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:20 INFO - 'MOZ_NO_REMOTE': '1', 03:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:20 INFO - 'NO_EM_RESTART': '1', 03:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:20 INFO - 'PWD': '/builds/slave/test', 03:28:20 INFO - 'SHELL': '/bin/bash', 03:28:20 INFO - 'SHLVL': '1', 03:28:20 INFO - 'TERM': 'linux', 03:28:20 INFO - 'TMOUT': '86400', 03:28:20 INFO - 'USER': 'cltbld', 03:28:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:20 INFO - '_': '/tools/buildbot/bin/python'} 03:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:20 INFO - Running setup.py (path:/tmp/pip-A64VVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:20 INFO - Running setup.py (path:/tmp/pip-8hMg7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:20 INFO - Running setup.py (path:/tmp/pip-omzV0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:20 INFO - Running setup.py (path:/tmp/pip-WrfPFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:21 INFO - Running setup.py (path:/tmp/pip-h5zQ43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:21 INFO - Running setup.py (path:/tmp/pip-t_fhP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:21 INFO - Running setup.py (path:/tmp/pip-vbPr1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:21 INFO - Running setup.py (path:/tmp/pip-zU8Cdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:21 INFO - Running setup.py (path:/tmp/pip-F4wtRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:21 INFO - Running setup.py (path:/tmp/pip-UK666Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:21 INFO - Running setup.py (path:/tmp/pip-_xJ_bR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:21 INFO - Running setup.py (path:/tmp/pip-u_BUB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:21 INFO - Running setup.py (path:/tmp/pip-6TCdxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:21 INFO - Running setup.py (path:/tmp/pip-A125S_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:21 INFO - Running setup.py (path:/tmp/pip-e7b9VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:21 INFO - Running setup.py (path:/tmp/pip-_02vFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:21 INFO - Running setup.py (path:/tmp/pip-byYbNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:28:21 INFO - Running setup.py install for manifestparser 03:28:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for mozcrash 03:28:22 INFO - Running setup.py install for mozdebug 03:28:22 INFO - Running setup.py install for mozdevice 03:28:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for mozfile 03:28:22 INFO - Running setup.py install for mozhttpd 03:28:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for mozinfo 03:28:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for mozInstall 03:28:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for mozleak 03:28:22 INFO - Running setup.py install for mozlog 03:28:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:28:22 INFO - Running setup.py install for moznetwork 03:28:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Running setup.py install for mozprocess 03:28:23 INFO - Running setup.py install for mozprofile 03:28:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Running setup.py install for mozrunner 03:28:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Running setup.py install for mozscreenshot 03:28:23 INFO - Running setup.py install for moztest 03:28:23 INFO - Running setup.py install for mozversion 03:28:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:28:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:28:23 INFO - Cleaning up... 03:28:23 INFO - Return code: 0 03:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:23 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')]} 03:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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')]} 03:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:23 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:23 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 03:28:23 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 03:28:23 INFO - Using env: {'DISPLAY': ':0', 03:28:23 INFO - 'HOME': '/home/cltbld', 03:28:23 INFO - 'LANG': 'en_US.UTF-8', 03:28:23 INFO - 'LANGUAGE': 'en_US:en', 03:28:23 INFO - 'LOGNAME': 'cltbld', 03:28:23 INFO - 'MAIL': '/var/mail/cltbld', 03:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:23 INFO - 'MOZ_NO_REMOTE': '1', 03:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:23 INFO - 'NO_EM_RESTART': '1', 03:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:23 INFO - 'PWD': '/builds/slave/test', 03:28:23 INFO - 'SHELL': '/bin/bash', 03:28:23 INFO - 'SHLVL': '1', 03:28:23 INFO - 'TERM': 'linux', 03:28:23 INFO - 'TMOUT': '86400', 03:28:23 INFO - 'USER': 'cltbld', 03:28:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:23 INFO - '_': '/tools/buildbot/bin/python'} 03:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:28:23 INFO - Running setup.py (path:/tmp/pip-rYax8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:28:24 INFO - Running setup.py (path:/tmp/pip-ZyAAy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:28:24 INFO - Running setup.py (path:/tmp/pip-cyJAIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:28:24 INFO - Running setup.py (path:/tmp/pip-_nZ85q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:28:24 INFO - Running setup.py (path:/tmp/pip-pcIhFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:28:24 INFO - Running setup.py (path:/tmp/pip-PJTTFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:28:24 INFO - Running setup.py (path:/tmp/pip-OuCNhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:28:24 INFO - Running setup.py (path:/tmp/pip-yhK_y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:28:24 INFO - Running setup.py (path:/tmp/pip-TJGuVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:28:24 INFO - Running setup.py (path:/tmp/pip-3HqajS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:28:24 INFO - Running setup.py (path:/tmp/pip-U0Mxnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:28:24 INFO - Running setup.py (path:/tmp/pip-QcTFDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:28:24 INFO - Running setup.py (path:/tmp/pip-TJTxXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:28:24 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:28:24 INFO - Running setup.py (path:/tmp/pip-SOn2zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:28:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 03:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:24 INFO - Running setup.py (path:/tmp/pip-WzKZTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:25 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)) 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:25 INFO - Running setup.py (path:/tmp/pip-prnZX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:25 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)) 03:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:25 INFO - Running setup.py (path:/tmp/pip-oYFvaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:25 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)) 03:28:25 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)) 03:28:25 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)) 03:28:25 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)) 03:28:25 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)) 03:28:25 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)) 03:28:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:25 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 03:28:27 INFO - Downloading blessings-1.6.tar.gz 03:28:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:27 INFO - Installing collected packages: blessings 03:28:27 INFO - Running setup.py install for blessings 03:28:27 INFO - Successfully installed blessings 03:28:27 INFO - Cleaning up... 03:28:27 INFO - Return code: 0 03:28:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:27 INFO - Reading from file tmpfile_stdout 03:28:27 INFO - Current package versions: 03:28:27 INFO - argparse == 1.2.1 03:28:27 INFO - blessings == 1.6 03:28:27 INFO - blobuploader == 1.2.4 03:28:27 INFO - docopt == 0.6.1 03:28:27 INFO - functools32 == 3.2.3-2 03:28:27 INFO - jsonschema == 2.5.1 03:28:27 INFO - manifestparser == 1.1 03:28:27 INFO - mozInstall == 1.12 03:28:27 INFO - mozcrash == 0.17 03:28:27 INFO - mozdebug == 0.1 03:28:27 INFO - mozdevice == 0.48 03:28:27 INFO - mozfile == 1.2 03:28:27 INFO - mozhttpd == 0.7 03:28:27 INFO - mozinfo == 0.9 03:28:27 INFO - mozleak == 0.1 03:28:27 INFO - mozlog == 3.2 03:28:27 INFO - moznetwork == 0.27 03:28:27 INFO - mozprocess == 0.23 03:28:27 INFO - mozprofile == 0.28 03:28:27 INFO - mozrunner == 6.12 03:28:27 INFO - mozscreenshot == 0.1 03:28:27 INFO - mozsystemmonitor == 0.3 03:28:27 INFO - moztest == 0.7 03:28:27 INFO - mozversion == 1.4 03:28:27 INFO - psutil == 3.1.1 03:28:27 INFO - requests == 1.2.3 03:28:27 INFO - wsgiref == 0.1.2 03:28:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:27 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:27 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 03:28:27 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 03:28:27 INFO - Using env: {'DISPLAY': ':0', 03:28:27 INFO - 'HOME': '/home/cltbld', 03:28:27 INFO - 'LANG': 'en_US.UTF-8', 03:28:27 INFO - 'LANGUAGE': 'en_US:en', 03:28:27 INFO - 'LOGNAME': 'cltbld', 03:28:27 INFO - 'MAIL': '/var/mail/cltbld', 03:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:27 INFO - 'MOZ_NO_REMOTE': '1', 03:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:27 INFO - 'NO_EM_RESTART': '1', 03:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:27 INFO - 'PWD': '/builds/slave/test', 03:28:27 INFO - 'SHELL': '/bin/bash', 03:28:27 INFO - 'SHLVL': '1', 03:28:27 INFO - 'TERM': 'linux', 03:28:27 INFO - 'TMOUT': '86400', 03:28:27 INFO - 'USER': 'cltbld', 03:28:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:27 INFO - '_': '/tools/buildbot/bin/python'} 03:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 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)) 03:28:27 INFO - Cleaning up... 03:28:27 INFO - Return code: 0 03:28:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28: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')]} 03:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28: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')]} 03:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:27 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 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:27 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 03:28:27 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 03:28:27 INFO - Using env: {'DISPLAY': ':0', 03:28:27 INFO - 'HOME': '/home/cltbld', 03:28:27 INFO - 'LANG': 'en_US.UTF-8', 03:28:27 INFO - 'LANGUAGE': 'en_US:en', 03:28:27 INFO - 'LOGNAME': 'cltbld', 03:28:27 INFO - 'MAIL': '/var/mail/cltbld', 03:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:27 INFO - 'MOZ_NO_REMOTE': '1', 03:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:27 INFO - 'NO_EM_RESTART': '1', 03:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:27 INFO - 'PWD': '/builds/slave/test', 03:28:27 INFO - 'SHELL': '/bin/bash', 03:28:27 INFO - 'SHLVL': '1', 03:28:27 INFO - 'TERM': 'linux', 03:28:27 INFO - 'TMOUT': '86400', 03:28:27 INFO - 'USER': 'cltbld', 03:28:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:27 INFO - '_': '/tools/buildbot/bin/python'} 03:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:27 INFO - Cleaning up... 03:28:28 INFO - Return code: 0 03:28:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:28:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83da79cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f91350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, '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': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', '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 03:28:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:28:28 INFO - Using env: {'DISPLAY': ':0', 03:28:28 INFO - 'HOME': '/home/cltbld', 03:28:28 INFO - 'LANG': 'en_US.UTF-8', 03:28:28 INFO - 'LANGUAGE': 'en_US:en', 03:28:28 INFO - 'LOGNAME': 'cltbld', 03:28:28 INFO - 'MAIL': '/var/mail/cltbld', 03:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:28 INFO - 'MOZ_NO_REMOTE': '1', 03:28:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:28 INFO - 'NO_EM_RESTART': '1', 03:28:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:28 INFO - 'PWD': '/builds/slave/test', 03:28:28 INFO - 'SHELL': '/bin/bash', 03:28:28 INFO - 'SHLVL': '1', 03:28:28 INFO - 'TERM': 'linux', 03:28:28 INFO - 'TMOUT': '86400', 03:28:28 INFO - 'USER': 'cltbld', 03:28:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:28 INFO - '_': '/tools/buildbot/bin/python'} 03:28:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:28 INFO - Downloading/unpacking flake8 03:28:28 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 03:28:28 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 03:28:28 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 03:28:28 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 03:28:28 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 03:28:28 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 03:28:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:28:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:28:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 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 03:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:28:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:30 INFO - no previously-included directories found matching 'docs/_build' 03:28:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:28:30 INFO - Running setup.py install for pep8 03:28:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:28:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:28:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:28:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:28:30 INFO - no previously-included directories found matching 'docs/_build' 03:28:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:28:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:28:31 INFO - Cleaning up... 03:28:31 INFO - Return code: 0 03:28:31 INFO - Running post-action listener: _resource_record_post_action 03:28:31 INFO - Running post-action listener: _start_resource_monitoring 03:28:31 INFO - Starting resource monitoring. 03:28:31 INFO - ##### 03:28:31 INFO - ##### Finished create-virtualenv step (success) 03:28:31 INFO - ##### 03:28:31 INFO - ##### 03:28:31 INFO - ##### Running install step. 03:28:31 INFO - ##### 03:28:31 INFO - Running pre-action listener: _resource_record_pre_action 03:28:31 INFO - Running main action method: install 03:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:31 INFO - Reading from file tmpfile_stdout 03:28:31 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:31 INFO - Reading from file tmpfile_stdout 03:28:31 INFO - Output received: 03:28:31 INFO - Usage: mozinstall [options] installer 03:28:31 INFO - Options: 03:28:31 INFO - -h, --help show this help message and exit 03:28:31 INFO - -d DEST, --destination=DEST 03:28:31 INFO - Directory to install application into. [default: 03:28:31 INFO - "/builds/slave/test"] 03:28:31 INFO - --app=APP Application being installed. [default: firefox] 03:28:31 INFO - mkdir: /builds/slave/test/build/application 03:28:31 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'] 03:28:31 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 03:28:47 INFO - Reading from file tmpfile_stdout 03:28:47 INFO - Output received: 03:28:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:47 INFO - Running post-action listener: _resource_record_post_action 03:28:47 INFO - ##### 03:28:47 INFO - ##### Finished install step (success) 03:28:47 INFO - ##### 03:28:47 INFO - ##### 03:28:47 INFO - ##### Running run-tests step. 03:28:47 INFO - ##### 03:28:47 INFO - Running pre-action listener: _resource_record_pre_action 03:28:47 INFO - Running main action method: run_tests 03:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:47 INFO - Python 2.7.3 03:28:47 INFO - Return code: 0 03:28:47 INFO - grabbing minidump binary from tooltool 03:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:47 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 0x20201c0>, '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 0x20210c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2021550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:47 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 03:28:47 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 03:28:47 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 03:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:47 INFO - Return code: 0 03:28:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:28:48 INFO - Return code: 0 03:28:48 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:28:48 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 03:28:48 INFO - Using env: {'DISPLAY': ':0', 03:28:48 INFO - 'HOME': '/home/cltbld', 03:28:48 INFO - 'LANG': 'en_US.UTF-8', 03:28:48 INFO - 'LANGUAGE': 'en_US:en', 03:28:48 INFO - 'LOGNAME': 'cltbld', 03:28:48 INFO - 'MAIL': '/var/mail/cltbld', 03:28:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:48 INFO - 'MOZ_NO_REMOTE': '1', 03:28:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:48 INFO - 'NO_EM_RESTART': '1', 03:28:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:48 INFO - 'PWD': '/builds/slave/test', 03:28:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:48 INFO - 'SHELL': '/bin/bash', 03:28:48 INFO - 'SHLVL': '1', 03:28:48 INFO - 'TERM': 'linux', 03:28:48 INFO - 'TMOUT': '86400', 03:28:48 INFO - 'USER': 'cltbld', 03:28:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106', 03:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:48 INFO - '_': '/tools/buildbot/bin/python'} 03:28:48 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/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:28:48 INFO - mozversion application_buildid: 20160729170826 03:28:48 INFO - mozversion application_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:28:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:28:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:48 INFO - mozversion application_name: Firefox 03:28:48 INFO - mozversion application_remotingname: firefox-dev 03:28:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:48 INFO - mozversion application_vendor: Mozilla 03:28:48 INFO - mozversion application_version: 49.0a2 03:28:48 INFO - mozversion platform_buildid: 20160729170826 03:28:48 INFO - mozversion platform_changeset: 589e1f984537e280ff84591e94afdc3c5bfe2710 03:28:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:28:48 INFO - mozversion platform_version: 49.0a2 03:28:48 INFO - using testdate: 1469874528 03:28:48 INFO - actual date: 1469874528 03:28:48 INFO - starting webserver on 'localhost:32962' 03:28:48 INFO - SUITE-START | Running 2 tests 03:28:48 INFO - TEST-START | dromaeo_css 03:28:48 INFO - operating with platform_type : linux_ 03:28:48 INFO - Initialising browser for dromaeo_css test... 03:28:48 INFO - TEST-INFO | started process 32198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCUqv9/profile http://localhost:32962/getInfo.html) 03:28:53 INFO - PROCESS | 32198 | __metrics Screen width/height:1600/1200 03:28:53 INFO - PROCESS | 32198 | colorDepth:24 03:28:53 INFO - PROCESS | 32198 | Browser inner width/height: 1024/697 03:28:53 INFO - PROCESS | 32198 | __metrics 03:28:54 ERROR - PROCESS | 32198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:28:55 INFO - TEST-INFO | 32198: exit 0 03:28:55 INFO - Browser initialized. 03:28:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:55 INFO - TEST-INFO | started process 32328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeCUqv9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:06 INFO - PROCESS | 32328 | RSS: Main: 156082176 03:29:06 INFO - PROCESS | 32328 | 03:29:56 INFO - PROCESS | 32328 | 1469874596568 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] 03:32:04 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32962/tests/dromaeo/cssquery-ext.html) 03:32:05 INFO - PROCESS | 32328 | RSS: Main: 160088064 03:32:05 INFO - PROCESS | 32328 | 03:35:07 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-ext.html (next: http://localhost:32962/tests/dromaeo/cssquery-jquery.html) 03:35:07 INFO - PROCESS | 32328 | RSS: Main: 157986816 03:35:07 INFO - PROCESS | 32328 | 03:38:09 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32962/tests/dromaeo/cssquery-mootools.html) 03:38:10 INFO - PROCESS | 32328 | RSS: Main: 157405184 03:38:10 INFO - PROCESS | 32328 | 03:41:12 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32962/tests/dromaeo/cssquery-prototype.html) 03:41:12 INFO - PROCESS | 32328 | RSS: Main: 157036544 03:41:12 INFO - PROCESS | 32328 | 03:44:15 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32962/tests/dromaeo/cssquery-yui.html) 03:44:15 INFO - PROCESS | 32328 | RSS: Main: 158674944 03:44:15 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | Cycle 1(1): loaded http://localhost:32962/tests/dromaeo/cssquery-yui.html (next: http://localhost:32962/tests/dromaeo/cssquery-dojo.html) 03:47:18 INFO - PROCESS | 32328 | RSS: Main: 159617024 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | __start_tp_report 03:47:18 INFO - PROCESS | 32328 | _x_x_mozilla_page_load 03:47:18 INFO - PROCESS | 32328 | _x_x_mozilla_page_load_details 03:47:18 INFO - PROCESS | 32328 | |i|pagename|runs| 03:47:18 INFO - PROCESS | 32328 | |0;dojo.html;3357.0768038789333;3395.7792743471687;3399.4051041067814;3430.6054803697584;3431.691147796698;5588.24558684578;5650.773969041234;5674.063779476387;5692.260006199199;5735.283089613798;5688.800891968782;5718.685472299022;5745.425457454253;5752.769889204426;5768.192453056576;5132.153194722866;5181.274621552986;5222.9477705223035;5240;5272.209168624699;5089.160288552384;5091.109055915219;5264.921026184591;5265.947340526584;5277.762500687459;5119.744012799364;5120.129577971754;5132.846014619548;5153.2785410042625;5201.661891977028;5136.255242989764;5219.634625576211;5242.8689282767855;5253.317068781034;5278.868028299285;5021.196608542652;5104.540591346797;5171.120909445403;5219.060569097561;5234.7644356004075;5451.918221226685;5496.615236933376;5503.6147469677135;5513.641613295163;5574.386817450078;6047.727852246616;6065.120557519179;6086.147939288503;6087.634741915455;6095.603785753956;5869.7652093916195;5987.6108052976415;6113.205283313186;6121.143039974407;6125.387461253884;5622.072358060915;5666.12175112854;5685.204071429962;5694;5719.799807006776;6127.754889804447;6129.724162412702;6156.630602163885;6159.5688301818445;6170;5794.159846822187;5886.676232807236;5886.764529418861;5947.613405128653;5951.880962380728;6068.33248342682;6068.575199736064;6075.392460753889;6077.088436734437;6113.602615829956;5973.163757074013;5978.730957106941;6018.307894592091;6019;6058.030715085565;5803.564732645069;5985.551083668743;6050.273967123973;6054.969725151346;6087.147799308101;4598.126355992351;4613.8846528836375;4624.884377890512;4650.953490465052;4654.674172807939;4129.359949207877;4176.33178691414;4179.686523510749;4183.707140500197;4200.85297014603;5696.686682232517;5749.051406517878;5763.682997435098;5817;5848.590598658053;5984.551158663031;6039.486643635252;6059.60612560191;6110.205673262448;6135.693215339215;5714.914276285859;5843.912341314884;5845.240118784531;5858.560607954335;5862.355140934494;5131.820386286462;5157.871053223699;5165.715885626327;5209.739513024334;5235.083860324428;6380.170577824946;6388.872222555616;6423.775167869102;6428.228612566522;6446.967765161145;5884.735186916513;6045.395460454095;6185.288691800501;6185.659788711574;6205.875882482234;6208.720607572761;6335.176427064452;6363.840903977252;6369.235691716838;6384.042393640805;6004.87990240184;6056.242969628796;6059.969700151471;6068.484178844671;6085.178500902499;5972.522198224045;5984.461398474158;6009.489193418608;6159.630422174684;6160.722767475564;5935.881282374242;5949.0481522956115;5951.940480595312;5956;5983.880322393615;5789.247397838254;5853.1805547222575;5853.678047707417;5923;5923.318818335946;5677.687727175045;5712.228849105318;5727.541796656341;5784.942150578609;5805.042168042226;5948.851278718067;5954.880902382015;5967.731452084753;5975.37258587842;6007.729652165575;5823.592348535732;5842.152887831326;5844.707764611838;5856;5859.648421094748 03:47:18 INFO - PROCESS | 32328 | |1;ext.html;588.6909372579395;636.1634450697336;639.8624295776407;654.7741029344876;685.2975699907596;34905.30189396214;38181.80909095454;46267.76866115673;47339.52660473394;47829.28256076153;47081.76459117708;47336.289955650696;47662.0467590648;47759.76120119403;47790.761046194806;9056.547172641374;9184.448933064004;9193.540322983858;9232.261419086457;9243.768905777342;9055.59249833759;9134.406263592879;9149.862752058725;9155.633774649039;9158.542072896362;9132.178103970642;9163.862542061874;9188.1730644242;9204.861927071099;9215.677451289206;9061.365704400727;9147.771305717377;9189.035151309083;9200.585973631203;9210.631574737035;9003.324750643727;9066.727998160066;9069.455832650063;9100.63597456101;9101.226395756303;44300.556994430284;44495;44560.55439445596;44647.33029004568;44828;3698.519192504984;3890.610938906115;3964.405339199114;4306.590873866978;4677.532246775295;33812;34236.14409639754;34589.481157782655;34619.65380346215;35526.467102993214;4694.779357367075;4747.928781068253;4761.2382018876815;4772.069446457942;4818.759062046884;380902;384555;386598;387664.0616796926;387775;58975;59793.402065978786;59856;64734;64923;40248.19503609911;41494.79252603718;41763;68444.6577767108;68622.31377686259;18154.092295385177;18160.091995400177;18254.36109736153;18308;18363.72454413185;14469.276536173149;14515.85484145166;14586.41654333836;14650.267486625626;14667.193304368362;21302.147914083263;21556.89221553882;21576;21589.676154857374;21700.45748856291;7709.498882572615;7841.882371764428;7861.646225919733;7868;7979.640916158787;1041.5313109100935;1052.768390953989;1134.0927258193576;1148.2708480115186;1183.893449589524;29977.400451990838;31911.202219944687;32649.673503265138;32662.997565596583;32853.17867053343;1170.6488053583892;1199.1845545029464;1229.3238718704856;1250.3435696259537;1276.9808452873215;17039.829601704074;17089.48731538056;17152.742708859376;17165.227564759614;17429.65140697179;610824;666393;668652;688203;867132;63043.36956630375;63491;63571.36428635747;64007.35992640107;64468.67765661235;1460.1239256446047;1484.480431848866;1486.5466032860081;1491.4332553629552;1510.3870304373495;32598;33043.66956330502;33211.335773283914;33424;33435;53849.73075134599;54982.45017549933;55125;55143.72428137834;55245.723771380886;519170;522128;522325;522669;524797;29346.55980160342;29397;29432.411351772418;30327.393452130393;30708.385832283675;51703.48296516987;51761.22358164706;51821.22268166056;52238.47761522488;52931;42879;43088.35367469428;43275.567244327154;44143;44418.111637766415;42788.35817462678;43186.78406607947;43479;44245.778771105935;44660.10679786321;42778.786106069274;43723.34414983841;43739.12521749611;43791.56208437875;44008.559914401725;37221.25557488889;37343.43984840284;37587.62412375951;38029.239415210985;38976.415353769145;29086.418271634873;29764.51368689471;30135.547966780076;30175.69824301729;30394.696053040072 03:47:18 INFO - PROCESS | 32328 | |2;jquery.html;413.6504653567734;422.72734086514197;426.5201648145836;428.7706077248671;435.68630585978104;19047.619047619057;19275.421737347886;19934.50163745907;20700.689489657667;20801;12884;17934.74456788022;18412.44762657119;19366.12852421641;19395.321163759272;5123.385193776752;5270.894582108355;5281.656692315007;5291.6031297652635;5309.442508536606;5129.512696293846;5242.239875218091;5256.185291279858;5419.729013549327;5423.484768946963;5348.3849357323825;5373.865653358678;5419.376771671249;5431.321084864392;5451.48210919962;5339.092354299759;5376.973115134439;5385.057614917393;5747.051736463479;5751.367349591542;5512;5631.577631677641;5640.492355687967;5669.9433005669825;5845.912311315291;14147.717045659132;14432.855671443362;14573.562793116223;14591.70816583673;20763.273285434938;2255.3387003336056;2383.4398916254668;2539.898404063835;2639.4721055788727;2644.1803041057333;10580.78838423235;10705.036546710833;10869.130469562417;12342.259464432163;13804.585862424143;1988.8408927285927;2046.5395286060666;2051.784562620918;2072.057213967641;2112.4824418017683;80508.99999999942;81094.18905810984;81372.59313703454;81420.59289703514;81574.18425815785;10981.670549883356;11382.373969431761;11581.652550423501;11585.536578536932;11733.589324373606;12888.61334159958;16210.594735131715;16228.837711622733;16242.350305987628;16277.104759238355;7680.731174408869;8042.437029407885;8158.347332213409;8194.262516373556;8348;8114.797130071795;8188.303994160563;8228.588570571448;8351.415400921876;8446.239838414573;4276.2302785498905;4311.805968731414;4320.401451462979;4326.913461730748;4416.734995900256;1966.5575245569632;1974.8025197480138;1986.8708533945248;2002.9799702002792;2040.6224848403092;1021.9897801022043;1082.2370228988543;1084.6474895658941;1104.9613263535898;1112.0436424674774;17316.65366692659;18060.54848628795;19146.329878454188;19268.132934018002;19507.51231219231;1009.258195226508;1024.513356155835;1040.9167266618651;1043.2488608202234;1050.165118730611;10525.36847789135;10890.128789696806;10937.851525589858;10941.781164376827;10946.343219406861;537458;538004;542061;552733;555822;94194;96011;96364;97413;97471.51264243634;1029.325791606499;1030.3714734012246;1043.994780026095;1051.5373235776235;1051.9684409467727;16767.91616041912;17200.569985749957;17377.21802518915;17784.73322900132;17822.19800109024;36574.817125914204;38913.610863891;40521.392179116745;42583.50957716465;45002;51192;52100.47899521108;54767.45232547783;59912.70043649754;60236;8222.876656850272;8481.745547633582;8543.273821724973;8557.058723540282;8671.956640216758;9328.440293582407;12994.80507792365;13266.403011864682;13290.800637990245;13322.600321990356;5737.827865164052;8837;11429.45702330208;11594.826077608674;11720;10480.737981550523;11166.553337866395;11480.483378248166;11480.655580332603;11740.471678774305;11623.186376953532;11667.241629294069;11682.415879205835;11724.70688232801;11749.88250117488;7527.585982771;7879.684812607432;8150.9184908150155;8742.956285218534;8799.824003520022;8613.784655383666;10943;11842.703932401759;11966.401679916144;12163.81754273669 03:47:18 INFO - PROCESS | 32328 | |3;mootools.html;1277.78916478781;1416.6600015996157;1420.247268947458;1680.4118558504524;1692.8984260944337;8392.454490458116;9037.367384283103;9172.082791720824;9793.06965838246;9795.265355098369;9089.091090890908;9428.05719428057;9499.477528735917;9505.19205867502;9512.524373781318;2437.987810060947;2469.09877894569;2486.627005949113;2488.35302821266;2493.4140476987895;2383.9880800595975;2446.926592202237;2452.31335226137;2455.2143314139485;2457.0540341968294;2437.2688193541867;2461.8276720629565;2501.862397568133;2508.924732258035;2511.535365957304;2357.4577847095265;2384.117876385731;2414.3481260059775;2426.4055306449854;2427.9393015174587;2391.2228525729206;2407.65089062085;2408.5664580375524;2413.4690368118986;2414.5170965806733;9333.766655833591;9405.623775048989;9411.670591529331;9425.670101546482;9478.146966772954;5412.296401467824;5548.389677135512;5573.052581061229;5581.190727344553;5584.832455026356;3452.9654703453148;3479.1650003998857;3552.1119720069983;3579.7315201359743;3585.8744943926836;1041.4063983529315;1069.8288273876142;1081.9350838949688;1157.0916830288268;1168.0830548019849;13318.600441986757;13327.133736307205;13327.73344533104;13336.599902002858;13342.666433339147;4655.11552804966;4736.455307639597;4813.542713442287;4822.614190864722;4840.75796210188;11210.103191744642;11228.101751859831;11240.662780116609;11243.775124497464;11272.041876440595;5480.479354461319;5501.779928802803;5509.8071567495745;5520.420355862657;5562.554995600423;4387.473503179639;4854.101991131652;5031.723255220998;5079.542841144241;5095.541401273903;4227.492700875914;4323.329883868006;4429.9778501107285;4439.156560253606;4451.866444006685;1356.7625665508497;1365.6790654196257;1385.7228554289181;1390.610629023875;1414.299921538845;1088.6625146204701;1098.9340639561651;1111.0778054214982;1130.7851508213578;1138.8576427946507;6419.101325814389;6449.645269510128;6551.541392102602;6614.10709554204;6645.501587380966;408.78334482724205;410.5299432150171;413.0726518964943;415.10958992959934;418.87643145272216;4418.558144185556;4607.424071991001;4612.630989520897;4613.123506533748;4623.190941585209;11501.654950351503;11545.653630391102;11929.880701193051;12055.095867809774;12072.517099315928;11773.52905883755;11814.586489472827;11899.286042837457;11998.940005299917;11999.820002699966;8987.55062246885;9004.144606262395;9033.141851524095;9089.81820363589;9092.545372731469;6435.22777266731;6491.091247225487;6491.642959637076;6495.0906873036865;6529.118568993315;10711.716751918246;10794.406307653155;10897.891021090005;11003.33979961205;11102.833457498306;10987.39569323695;11058.723531911766;11123.721906952067;11230.270032448192;11308.604198853001;7584.4311676625575;8080.353571714131;8362.247397734232;8524.104968978168;8588.65645374203;9218.308626853148;9285.257179425495;9287.303452240974;9389.06109389083;9395.624175033196;8214.507129572245;8394.790130246793;8395.83208335842;8454.788630284293;8515;7560.735374261874;7758.185390533913;7820.296173344426;7928.920710793049;8037.959810200911;7172.282771722786;7231.349178573953;7248.166460856858;7252.948322493104;7298.489105762758;5411.188321751769;5428;5460.099083651153;5464.371597266365;5464.426235245242;5364.597655175799;5513.558915286848;5564.304461942257;5687.260656114679;5835.153902684172 03:47:18 INFO - PROCESS | 32328 | |4;prototype.html;307.8014680531056;321.8760777100816;336.51877814724946;337.84965690267825;343.1404332147968;5507.83299602728;5610.579206559504;5695.914561281579;5725.885482290357;5754.913676294854;5500.45987123606;5559.388467268597;5566.944330556693;5625.931073096109;5649.322081350233;4361.956380436187;4379.255526560476;4421.6683748718815;4443.22243607369;4443.955670417449;4214.97892510537;4408.42690450241;4440.313610265791;4449.199144154051;4461.553844615545;4395.318725597522;4410.353787727354;4411.889702757425;4434.68957172998;4446.710963787344;4423.690341676068;4454.443194600675;4458.375827384169;4513.187626227278;4522.095580883836;3706.4440333950124;3919.510061242345;4000.5199376075057;4014.979925100385;4022.658074063708;5454.836354909359;5457.154141108134;5465.371482279509;5493.148561972861;5496.422875598045;5091.919388769815;5102.9489705103215;5110.594586488708;5111.207762796773;5111.488851114896;5636.239107720447;5914.781956766213;5929.14027466015;5929.466348028698;5980.372060933583;4308.4399028126145;4320.191875281061;4338.717983331074;4356.324769660708;4359.782010899442;6181.165542651775;6202.3797620238065;6214.65819379934;6222.191115155001;6225.470834979033;4363.19280933022;4427.5351088135285;4431.33529970507;4432.3351497275025;4434.467863856358;4502.16709908668;4505.954940450553;4515.954840451619;4525.796339164745;4537.478190008125;5036.798528058836;5047.4447810740785;5076.873078173076;5100.285959965608;5101.591872650179;5707.914381284284;5763.87604417143;5940.108983652401;5975;5984.1921340618455;1536.2549163655617;1544.1352842408287;1553.2777258574818;1559.2125976381853;1566.2795114247347;968.5786682792867;980.5881529757519;981.699248495746;983.1692220074026;998.5356809083811;5089.109405853961;5136.640435169502;5160.638755287094;5169.663971841818;5221.399539052982;5377.870647164139;5470.316210473691;5486.91769623456;5511.3937466878615;5540.252065971123;5023.824166154167;5148.433672296044;5172;5178.249153872667;5181.4300426953005;2910.563415487694;2931.457680329146;2950.3066779306846;2952.9114126576237;2958.319586495118;5599.496045355938;5635.971820140873;5668.072855229159;5679.432056794288;5721.656700597978;5251.396089449686;5495.2856128703015;5499.890002199933;5513.8345849624575;5567.464659940967;5541.33503979517;5594.888102237933;5623.915641265385;5671.100181439181;5740.339860915965;5004.874878128076;5313.946860531345;5377.327834020747;5385.461453854583;5429.67421954684;5303.605692356972;5326;5364.2490051393615;5383.569314454912;5393.865153371197;5505.697186654773;5552.7223638818705;5592.245046918614;5623.88752224945;5639.88720225585;3855.978165786125;3959.6238357356006;3994.8202330894596;4025.745582473707;4048.8785336439955;5387.784488620411;5447.237386765777;5490.282310256449;5935.347111817783;6173.783917562864;6013.9699301503215;6019.458248757633;6025.367336429612;6053.394660534088;6137.539684523589;5925.733341999534;5961.493273071664;5963.552733544915;6008.24896887889;6027.035674292092;5875.618084824473;5903.793367232126;5929.673867937305;5943.346231914573;5949.940500595112;6018.4884284834525;6058.878822423439;6071.908921366095;6085.391460853879;6087.330393656783;5794.348610645946;5813.505852002627;5871.706414679335;5950.910736339045;5954.553408494467 03:47:18 INFO - PROCESS | 32328 | |5;yui.html;775.7246177606946;779.543966779434;794.7562065367699;868.1101870582654;872.6422166911566;15711.607209819746;16022.75965860513;16686.58283542912;16775.91612041938;16822.411215607455;17357.47927562175;17568.29726810926;17571.824281757177;17575.29698812046;17585.82414175861;710.7405796884152;882.7925437522193;888.5557221389305;891.888513935758;894.4990805149105;838.2455789789177;876.837785009772;882.7969566999594;886.8847049883539;888.9288856891433;931.2503434735036;932.5570354081825;936.3539157981005;938.6620816506053;940.8588711693267;924.3899026642383;929.9814003719922;933.3140141995627;933.8879334479872;935.4060171790894;683.4942142814282;683.733343995842;684.1174884399119;685.3146853146853;686.6978529447027;15905.522834314874;16114.355425782955;16140.112293823835;16153.515394538183;16209.270582823801;15739.763903541456;16079.276432560562;16564.171791410383;16571.751423728652;16909.492715218563;13264.73470530584;13355.599332020054;13392.397342119531;13440.86559134406;13550.186988780606;4242.681798865066;4264.701470897038;4331.112122014979;4365.170617582649;4373.518912919576;67239.31901702448;69162;69901.65049174773;70117;78822;12864.549740759216;12920.612381628565;13129.671758206121;13155.210687358789;13625.114367566077;22418.887905560696;24244.87877560636;24577.262682119566;24723.505529889662;24766.87616561942;9527.52362381878;9730.756731081638;9731.318807683394;9759.219262458986;9786.41281523111;5211.713355765393;5221.295125158131;5406.972965135149;5436.972815135978;5441.83674489766;3702.3705969985167;3851.345271303885;3912.921741565153;4066.7763273019677;4108.404281379183;708.0512113767576;724.2323137474294;726.4370113162341;729.1869565434608;736.0725485887713;682.2290811383106;816.1185919207242;827.8054657155564;838.4382463749303;854.0605334132529;10995.670129896116;11241.943790280997;11292.604758833402;11396.829047564293;11435.14236432271;764.9464537482323;813.2655282268395;839.2940406154779;848.3722045686147;869.2090197919989;5406.135018397038;5482.506574408243;5568.582356323292;5627.323650423867;5630.352509461382;108683;129578.35210823886;129945;130142.34928825295;132185;110844;111694.44152779185;112775;113231;114951.42524287324;97923;99106;99106.5044674772;101875;102008;10119.848202276824;10212.642557510451;10295.330803497749;10421;10437.11284540792;53227.733861331995;56245.43754562402;56524.7173764145;56616;58348.83302333845;74634.62682686551;83669;84499.5775021121;84544.57727711322;86802.1319786794;12463.189892656948;12776.74446511046;12827.294498802283;14643;14813.333399997242;15969;16169;16252.756208656643;16302.755458667893;16325.510234692978;14233.217173055582;15074.397024118913;15213.315400806769;15332.463363782213;15487.767683484532;14444.277786110863;14672.97289189789;14764.90100703588;14964.700705985602;15552.533423997298;14898.77651835245;15000.174990375634;15070.924645376703;15615.453459128876;15644.374225031326;10966.561337546409;11056;11138.832917506406;11205.943970280423;11338.14963877696;12133.393330333625;12290.262584244974;12302.0773441994;12560.811587826372;12764.361781911053 03:47:18 INFO - PROCESS | 32328 | __end_tp_report 03:47:18 INFO - PROCESS | 32328 | __start_cc_report 03:47:18 INFO - PROCESS | 32328 | _x_x_mozilla_cycle_collect,334 03:47:18 INFO - PROCESS | 32328 | __end_cc_report 03:47:18 INFO - PROCESS | 32328 | __startTimestamp1469875638425__endTimestamp 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | ------- Summary: start ------- 03:47:18 INFO - PROCESS | 32328 | Number of tests: 6 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#0] dojo.html Cycles:165 Average:5641.16 Median:5845.24 stddev:626.34 (10.7%) stddev-sans-first:602.09 03:47:18 INFO - PROCESS | 32328 | Values: 3357.1 3395.8 3399.4 3430.6 3431.7 5588.2 5650.8 5674.1 5692.3 5735.3 5688.8 5718.7 5745.4 5752.8 5768.2 5132.2 5181.3 5222.9 5240.0 5272.2 5089.2 5091.1 5264.9 5265.9 5277.8 5119.7 5120.1 5132.8 5153.3 5201.7 5136.3 5219.6 5242.9 5253.3 5278.9 5021.2 5104.5 5171.1 5219.1 5234.8 5451.9 5496.6 5503.6 5513.6 5574.4 6047.7 6065.1 6086.1 6087.6 6095.6 5869.8 5987.6 6113.2 6121.1 6125.4 5622.1 5666.1 5685.2 5694.0 5719.8 6127.8 6129.7 6156.6 6159.6 6170.0 5794.2 5886.7 5886.8 5947.6 5951.9 6068.3 6068.6 6075.4 6077.1 6113.6 5973.2 5978.7 6018.3 6019.0 6058.0 5803.6 5985.6 6050.3 6055.0 6087.1 4598.1 4613.9 4624.9 4651.0 4654.7 4129.4 4176.3 4179.7 4183.7 4200.9 5696.7 5749.1 5763.7 5817.0 5848.6 5984.6 6039.5 6059.6 6110.2 6135.7 5714.9 5843.9 5845.2 5858.6 5862.4 5131.8 5157.9 5165.7 5209.7 5235.1 6380.2 6388.9 6423.8 6428.2 6447.0 5884.7 6045.4 6185.3 6185.7 6205.9 6208.7 6335.2 6363.8 6369.2 6384.0 6004.9 6056.2 6060.0 6068.5 6085.2 5972.5 5984.5 6009.5 6159.6 6160.7 5935.9 5949.0 5951.9 5956.0 5983.9 5789.2 5853.2 5853.7 5923.0 5923.3 5677.7 5712.2 5727.5 5784.9 5805.0 5948.9 5954.9 5967.7 5975.4 6007.7 5823.6 5842.2 5844.7 5856.0 5859.6 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#1] ext.html Cycles:180 Average:69277.57 Median:44194.39 stddev:147908.47 (334.7%) stddev-sans-first:148233.48 03:47:18 INFO - PROCESS | 32328 | Values: 588.7 636.2 639.9 654.8 685.3 34905.3 38181.8 46267.8 47339.5 47829.3 47081.8 47336.3 47662.0 47759.8 47790.8 9056.5 9184.4 9193.5 9232.3 9243.8 9055.6 9134.4 9149.9 9155.6 9158.5 9132.2 9163.9 9188.2 9204.9 9215.7 9061.4 9147.8 9189.0 9200.6 9210.6 9003.3 9066.7 9069.5 9100.6 9101.2 44300.6 44495.0 44560.6 44647.3 44828.0 3698.5 3890.6 3964.4 4306.6 4677.5 33812.0 34236.1 34589.5 34619.7 35526.5 4694.8 4747.9 4761.2 4772.1 4818.8 380902.0 384555.0 386598.0 387664.1 387775.0 58975.0 59793.4 59856.0 64734.0 64923.0 40248.2 41494.8 41763.0 68444.7 68622.3 18154.1 18160.1 18254.4 18308.0 18363.7 14469.3 14515.9 14586.4 14650.3 14667.2 21302.1 21556.9 21576.0 21589.7 21700.5 7709.5 7841.9 7861.6 7868.0 7979.6 1041.5 1052.8 1134.1 1148.3 1183.9 29977.4 31911.2 32649.7 32663.0 32853.2 1170.6 1199.2 1229.3 1250.3 1277.0 17039.8 17089.5 17152.7 17165.2 17429.7 610824.0 666393.0 668652.0 688203.0 867132.0 63043.4 63491.0 63571.4 64007.4 64468.7 1460.1 1484.5 1486.5 1491.4 1510.4 32598.0 33043.7 33211.3 33424.0 33435.0 53849.7 54982.5 55125.0 55143.7 55245.7 519170.0 522128.0 522325.0 522669.0 524797.0 29346.6 29397.0 29432.4 30327.4 30708.4 51703.5 51761.2 51821.2 52238.5 52931.0 42879.0 43088.4 43275.6 44143.0 44418.1 42788.4 43186.8 43479.0 44245.8 44660.1 42778.8 43723.3 43739.1 43791.6 44008.6 37221.3 37343.4 37587.6 38029.2 38976.4 29086.4 29764.5 30135.5 30175.7 30394.7 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#2] jquery.html Cycles:180 Average:30247.73 Median:2183.91 stddev:89751.35 (4109.7%) stddev-sans-first:89975.17 03:47:18 INFO - PROCESS | 32328 | Values: 413.7 422.7 426.5 428.8 435.7 19047.6 19275.4 19934.5 20700.7 20801.0 12884.0 17934.7 18412.4 19366.1 19395.3 5123.4 5270.9 5281.7 5291.6 5309.4 5129.5 5242.2 5256.2 5419.7 5423.5 5348.4 5373.9 5419.4 5431.3 5451.5 5339.1 5377.0 5385.1 5747.1 5751.4 5512.0 5631.6 5640.5 5669.9 5845.9 14147.7 14432.9 14573.6 14591.7 20763.3 2255.3 2383.4 2539.9 2639.5 2644.2 10580.8 10705.0 10869.1 12342.3 13804.6 1988.8 2046.5 2051.8 2072.1 2112.5 80509.0 81094.2 81372.6 81420.6 81574.2 10981.7 11382.4 11581.7 11585.5 11733.6 12888.6 16210.6 16228.8 16242.4 16277.1 7680.7 8042.4 8158.3 8194.3 8348.0 8114.8 8188.3 8228.6 8351.4 8446.2 4276.2 4311.8 4320.4 4326.9 4416.7 1966.6 1974.8 1986.9 2003.0 2040.6 1022.0 1082.2 1084.6 1105.0 1112.0 17316.7 18060.5 19146.3 19268.1 19507.5 1009.3 1024.5 1040.9 1043.2 1050.2 10525.4 10890.1 10937.9 10941.8 10946.3 537458.0 538004.0 542061.0 552733.0 555822.0 94194.0 96011.0 96364.0 97413.0 97471.5 1029.3 1030.4 1044.0 1051.5 1052.0 16767.9 17200.6 17377.2 17784.7 17822.2 36574.8 38913.6 40521.4 42583.5 45002.0 51192.0 52100.5 54767.5 59912.7 60236.0 8222.9 8481.7 8543.3 8557.1 8672.0 9328.4 12994.8 13266.4 13290.8 13322.6 5737.8 8837.0 11429.5 11594.8 11720.0 10480.7 11166.6 11480.5 11480.7 11740.5 11623.2 11667.2 11682.4 11724.7 11749.9 7527.6 7879.7 8150.9 8743.0 8799.8 8613.8 10943.0 11842.7 11966.4 12163.8 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#3] mootools.html Cycles:180 Average:6205.77 Median:4445.51 stddev:3615.57 (81.3%) stddev-sans-first:3606.74 03:47:18 INFO - PROCESS | 32328 | Values: 1277.8 1416.7 1420.2 1680.4 1692.9 8392.5 9037.4 9172.1 9793.1 9795.3 9089.1 9428.1 9499.5 9505.2 9512.5 2438.0 2469.1 2486.6 2488.4 2493.4 2384.0 2446.9 2452.3 2455.2 2457.1 2437.3 2461.8 2501.9 2508.9 2511.5 2357.5 2384.1 2414.3 2426.4 2427.9 2391.2 2407.7 2408.6 2413.5 2414.5 9333.8 9405.6 9411.7 9425.7 9478.1 5412.3 5548.4 5573.1 5581.2 5584.8 3453.0 3479.2 3552.1 3579.7 3585.9 1041.4 1069.8 1081.9 1157.1 1168.1 13318.6 13327.1 13327.7 13336.6 13342.7 4655.1 4736.5 4813.5 4822.6 4840.8 11210.1 11228.1 11240.7 11243.8 11272.0 5480.5 5501.8 5509.8 5520.4 5562.6 4387.5 4854.1 5031.7 5079.5 5095.5 4227.5 4323.3 4430.0 4439.2 4451.9 1356.8 1365.7 1385.7 1390.6 1414.3 1088.7 1098.9 1111.1 1130.8 1138.9 6419.1 6449.6 6551.5 6614.1 6645.5 408.8 410.5 413.1 415.1 418.9 4418.6 4607.4 4612.6 4613.1 4623.2 11501.7 11545.7 11929.9 12055.1 12072.5 11773.5 11814.6 11899.3 11998.9 11999.8 8987.6 9004.1 9033.1 9089.8 9092.5 6435.2 6491.1 6491.6 6495.1 6529.1 10711.7 10794.4 10897.9 11003.3 11102.8 10987.4 11058.7 11123.7 11230.3 11308.6 7584.4 8080.4 8362.2 8524.1 8588.7 9218.3 9285.3 9287.3 9389.1 9395.6 8214.5 8394.8 8395.8 8454.8 8515.0 7560.7 7758.2 7820.3 7928.9 8038.0 7172.3 7231.3 7248.2 7252.9 7298.5 5411.2 5428.0 5460.1 5464.4 5464.4 5364.6 5513.6 5564.3 5687.3 5835.2 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#4] prototype.html Cycles:180 Average:4830.21 Median:5390.82 stddev:1388.06 (25.7%) stddev-sans-first:1349.81 03:47:18 INFO - PROCESS | 32328 | Values: 307.8 321.9 336.5 337.8 343.1 5507.8 5610.6 5695.9 5725.9 5754.9 5500.5 5559.4 5566.9 5625.9 5649.3 4362.0 4379.3 4421.7 4443.2 4444.0 4215.0 4408.4 4440.3 4449.2 4461.6 4395.3 4410.4 4411.9 4434.7 4446.7 4423.7 4454.4 4458.4 4513.2 4522.1 3706.4 3919.5 4000.5 4015.0 4022.7 5454.8 5457.2 5465.4 5493.1 5496.4 5091.9 5102.9 5110.6 5111.2 5111.5 5636.2 5914.8 5929.1 5929.5 5980.4 4308.4 4320.2 4338.7 4356.3 4359.8 6181.2 6202.4 6214.7 6222.2 6225.5 4363.2 4427.5 4431.3 4432.3 4434.5 4502.2 4506.0 4516.0 4525.8 4537.5 5036.8 5047.4 5076.9 5100.3 5101.6 5707.9 5763.9 5940.1 5975.0 5984.2 1536.3 1544.1 1553.3 1559.2 1566.3 968.6 980.6 981.7 983.2 998.5 5089.1 5136.6 5160.6 5169.7 5221.4 5377.9 5470.3 5486.9 5511.4 5540.3 5023.8 5148.4 5172.0 5178.2 5181.4 2910.6 2931.5 2950.3 2952.9 2958.3 5599.5 5636.0 5668.1 5679.4 5721.7 5251.4 5495.3 5499.9 5513.8 5567.5 5541.3 5594.9 5623.9 5671.1 5740.3 5004.9 5313.9 5377.3 5385.5 5429.7 5303.6 5326.0 5364.2 5383.6 5393.9 5505.7 5552.7 5592.2 5623.9 5639.9 3856.0 3959.6 3994.8 4025.7 4048.9 5387.8 5447.2 5490.3 5935.3 6173.8 6014.0 6019.5 6025.4 6053.4 6137.5 5925.7 5961.5 5963.6 6008.2 6027.0 5875.6 5903.8 5929.7 5943.3 5949.9 6018.5 6058.9 6071.9 6085.4 6087.3 5794.3 5813.5 5871.7 5950.9 5954.6 03:47:18 INFO - PROCESS | 32328 | 03:47:18 INFO - PROCESS | 32328 | [#5] yui.html Cycles:180 Average:22841.52 Median:24745.19 stddev:32954.85 (133.2%) stddev-sans-first:33005.65 03:47:18 INFO - PROCESS | 32328 | Values: 775.7 779.5 794.8 868.1 872.6 15711.6 16022.8 16686.6 16775.9 16822.4 17357.5 17568.3 17571.8 17575.3 17585.8 710.7 882.8 888.6 891.9 894.5 838.2 876.8 882.8 886.9 888.9 931.3 932.6 936.4 938.7 940.9 924.4 930.0 933.3 933.9 935.4 683.5 683.7 684.1 685.3 686.7 15905.5 16114.4 16140.1 16153.5 16209.3 15739.8 16079.3 16564.2 16571.8 16909.5 13264.7 13355.6 13392.4 13440.9 13550.2 4242.7 4264.7 4331.1 4365.2 4373.5 67239.3 69162.0 69901.7 70117.0 78822.0 12864.5 12920.6 13129.7 13155.2 13625.1 22418.9 24244.9 24577.3 24723.5 24766.9 9527.5 9730.8 9731.3 9759.2 9786.4 5211.7 5221.3 5407.0 5437.0 5441.8 3702.4 3851.3 3912.9 4066.8 4108.4 708.1 724.2 726.4 729.2 736.1 682.2 816.1 827.8 838.4 854.1 10995.7 11241.9 11292.6 11396.8 11435.1 764.9 813.3 839.3 848.4 869.2 5406.1 5482.5 5568.6 5627.3 5630.4 108683.0 129578.4 129945.0 130142.3 132185.0 110844.0 111694.4 112775.0 113231.0 114951.4 97923.0 99106.0 99106.5 101875.0 102008.0 10119.8 10212.6 10295.3 10421.0 10437.1 53227.7 56245.4 56524.7 56616.0 58348.8 74634.6 83669.0 84499.6 84544.6 86802.1 12463.2 12776.7 12827.3 14643.0 14813.3 15969.0 16169.0 16252.8 16302.8 16325.5 14233.2 15074.4 15213.3 15332.5 15487.8 14444.3 14673.0 14764.9 14964.7 15552.5 14898.8 15000.2 15070.9 15615.5 15644.4 10966.6 11056.0 11138.8 11205.9 11338.1 12133.4 12290.3 12302.1 12560.8 12764.4 03:47:18 INFO - PROCESS | 32328 | -------- Summary: end -------- 03:47:18 INFO - PROCESS | 32328 | 03:47:19 INFO - TEST-INFO | 32328: exit 0 03:47:19 INFO - TEST-OK | dromaeo_css | took 1110689ms 03:47:19 INFO - TEST-START | kraken 03:47:19 INFO - operating with platform_type : linux_ 03:47:19 INFO - Initialising browser for kraken test... 03:47:19 INFO - TEST-INFO | started process 32572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5perMu/profile http://localhost:32962/getInfo.html) 03:47:23 INFO - PROCESS | 32572 | __metrics Screen width/height:1600/1200 03:47:23 INFO - PROCESS | 32572 | colorDepth:24 03:47:23 INFO - PROCESS | 32572 | Browser inner width/height: 1024/697 03:47:23 INFO - PROCESS | 32572 | __metrics 03:47:24 ERROR - PROCESS | 32572 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 03:47:25 INFO - TEST-INFO | 32572: exit 0 03:47:25 INFO - Browser initialized. 03:47:25 INFO - Running cycle 1/1 for kraken test... 03:47:25 INFO - TEST-INFO | started process 32699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5perMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:37 INFO - PROCESS | 32699 | RSS: Main: 156332032 03:47:37 INFO - PROCESS | 32699 | 03:47:39 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32962/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:40 INFO - PROCESS | 32699 | RSS: Main: 160931840 03:47:40 INFO - PROCESS | 32699 | 03:47:43 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32962/tests/kraken/driver.html?testName=audio-dft) 03:47:44 INFO - PROCESS | 32699 | RSS: Main: 160342016 03:47:44 INFO - PROCESS | 32699 | 03:47:46 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32962/tests/kraken/driver.html?testName=audio-fft) 03:47:47 INFO - PROCESS | 32699 | RSS: Main: 161120256 03:47:47 INFO - PROCESS | 32699 | 03:47:49 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32962/tests/kraken/driver.html?testName=audio-oscillator) 03:47:50 INFO - PROCESS | 32699 | RSS: Main: 160780288 03:47:50 INFO - PROCESS | 32699 | 03:47:52 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:53 INFO - PROCESS | 32699 | RSS: Main: 160600064 03:47:53 INFO - PROCESS | 32699 | 03:47:56 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32962/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:56 INFO - PROCESS | 32699 | RSS: Main: 160608256 03:47:56 INFO - PROCESS | 32699 | 03:48:00 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32962/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:00 INFO - PROCESS | 32699 | RSS: Main: 160935936 03:48:00 INFO - PROCESS | 32699 | 03:48:03 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32962/tests/kraken/driver.html?testName=json-parse-financial) 03:48:04 INFO - PROCESS | 32699 | RSS: Main: 160890880 03:48:04 INFO - PROCESS | 32699 | 03:48:05 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:06 INFO - PROCESS | 32699 | RSS: Main: 160608256 03:48:06 INFO - PROCESS | 32699 | 03:48:08 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:08 INFO - PROCESS | 32699 | RSS: Main: 160980992 03:48:08 INFO - PROCESS | 32699 | 03:48:10 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:11 INFO - PROCESS | 32699 | RSS: Main: 161509376 03:48:11 INFO - PROCESS | 32699 | 03:48:13 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:14 INFO - PROCESS | 32699 | RSS: Main: 161390592 03:48:14 INFO - PROCESS | 32699 | 03:48:17 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:48:17 INFO - PROCESS | 32699 | RSS: Main: 161128448 03:48:17 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | Cycle 1(1): loaded http://localhost:32962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32962/tests/kraken/driver.html?testName=ai-astar) 03:48:19 INFO - PROCESS | 32699 | RSS: Main: 161980416 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | __start_tp_report 03:48:19 INFO - PROCESS | 32699 | _x_x_mozilla_page_load 03:48:19 INFO - PROCESS | 32699 | _x_x_mozilla_page_load_details 03:48:19 INFO - PROCESS | 32699 | |i|pagename|runs| 03:48:19 INFO - PROCESS | 32699 | |0;ai-astar;113;106;112;112;110;111;110;110;110;110 03:48:19 INFO - PROCESS | 32699 | |1;audio-beat-detection;150;137;164;181;126;155;158;134;188;132 03:48:19 INFO - PROCESS | 32699 | |2;audio-dft;161;163;161;162;161;164;163;165;161;163 03:48:19 INFO - PROCESS | 32699 | |3;audio-fft;75;76;75;175;77;75;74;76;176;76 03:48:19 INFO - PROCESS | 32699 | |4;audio-oscillator;87;85;154;84;84;85;140;84;86;145 03:48:19 INFO - PROCESS | 32699 | |5;imaging-gaussian-blur;118;117;118;118;117;118;117;120;118;118 03:48:19 INFO - PROCESS | 32699 | |6;imaging-darkroom;147;146;147;147;146;147;146;147;148;147 03:48:19 INFO - PROCESS | 32699 | |7;imaging-desaturate;95;95;97;95;96;96;96;95;95;96 03:48:19 INFO - PROCESS | 32699 | |8;json-parse-financial;51;52;54;52;52;54;59;51;51;59 03:48:19 INFO - PROCESS | 32699 | |9;json-stringify-tinderbox;61;61;61;62;61;61;61;62;61;61 03:48:19 INFO - PROCESS | 32699 | |10;stanford-crypto-aes;78;76;78;80;78;79;83;78;112;78 03:48:19 INFO - PROCESS | 32699 | |11;stanford-crypto-ccm;122;138;120;123;128;122;123;132;130;127 03:48:19 INFO - PROCESS | 32699 | |12;stanford-crypto-pbkdf2;161;156;161;155;154;158;153;158;154;154 03:48:19 INFO - PROCESS | 32699 | |13;stanford-crypto-sha256-iterative;61;70;61;64;66;62;67;61;61;64 03:48:19 INFO - PROCESS | 32699 | __end_tp_report 03:48:19 INFO - PROCESS | 32699 | __start_cc_report 03:48:19 INFO - PROCESS | 32699 | _x_x_mozilla_cycle_collect,864 03:48:19 INFO - PROCESS | 32699 | __end_cc_report 03:48:19 INFO - PROCESS | 32699 | __startTimestamp1469875699755__endTimestamp 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | ------- Summary: start ------- 03:48:19 INFO - PROCESS | 32699 | Number of tests: 14 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:1.90 (1.7%) stddev-sans-first:1.76 03:48:19 INFO - PROCESS | 32699 | Values: 113.0 106.0 112.0 112.0 110.0 111.0 110.0 110.0 110.0 110.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:156.50 stddev:20.96 (13.4%) stddev-sans-first:22.21 03:48:19 INFO - PROCESS | 32699 | Values: 150.0 137.0 164.0 181.0 126.0 155.0 158.0 134.0 188.0 132.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.43 (0.9%) stddev-sans-first:1.42 03:48:19 INFO - PROCESS | 32699 | Values: 161.0 163.0 161.0 162.0 161.0 164.0 163.0 165.0 161.0 163.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:42.17 (55.9%) stddev-sans-first:44.07 03:48:19 INFO - PROCESS | 32699 | Values: 75.0 76.0 75.0 175.0 77.0 75.0 74.0 76.0 176.0 76.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.50 stddev:29.83 (35.3%) stddev-sans-first:31.04 03:48:19 INFO - PROCESS | 32699 | Values: 87.0 85.0 154.0 84.0 84.0 85.0 140.0 84.0 86.0 145.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 03:48:19 INFO - PROCESS | 32699 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 117.0 120.0 118.0 118.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 03:48:19 INFO - PROCESS | 32699 | Values: 147.0 146.0 147.0 147.0 146.0 147.0 146.0 147.0 148.0 147.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:48:19 INFO - PROCESS | 32699 | Values: 95.0 95.0 97.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.00 stddev:3.10 (5.8%) stddev-sans-first:3.15 03:48:19 INFO - PROCESS | 32699 | Values: 51.0 52.0 54.0 52.0 52.0 54.0 59.0 51.0 51.0 59.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 03:48:19 INFO - PROCESS | 32699 | Values: 61.0 61.0 61.0 62.0 61.0 61.0 61.0 62.0 61.0 61.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:78.00 stddev:10.70 (13.7%) stddev-sans-first:11.25 03:48:19 INFO - PROCESS | 32699 | Values: 78.0 76.0 78.0 80.0 78.0 79.0 83.0 78.0 112.0 78.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.50 stddev:5.62 (4.4%) stddev-sans-first:5.72 03:48:19 INFO - PROCESS | 32699 | Values: 122.0 138.0 120.0 123.0 128.0 122.0 123.0 132.0 130.0 127.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.40 Median:157.00 stddev:2.95 (1.9%) stddev-sans-first:2.62 03:48:19 INFO - PROCESS | 32699 | Values: 161.0 156.0 161.0 155.0 154.0 158.0 153.0 158.0 154.0 154.0 03:48:19 INFO - PROCESS | 32699 | 03:48:19 INFO - PROCESS | 32699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:3.13 (4.9%) stddev-sans-first:3.16 03:48:19 INFO - PROCESS | 32699 | Values: 61.0 70.0 61.0 64.0 66.0 62.0 67.0 61.0 61.0 64.0 03:48:19 INFO - PROCESS | 32699 | -------- Summary: end -------- 03:48:19 INFO - PROCESS | 32699 | 03:48:20 INFO - TEST-INFO | 32699: exit 0 03:48:20 INFO - TEST-OK | kraken | took 61544ms 03:48:20 INFO - SUITE-END | took 1172s 03:48:20 INFO - Completed test suite (00:19:32) 03:48:20 INFO - javascript benchmark 03:48:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7609.415547979693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.0768038789333, 3395.7792743471687, 3399.4051041067814, 3430.6054803697584, 3431.691147796698, 5588.24558684578, 5650.773969041234, 5674.063779476387, 5692.260006199199, 5735.283089613798, 5688.800891968782, 5718.685472299022, 5745.425457454253, 5752.769889204426, 5768.192453056576, 5132.153194722866, 5181.274621552986, 5222.9477705223035, 5240.0, 5272.209168624699, 5089.160288552384, 5091.109055915219, 5264.921026184591, 5265.947340526584, 5277.762500687459, 5119.744012799364, 5120.129577971754, 5132.846014619548, 5153.2785410042625, 5201.661891977028, 5136.255242989764, 5219.634625576211, 5242.8689282767855, 5253.317068781034, 5278.868028299285, 5021.196608542652, 5104.540591346797, 5171.120909445403, 5219.060569097561, 5234.7644356004075, 5451.918221226685, 5496.615236933376, 5503.6147469677135, 5513.641613295163, 5574.386817450078, 6047.727852246616, 6065.120557519179, 6086.147939288503, 6087.634741915455, 6095.603785753956, 5869.7652093916195, 5987.6108052976415, 6113.205283313186, 6121.143039974407, 6125.387461253884, 5622.072358060915, 5666.12175112854, 5685.204071429962, 5694.0, 5719.799807006776, 6127.754889804447, 6129.724162412702, 6156.630602163885, 6159.5688301818445, 6170.0, 5794.159846822187, 5886.676232807236, 5886.764529418861, 5947.613405128653, 5951.880962380728, 6068.33248342682, 6068.575199736064, 6075.392460753889, 6077.088436734437, 6113.602615829956, 5973.163757074013, 5978.730957106941, 6018.307894592091, 6019.0, 6058.030715085565, 5803.564732645069, 5985.551083668743, 6050.273967123973, 6054.969725151346, 6087.147799308101, 4598.126355992351, 4613.8846528836375, 4624.884377890512, 4650.953490465052, 4654.674172807939, 4129.359949207877, 4176.33178691414, 4179.686523510749, 4183.707140500197, 4200.85297014603, 5696.686682232517, 5749.051406517878, 5763.682997435098, 5817.0, 5848.590598658053, 5984.551158663031, 6039.486643635252, 6059.60612560191, 6110.205673262448, 6135.693215339215, 5714.914276285859, 5843.912341314884, 5845.240118784531, 5858.560607954335, 5862.355140934494, 5131.820386286462, 5157.871053223699, 5165.715885626327, 5209.739513024334, 5235.083860324428, 6380.170577824946, 6388.872222555616, 6423.775167869102, 6428.228612566522, 6446.967765161145, 5884.735186916513, 6045.395460454095, 6185.288691800501, 6185.659788711574, 6205.875882482234, 6208.720607572761, 6335.176427064452, 6363.840903977252, 6369.235691716838, 6384.042393640805, 6004.87990240184, 6056.242969628796, 6059.969700151471, 6068.484178844671, 6085.178500902499, 5972.522198224045, 5984.461398474158, 6009.489193418608, 6159.630422174684, 6160.722767475564, 5935.881282374242, 5949.0481522956115, 5951.940480595312, 5956.0, 5983.880322393615, 5789.247397838254, 5853.1805547222575, 5853.678047707417, 5923.0, 5923.318818335946, 5677.687727175045, 5712.228849105318, 5727.541796656341, 5784.942150578609, 5805.042168042226, 5948.851278718067, 5954.880902382015, 5967.731452084753, 5975.37258587842, 6007.729652165575, 5823.592348535732, 5842.152887831326, 5844.707764611838, 5856.0, 5859.648421094748], "value": 5600.562007276885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.6909372579395, 636.1634450697336, 639.8624295776407, 654.7741029344876, 685.2975699907596, 34905.30189396214, 38181.80909095454, 46267.76866115673, 47339.52660473394, 47829.28256076153, 47081.76459117708, 47336.289955650696, 47662.0467590648, 47759.76120119403, 47790.761046194806, 9056.547172641374, 9184.448933064004, 9193.540322983858, 9232.261419086457, 9243.768905777342, 9055.59249833759, 9134.406263592879, 9149.862752058725, 9155.633774649039, 9158.542072896362, 9132.178103970642, 9163.862542061874, 9188.1730644242, 9204.861927071099, 9215.677451289206, 9061.365704400727, 9147.771305717377, 9189.035151309083, 9200.585973631203, 9210.631574737035, 9003.324750643727, 9066.727998160066, 9069.455832650063, 9100.63597456101, 9101.226395756303, 44300.556994430284, 44495.0, 44560.55439445596, 44647.33029004568, 44828.0, 3698.519192504984, 3890.610938906115, 3964.405339199114, 4306.590873866978, 4677.532246775295, 33812.0, 34236.14409639754, 34589.481157782655, 34619.65380346215, 35526.467102993214, 4694.779357367075, 4747.928781068253, 4761.2382018876815, 4772.069446457942, 4818.759062046884, 380902.0, 384555.0, 386598.0, 387664.0616796926, 387775.0, 58975.0, 59793.402065978786, 59856.0, 64734.0, 64923.0, 40248.19503609911, 41494.79252603718, 41763.0, 68444.6577767108, 68622.31377686259, 18154.092295385177, 18160.091995400177, 18254.36109736153, 18308.0, 18363.72454413185, 14469.276536173149, 14515.85484145166, 14586.41654333836, 14650.267486625626, 14667.193304368362, 21302.147914083263, 21556.89221553882, 21576.0, 21589.676154857374, 21700.45748856291, 7709.498882572615, 7841.882371764428, 7861.646225919733, 7868.0, 7979.640916158787, 1041.5313109100935, 1052.768390953989, 1134.0927258193576, 1148.2708480115186, 1183.893449589524, 29977.400451990838, 31911.202219944687, 32649.673503265138, 32662.997565596583, 32853.17867053343, 1170.6488053583892, 1199.1845545029464, 1229.3238718704856, 1250.3435696259537, 1276.9808452873215, 17039.829601704074, 17089.48731538056, 17152.742708859376, 17165.227564759614, 17429.65140697179, 610824.0, 666393.0, 668652.0, 688203.0, 867132.0, 63043.36956630375, 63491.0, 63571.36428635747, 64007.35992640107, 64468.67765661235, 1460.1239256446047, 1484.480431848866, 1486.5466032860081, 1491.4332553629552, 1510.3870304373495, 32598.0, 33043.66956330502, 33211.335773283914, 33424.0, 33435.0, 53849.73075134599, 54982.45017549933, 55125.0, 55143.72428137834, 55245.723771380886, 519170.0, 522128.0, 522325.0, 522669.0, 524797.0, 29346.55980160342, 29397.0, 29432.411351772418, 30327.393452130393, 30708.385832283675, 51703.48296516987, 51761.22358164706, 51821.22268166056, 52238.47761522488, 52931.0, 42879.0, 43088.35367469428, 43275.567244327154, 44143.0, 44418.111637766415, 42788.35817462678, 43186.78406607947, 43479.0, 44245.778771105935, 44660.10679786321, 42778.786106069274, 43723.34414983841, 43739.12521749611, 43791.56208437875, 44008.559914401725, 37221.25557488889, 37343.43984840284, 37587.62412375951, 38029.239415210985, 38976.415353769145, 29086.418271634873, 29764.51368689471, 30135.547966780076, 30175.69824301729, 30394.696053040072], "value": 21526.043525360914, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.6504653567734, 422.72734086514197, 426.5201648145836, 428.7706077248671, 435.68630585978104, 19047.619047619057, 19275.421737347886, 19934.50163745907, 20700.689489657667, 20801.0, 12884.0, 17934.74456788022, 18412.44762657119, 19366.12852421641, 19395.321163759272, 5123.385193776752, 5270.894582108355, 5281.656692315007, 5291.6031297652635, 5309.442508536606, 5129.512696293846, 5242.239875218091, 5256.185291279858, 5419.729013549327, 5423.484768946963, 5348.3849357323825, 5373.865653358678, 5419.376771671249, 5431.321084864392, 5451.48210919962, 5339.092354299759, 5376.973115134439, 5385.057614917393, 5747.051736463479, 5751.367349591542, 5512.0, 5631.577631677641, 5640.492355687967, 5669.9433005669825, 5845.912311315291, 14147.717045659132, 14432.855671443362, 14573.562793116223, 14591.70816583673, 20763.273285434938, 2255.3387003336056, 2383.4398916254668, 2539.898404063835, 2639.4721055788727, 2644.1803041057333, 10580.78838423235, 10705.036546710833, 10869.130469562417, 12342.259464432163, 13804.585862424143, 1988.8408927285927, 2046.5395286060666, 2051.784562620918, 2072.057213967641, 2112.4824418017683, 80508.99999999942, 81094.18905810984, 81372.59313703454, 81420.59289703514, 81574.18425815785, 10981.670549883356, 11382.373969431761, 11581.652550423501, 11585.536578536932, 11733.589324373606, 12888.61334159958, 16210.594735131715, 16228.837711622733, 16242.350305987628, 16277.104759238355, 7680.731174408869, 8042.437029407885, 8158.347332213409, 8194.262516373556, 8348.0, 8114.797130071795, 8188.303994160563, 8228.588570571448, 8351.415400921876, 8446.239838414573, 4276.2302785498905, 4311.805968731414, 4320.401451462979, 4326.913461730748, 4416.734995900256, 1966.5575245569632, 1974.8025197480138, 1986.8708533945248, 2002.9799702002792, 2040.6224848403092, 1021.9897801022043, 1082.2370228988543, 1084.6474895658941, 1104.9613263535898, 1112.0436424674774, 17316.65366692659, 18060.54848628795, 19146.329878454188, 19268.132934018002, 19507.51231219231, 1009.258195226508, 1024.513356155835, 1040.9167266618651, 1043.2488608202234, 1050.165118730611, 10525.36847789135, 10890.128789696806, 10937.851525589858, 10941.781164376827, 10946.343219406861, 537458.0, 538004.0, 542061.0, 552733.0, 555822.0, 94194.0, 96011.0, 96364.0, 97413.0, 97471.51264243634, 1029.325791606499, 1030.3714734012246, 1043.994780026095, 1051.5373235776235, 1051.9684409467727, 16767.91616041912, 17200.569985749957, 17377.21802518915, 17784.73322900132, 17822.19800109024, 36574.817125914204, 38913.610863891, 40521.392179116745, 42583.50957716465, 45002.0, 51192.0, 52100.47899521108, 54767.45232547783, 59912.70043649754, 60236.0, 8222.876656850272, 8481.745547633582, 8543.273821724973, 8557.058723540282, 8671.956640216758, 9328.440293582407, 12994.80507792365, 13266.403011864682, 13290.800637990245, 13322.600321990356, 5737.827865164052, 8837.0, 11429.45702330208, 11594.826077608674, 11720.0, 10480.737981550523, 11166.553337866395, 11480.483378248166, 11480.655580332603, 11740.471678774305, 11623.186376953532, 11667.241629294069, 11682.415879205835, 11724.70688232801, 11749.88250117488, 7527.585982771, 7879.684812607432, 8150.9184908150155, 8742.956285218534, 8799.824003520022, 8613.784655383666, 10943.0, 11842.703932401759, 11966.401679916144, 12163.81754273669], "value": 9101.826452437987, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.78916478781, 1416.6600015996157, 1420.247268947458, 1680.4118558504524, 1692.8984260944337, 8392.454490458116, 9037.367384283103, 9172.082791720824, 9793.06965838246, 9795.265355098369, 9089.091090890908, 9428.05719428057, 9499.477528735917, 9505.19205867502, 9512.524373781318, 2437.987810060947, 2469.09877894569, 2486.627005949113, 2488.35302821266, 2493.4140476987895, 2383.9880800595975, 2446.926592202237, 2452.31335226137, 2455.2143314139485, 2457.0540341968294, 2437.2688193541867, 2461.8276720629565, 2501.862397568133, 2508.924732258035, 2511.535365957304, 2357.4577847095265, 2384.117876385731, 2414.3481260059775, 2426.4055306449854, 2427.9393015174587, 2391.2228525729206, 2407.65089062085, 2408.5664580375524, 2413.4690368118986, 2414.5170965806733, 9333.766655833591, 9405.623775048989, 9411.670591529331, 9425.670101546482, 9478.146966772954, 5412.296401467824, 5548.389677135512, 5573.052581061229, 5581.190727344553, 5584.832455026356, 3452.9654703453148, 3479.1650003998857, 3552.1119720069983, 3579.7315201359743, 3585.8744943926836, 1041.4063983529315, 1069.8288273876142, 1081.9350838949688, 1157.0916830288268, 1168.0830548019849, 13318.600441986757, 13327.133736307205, 13327.73344533104, 13336.599902002858, 13342.666433339147, 4655.11552804966, 4736.455307639597, 4813.542713442287, 4822.614190864722, 4840.75796210188, 11210.103191744642, 11228.101751859831, 11240.662780116609, 11243.775124497464, 11272.041876440595, 5480.479354461319, 5501.779928802803, 5509.8071567495745, 5520.420355862657, 5562.554995600423, 4387.473503179639, 4854.101991131652, 5031.723255220998, 5079.542841144241, 5095.541401273903, 4227.492700875914, 4323.329883868006, 4429.9778501107285, 4439.156560253606, 4451.866444006685, 1356.7625665508497, 1365.6790654196257, 1385.7228554289181, 1390.610629023875, 1414.299921538845, 1088.6625146204701, 1098.9340639561651, 1111.0778054214982, 1130.7851508213578, 1138.8576427946507, 6419.101325814389, 6449.645269510128, 6551.541392102602, 6614.10709554204, 6645.501587380966, 408.78334482724205, 410.5299432150171, 413.0726518964943, 415.10958992959934, 418.87643145272216, 4418.558144185556, 4607.424071991001, 4612.630989520897, 4613.123506533748, 4623.190941585209, 11501.654950351503, 11545.653630391102, 11929.880701193051, 12055.095867809774, 12072.517099315928, 11773.52905883755, 11814.586489472827, 11899.286042837457, 11998.940005299917, 11999.820002699966, 8987.55062246885, 9004.144606262395, 9033.141851524095, 9089.81820363589, 9092.545372731469, 6435.22777266731, 6491.091247225487, 6491.642959637076, 6495.0906873036865, 6529.118568993315, 10711.716751918246, 10794.406307653155, 10897.891021090005, 11003.33979961205, 11102.833457498306, 10987.39569323695, 11058.723531911766, 11123.721906952067, 11230.270032448192, 11308.604198853001, 7584.4311676625575, 8080.353571714131, 8362.247397734232, 8524.104968978168, 8588.65645374203, 9218.308626853148, 9285.257179425495, 9287.303452240974, 9389.06109389083, 9395.624175033196, 8214.507129572245, 8394.790130246793, 8395.83208335842, 8454.788630284293, 8515.0, 7560.735374261874, 7758.185390533913, 7820.296173344426, 7928.920710793049, 8037.959810200911, 7172.282771722786, 7231.349178573953, 7248.166460856858, 7252.948322493104, 7298.489105762758, 5411.188321751769, 5428.0, 5460.099083651153, 5464.371597266365, 5464.426235245242, 5364.597655175799, 5513.558915286848, 5564.304461942257, 5687.260656114679, 5835.153902684172], "value": 4827.413188699999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.8014680531056, 321.8760777100816, 336.51877814724946, 337.84965690267825, 343.1404332147968, 5507.83299602728, 5610.579206559504, 5695.914561281579, 5725.885482290357, 5754.913676294854, 5500.45987123606, 5559.388467268597, 5566.944330556693, 5625.931073096109, 5649.322081350233, 4361.956380436187, 4379.255526560476, 4421.6683748718815, 4443.22243607369, 4443.955670417449, 4214.97892510537, 4408.42690450241, 4440.313610265791, 4449.199144154051, 4461.553844615545, 4395.318725597522, 4410.353787727354, 4411.889702757425, 4434.68957172998, 4446.710963787344, 4423.690341676068, 4454.443194600675, 4458.375827384169, 4513.187626227278, 4522.095580883836, 3706.4440333950124, 3919.510061242345, 4000.5199376075057, 4014.979925100385, 4022.658074063708, 5454.836354909359, 5457.154141108134, 5465.371482279509, 5493.148561972861, 5496.422875598045, 5091.919388769815, 5102.9489705103215, 5110.594586488708, 5111.207762796773, 5111.488851114896, 5636.239107720447, 5914.781956766213, 5929.14027466015, 5929.466348028698, 5980.372060933583, 4308.4399028126145, 4320.191875281061, 4338.717983331074, 4356.324769660708, 4359.782010899442, 6181.165542651775, 6202.3797620238065, 6214.65819379934, 6222.191115155001, 6225.470834979033, 4363.19280933022, 4427.5351088135285, 4431.33529970507, 4432.3351497275025, 4434.467863856358, 4502.16709908668, 4505.954940450553, 4515.954840451619, 4525.796339164745, 4537.478190008125, 5036.798528058836, 5047.4447810740785, 5076.873078173076, 5100.285959965608, 5101.591872650179, 5707.914381284284, 5763.87604417143, 5940.108983652401, 5975.0, 5984.1921340618455, 1536.2549163655617, 1544.1352842408287, 1553.2777258574818, 1559.2125976381853, 1566.2795114247347, 968.5786682792867, 980.5881529757519, 981.699248495746, 983.1692220074026, 998.5356809083811, 5089.109405853961, 5136.640435169502, 5160.638755287094, 5169.663971841818, 5221.399539052982, 5377.870647164139, 5470.316210473691, 5486.91769623456, 5511.3937466878615, 5540.252065971123, 5023.824166154167, 5148.433672296044, 5172.0, 5178.249153872667, 5181.4300426953005, 2910.563415487694, 2931.457680329146, 2950.3066779306846, 2952.9114126576237, 2958.319586495118, 5599.496045355938, 5635.971820140873, 5668.072855229159, 5679.432056794288, 5721.656700597978, 5251.396089449686, 5495.2856128703015, 5499.890002199933, 5513.8345849624575, 5567.464659940967, 5541.33503979517, 5594.888102237933, 5623.915641265385, 5671.100181439181, 5740.339860915965, 5004.874878128076, 5313.946860531345, 5377.327834020747, 5385.461453854583, 5429.67421954684, 5303.605692356972, 5326.0, 5364.2490051393615, 5383.569314454912, 5393.865153371197, 5505.697186654773, 5552.7223638818705, 5592.245046918614, 5623.88752224945, 5639.88720225585, 3855.978165786125, 3959.6238357356006, 3994.8202330894596, 4025.745582473707, 4048.8785336439955, 5387.784488620411, 5447.237386765777, 5490.282310256449, 5935.347111817783, 6173.783917562864, 6013.9699301503215, 6019.458248757633, 6025.367336429612, 6053.394660534088, 6137.539684523589, 5925.733341999534, 5961.493273071664, 5963.552733544915, 6008.24896887889, 6027.035674292092, 5875.618084824473, 5903.793367232126, 5929.673867937305, 5943.346231914573, 5949.940500595112, 6018.4884284834525, 6058.878822423439, 6071.908921366095, 6085.391460853879, 6087.330393656783, 5794.348610645946, 5813.505852002627, 5871.706414679335, 5950.910736339045, 5954.553408494467], "value": 4384.351843654428, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.7246177606946, 779.543966779434, 794.7562065367699, 868.1101870582654, 872.6422166911566, 15711.607209819746, 16022.75965860513, 16686.58283542912, 16775.91612041938, 16822.411215607455, 17357.47927562175, 17568.29726810926, 17571.824281757177, 17575.29698812046, 17585.82414175861, 710.7405796884152, 882.7925437522193, 888.5557221389305, 891.888513935758, 894.4990805149105, 838.2455789789177, 876.837785009772, 882.7969566999594, 886.8847049883539, 888.9288856891433, 931.2503434735036, 932.5570354081825, 936.3539157981005, 938.6620816506053, 940.8588711693267, 924.3899026642383, 929.9814003719922, 933.3140141995627, 933.8879334479872, 935.4060171790894, 683.4942142814282, 683.733343995842, 684.1174884399119, 685.3146853146853, 686.6978529447027, 15905.522834314874, 16114.355425782955, 16140.112293823835, 16153.515394538183, 16209.270582823801, 15739.763903541456, 16079.276432560562, 16564.171791410383, 16571.751423728652, 16909.492715218563, 13264.73470530584, 13355.599332020054, 13392.397342119531, 13440.86559134406, 13550.186988780606, 4242.681798865066, 4264.701470897038, 4331.112122014979, 4365.170617582649, 4373.518912919576, 67239.31901702448, 69162.0, 69901.65049174773, 70117.0, 78822.0, 12864.549740759216, 12920.612381628565, 13129.671758206121, 13155.210687358789, 13625.114367566077, 22418.887905560696, 24244.87877560636, 24577.262682119566, 24723.505529889662, 24766.87616561942, 9527.52362381878, 9730.756731081638, 9731.318807683394, 9759.219262458986, 9786.41281523111, 5211.713355765393, 5221.295125158131, 5406.972965135149, 5436.972815135978, 5441.83674489766, 3702.3705969985167, 3851.345271303885, 3912.921741565153, 4066.7763273019677, 4108.404281379183, 708.0512113767576, 724.2323137474294, 726.4370113162341, 729.1869565434608, 736.0725485887713, 682.2290811383106, 816.1185919207242, 827.8054657155564, 838.4382463749303, 854.0605334132529, 10995.670129896116, 11241.943790280997, 11292.604758833402, 11396.829047564293, 11435.14236432271, 764.9464537482323, 813.2655282268395, 839.2940406154779, 848.3722045686147, 869.2090197919989, 5406.135018397038, 5482.506574408243, 5568.582356323292, 5627.323650423867, 5630.352509461382, 108683.0, 129578.35210823886, 129945.0, 130142.34928825295, 132185.0, 110844.0, 111694.44152779185, 112775.0, 113231.0, 114951.42524287324, 97923.0, 99106.0, 99106.5044674772, 101875.0, 102008.0, 10119.848202276824, 10212.642557510451, 10295.330803497749, 10421.0, 10437.11284540792, 53227.733861331995, 56245.43754562402, 56524.7173764145, 56616.0, 58348.83302333845, 74634.62682686551, 83669.0, 84499.5775021121, 84544.57727711322, 86802.1319786794, 12463.189892656948, 12776.74446511046, 12827.294498802283, 14643.0, 14813.333399997242, 15969.0, 16169.0, 16252.756208656643, 16302.755458667893, 16325.510234692978, 14233.217173055582, 15074.397024118913, 15213.315400806769, 15332.463363782213, 15487.767683484532, 14444.277786110863, 14672.97289189789, 14764.90100703588, 14964.700705985602, 15552.533423997298, 14898.77651835245, 15000.174990375634, 15070.924645376703, 15615.453459128876, 15644.374225031326, 10966.561337546409, 11056.0, 11138.832917506406, 11205.943970280423, 11338.14963877696, 12133.393330333625, 12290.262584244974, 12302.0773441994, 12560.811587826372, 12764.361781911053], "value": 8358.331645312666, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1527.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 137.0, 164.0, 181.0, 126.0, 155.0, 158.0, 134.0, 188.0, 132.0], "value": 152.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 162.0, 161.0, 164.0, 163.0, 165.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 175.0, 77.0, 75.0, 74.0, 76.0, 176.0, 76.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 154.0, 84.0, 84.0, 85.0, 140.0, 84.0, 86.0, 145.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 120.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 52.0, 52.0, 54.0, 59.0, 51.0, 51.0, 59.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 78.0, 80.0, 78.0, 79.0, 83.0, 78.0, 112.0, 78.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 138.0, 120.0, 123.0, 128.0, 122.0, 123.0, 132.0, 130.0, 127.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 161.0, 155.0, 154.0, 158.0, 153.0, 158.0, 154.0, 154.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 70.0, 61.0, 64.0, 66.0, 62.0, 67.0, 61.0, 61.0, 64.0], "value": 63.7, "unit": "score"}]}]} 03:48:20 INFO - Return code: 0 03:48:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:21 ERROR - # TBPL SUCCESS # 03:48:21 INFO - Running post-action listener: _resource_record_post_action 03:48:21 INFO - ##### 03:48:21 INFO - ##### Finished run-tests step (success) 03:48:21 INFO - ##### 03:48:21 INFO - Running post-run listener: _resource_record_post_run 03:48:21 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 504885248; Read time: 104; Write time: 490948 03:48:21 INFO - TinderboxPrint: CPU usage
13.5% 03:48:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 03:48:21 INFO - TinderboxPrint: I/O write bytes / time
504,885,248 / 490,948 03:48:21 INFO - TinderboxPrint: CPU idle
8,208.4 (86.5%) 03:48:21 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 03:48:21 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 254672896; Read time: 0; Write time: 291736 03:48:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250163200; Read time: 104; Write time: 199196 03:48:21 INFO - Running post-run listener: _upload_blobber_files 03:48:21 INFO - Blob upload gear active. 03:48:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:21 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 03:48:21 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'] 03:48:21 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 03:48:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:22 INFO - (blobuploader) - INFO - Done attempting. 03:48:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:26 INFO - (blobuploader) - INFO - Done attempting. 03:48:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:27 INFO - (blobuploader) - INFO - Done attempting. 03:48:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:27 INFO - Return code: 0 03:48:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/472b52986c3e1b58626c5039be638139f52d10bed918fff941a87f78df038f05542caed79372f7310f0c32a08aae6a337e9ee4061e58995a47f461510482b82d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23f1e3a5185b58f0950740fbec5766c3eec6030d7ef988e18257b1452255f6f4312c68826220d3aa410aab8bc609b00a3b9bfee0f6db6cf29f39e6a6b5d52ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c6afc3764181142d45b27939464273b1772115ddac804c33ad2a04dc888e0e966bd71ba8b83e3b16f2aa584d819c2b38a41df54d0f9822562b5c8a52270e540"} 03:48:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:27 INFO - Contents: 03:48:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/472b52986c3e1b58626c5039be638139f52d10bed918fff941a87f78df038f05542caed79372f7310f0c32a08aae6a337e9ee4061e58995a47f461510482b82d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23f1e3a5185b58f0950740fbec5766c3eec6030d7ef988e18257b1452255f6f4312c68826220d3aa410aab8bc609b00a3b9bfee0f6db6cf29f39e6a6b5d52ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c6afc3764181142d45b27939464273b1772115ddac804c33ad2a04dc888e0e966bd71ba8b83e3b16f2aa584d819c2b38a41df54d0f9822562b5c8a52270e540"} 03:48:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:27 INFO - Copying logs to upload dir... 03:48:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.338737 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-30 03:48:26.821449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:48:26.825373) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 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/472b52986c3e1b58626c5039be638139f52d10bed918fff941a87f78df038f05542caed79372f7310f0c32a08aae6a337e9ee4061e58995a47f461510482b82d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23f1e3a5185b58f0950740fbec5766c3eec6030d7ef988e18257b1452255f6f4312c68826220d3aa410aab8bc609b00a3b9bfee0f6db6cf29f39e6a6b5d52ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c6afc3764181142d45b27939464273b1772115ddac804c33ad2a04dc888e0e966bd71ba8b83e3b16f2aa584d819c2b38a41df54d0f9822562b5c8a52270e540"} build_url:https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/Wsfhh1rLTzW9EnkNArOCaw/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/472b52986c3e1b58626c5039be638139f52d10bed918fff941a87f78df038f05542caed79372f7310f0c32a08aae6a337e9ee4061e58995a47f461510482b82d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/23f1e3a5185b58f0950740fbec5766c3eec6030d7ef988e18257b1452255f6f4312c68826220d3aa410aab8bc609b00a3b9bfee0f6db6cf29f39e6a6b5d52ddf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c6afc3764181142d45b27939464273b1772115ddac804c33ad2a04dc888e0e966bd71ba8b83e3b16f2aa584d819c2b38a41df54d0f9822562b5c8a52270e540"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-30 03:48:26.854459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:48:26.855208) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1469874474.687272-1445693106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004351 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-30 03:48:26.938938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:48:26.939667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-30 03:48:26.940398) ========= ========= Total master_lag: 0.17 =========