builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1469217239.23 results: success (0) buildid: 20160722101826 builduid: b047703bdbe945f1acb00523157b8f62 revision: ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.226350) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.226877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.227230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.245722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.246107) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 12:53:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-22 12:53:59 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165094 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.428683) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.429077) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014197 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.479291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:53:59.479691) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e --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 ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e --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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 12:54:00,051 truncating revision to first 12 chars 2016-07-22 12:54:00,051 Setting DEBUG logging. 2016-07-22 12:54:00,051 attempt 1/10 2016-07-22 12:54:00,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ccbdbee8d758?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 12:54:00,348 unpacking tar archive at: mozilla-aurora-ccbdbee8d758/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 12:54:00.135514) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 12:54:00.135871) ========= script_repo_revision: ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 12:54:00.136333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 12:54:00.136635) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 12:54:00.147394) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-22 12:54:00.147794) ========= /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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:00 INFO - MultiFileLogger online at 20160722 12:54:00 in /builds/slave/test 12:54:00 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 12:54:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:00 INFO - {'append_to_log': False, 12:54:00 INFO - 'base_work_dir': '/builds/slave/test', 12:54:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:54:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:00 INFO - 'branch': 'Mozilla-Aurora', 12:54:00 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:00 INFO - 'config_files': ('talos/linux_config.py',), 12:54:00 INFO - 'default_actions': ('clobber', 12:54:00 INFO - 'read-buildbot-config', 12:54:00 INFO - 'download-and-extract', 12:54:00 INFO - 'populate-webroot', 12:54:00 INFO - 'create-virtualenv', 12:54:00 INFO - 'install', 12:54:00 INFO - 'run-tests'), 12:54:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:00 INFO - 'download_minidump_stackwalk': True, 12:54:00 INFO - 'download_symbols': 'ondemand', 12:54:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:00 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:00 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:00 INFO - 'installer_path': 'installer.exe', 12:54:00 INFO - 'log_level': 'info', 12:54:00 INFO - 'log_name': 'talos', 12:54:00 INFO - 'log_to_console': True, 12:54:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:00 INFO - 'opt_config_files': (), 12:54:00 INFO - 'pip_index': False, 12:54:00 INFO - 'sps_profile': False, 12:54:00 INFO - 'sps_profile_interval': 0, 12:54:00 INFO - 'suite': 'dromaeojs-e10s', 12:54:00 INFO - 'system_bits': '32', 12:54:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:00 INFO - 'title': 'talos-linux64-ix-029', 12:54:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:00 INFO - 'use_talos_json': True, 12:54:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:00 INFO - 'work_dir': 'build'} 12:54:00 INFO - ##### 12:54:00 INFO - ##### Running clobber step. 12:54:00 INFO - ##### 12:54:00 INFO - Running pre-action listener: _resource_record_pre_action 12:54:00 INFO - Running main action method: clobber 12:54:00 INFO - rmtree: /builds/slave/test/build 12:54:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:01 INFO - Running post-action listener: _resource_record_post_action 12:54:01 INFO - ##### 12:54:01 INFO - ##### Finished clobber step (success) 12:54:01 INFO - ##### 12:54:01 INFO - ##### 12:54:01 INFO - ##### Running read-buildbot-config step. 12:54:01 INFO - ##### 12:54:01 INFO - Running pre-action listener: _resource_record_pre_action 12:54:01 INFO - Running main action method: read_buildbot_config 12:54:01 INFO - Using buildbot properties: 12:54:01 INFO - { 12:54:01 INFO - "project": "", 12:54:01 INFO - "product": "firefox", 12:54:01 INFO - "script_repo_revision": "production", 12:54:01 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:54:01 INFO - "repository": "", 12:54:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:54:01 INFO - "buildid": "20160722101826", 12:54:01 INFO - "pgo_build": "True", 12:54:01 INFO - "basedir": "/builds/slave/test", 12:54:01 INFO - "buildnumber": 405, 12:54:01 INFO - "slavename": "talos-linux64-ix-029", 12:54:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:54:01 INFO - "platform": "ubuntu64_hw", 12:54:01 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:54:01 INFO - "branch": "mozilla-aurora", 12:54:01 INFO - "repo_path": "releases/mozilla-aurora", 12:54:01 INFO - "revision": "ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e", 12:54:01 INFO - "stage_platform": "linux64-pgo", 12:54:01 INFO - "builduid": "b047703bdbe945f1acb00523157b8f62", 12:54:01 INFO - "slavebuilddir": "test" 12:54:01 INFO - } 12:54:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:54:01 INFO - Running post-action listener: _resource_record_post_action 12:54:01 INFO - ##### 12:54:01 INFO - ##### Finished read-buildbot-config step (success) 12:54:01 INFO - ##### 12:54:01 INFO - ##### 12:54:01 INFO - ##### Running download-and-extract step. 12:54:01 INFO - ##### 12:54:01 INFO - Running pre-action listener: _resource_record_pre_action 12:54:01 INFO - Running main action method: download_and_extract 12:54:01 INFO - mkdir: /builds/slave/test/build/tests 12:54: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')]} 12:54:01 INFO - https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:54:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:54:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:54:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:02 INFO - Downloaded 1361 bytes. 12:54:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:54:02 INFO - Using the following test package requirements: 12:54:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:54:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:54:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'jsshell-linux-x86_64.zip'], 12:54:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:54:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:54:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:54:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:54:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:02 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')]} 12:54:02 INFO - https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:54:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:54:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:03 INFO - Downloaded 24494461 bytes. 12:54:03 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'] 12:54:03 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 12:54:05 INFO - Return code: 0 12:54:05 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 12:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:05 INFO - https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:54:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:54:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:06 INFO - Downloaded 24494461 bytes. 12:54:06 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'] 12:54:06 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 12:54:07 INFO - Return code: 0 12:54:07 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')]} 12:54:07 INFO - https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:54:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:54:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:54:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:08 INFO - Downloaded 10833369 bytes. 12:54:08 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'] 12:54:08 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 12:54:09 INFO - Return code: 0 12:54: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')]} 12:54:09 INFO - https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:54:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:54:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:54:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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 12:54:11 INFO - Downloaded 63645425 bytes. 12:54:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:54:11 INFO - mkdir: /builds/slave/test/properties 12:54:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:11 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:11 INFO - Contents: 12:54:11 INFO - build_url:https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:54:11 INFO - Running post-action listener: _resource_record_post_action 12:54:11 INFO - Running post-action listener: set_extra_try_arguments 12:54:11 INFO - ##### 12:54:11 INFO - ##### Finished download-and-extract step (success) 12:54:11 INFO - ##### 12:54:11 INFO - ##### 12:54:11 INFO - ##### Running populate-webroot step. 12:54:11 INFO - ##### 12:54:11 INFO - Running pre-action listener: _resource_record_pre_action 12:54:11 INFO - Running main action method: populate_webroot 12:54:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:11 INFO - '--tppagecycles', 12:54:11 INFO - '7'], 12:54:11 INFO - 'tests': ['tsvgm']}}, 12:54:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['damp', 'tps']}, 12:54:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'tests': ['damp', 'tps']}, 12:54:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['dromaeo_dom']}, 12:54:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['a11yr', 12:54:11 INFO - 'ts_paint', 12:54:11 INFO - 'tpaint', 12:54:11 INFO - 'sessionrestore', 12:54:11 INFO - 'sessionrestore_no_auto_restore', 12:54:11 INFO - 'tabpaint']}, 12:54:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['tsvgx', 12:54:11 INFO - 'tsvgr_opacity', 12:54:11 INFO - 'tart', 12:54:11 INFO - 'tscrollx', 12:54:11 INFO - 'cart']}, 12:54:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:11 INFO - 'tsvgr_opacity', 12:54:11 INFO - 'tart', 12:54:11 INFO - 'tscrollx', 12:54:11 INFO - 'cart']}, 12:54:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'talos_options': ['--disable-e10s'], 12:54:11 INFO - 'tests': ['tp5o']}, 12:54:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'tests': ['tp5o']}, 12:54:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'talos_options': ['--disable-e10s', 12:54:11 INFO - '--xperf_path', 12:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:11 INFO - 'tests': ['tp5n']}, 12:54:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:11 INFO - 'talos_options': ['--xperf_path', 12:54:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:11 INFO - 'tests': ['tp5n']}}, 12:54:11 INFO - 'talos.zip': {'path': '', 12:54:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:11 INFO - Running post-action listener: _resource_record_post_action 12:54:11 INFO - ##### 12:54:11 INFO - ##### Finished populate-webroot step (success) 12:54:11 INFO - ##### 12:54:11 INFO - ##### 12:54:11 INFO - ##### Running create-virtualenv step. 12:54:11 INFO - ##### 12:54:11 INFO - Running pre-action listener: _resource_record_pre_action 12:54:11 INFO - Running main action method: create_virtualenv 12:54:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:11 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 12:54:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:11 INFO - Using real prefix '/usr' 12:54:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:12 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:14 INFO - Installing pip.................done. 12:54:14 INFO - Return code: 0 12:54:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54: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', 'pip>=1.5'] in /builds/slave/test/build 12:54: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 pip>=1.5 12:54:14 INFO - Using env: {'DISPLAY': ':0', 12:54:14 INFO - 'HOME': '/home/cltbld', 12:54:14 INFO - 'LANG': 'en_US.UTF-8', 12:54:14 INFO - 'LANGUAGE': 'en_US:en', 12:54:14 INFO - 'LOGNAME': 'cltbld', 12:54:14 INFO - 'MAIL': '/var/mail/cltbld', 12:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:14 INFO - 'MOZ_NO_REMOTE': '1', 12:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:14 INFO - 'NO_EM_RESTART': '1', 12:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:14 INFO - 'PWD': '/builds/slave/test', 12:54:14 INFO - 'SHELL': '/bin/bash', 12:54:14 INFO - 'SHLVL': '1', 12:54:14 INFO - 'TERM': 'linux', 12:54:14 INFO - 'TMOUT': '86400', 12:54:14 INFO - 'USER': 'cltbld', 12:54:14 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:14 INFO - '_': '/tools/buildbot/bin/python'} 12:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:14 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 12:54:14 INFO - Cleaning up... 12:54:14 INFO - Return code: 0 12:54:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', '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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54: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 psutil>=3.1.1 12:54:14 INFO - Using env: {'DISPLAY': ':0', 12:54:14 INFO - 'HOME': '/home/cltbld', 12:54:14 INFO - 'LANG': 'en_US.UTF-8', 12:54:14 INFO - 'LANGUAGE': 'en_US:en', 12:54:14 INFO - 'LOGNAME': 'cltbld', 12:54:14 INFO - 'MAIL': '/var/mail/cltbld', 12:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:14 INFO - 'MOZ_NO_REMOTE': '1', 12:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:14 INFO - 'NO_EM_RESTART': '1', 12:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:14 INFO - 'PWD': '/builds/slave/test', 12:54:14 INFO - 'SHELL': '/bin/bash', 12:54:14 INFO - 'SHLVL': '1', 12:54:14 INFO - 'TERM': 'linux', 12:54:14 INFO - 'TMOUT': '86400', 12:54:14 INFO - 'USER': 'cltbld', 12:54:14 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:14 INFO - '_': '/tools/buildbot/bin/python'} 12:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:14 INFO - Downloading/unpacking psutil>=3.1.1 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:16 INFO - Installing collected packages: psutil 12:54:16 INFO - Running setup.py install for psutil 12:54:16 INFO - building 'psutil._psutil_linux' extension 12:54:16 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 12:54:17 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 12:54:17 INFO - building 'psutil._psutil_posix' extension 12:54:17 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 12:54:17 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 12:54:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:17 INFO - Successfully installed psutil 12:54:17 INFO - Cleaning up... 12:54:17 INFO - Return code: 0 12:54:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54: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 mozsystemmonitor==0.3 12:54:17 INFO - Using env: {'DISPLAY': ':0', 12:54:17 INFO - 'HOME': '/home/cltbld', 12:54:17 INFO - 'LANG': 'en_US.UTF-8', 12:54:17 INFO - 'LANGUAGE': 'en_US:en', 12:54:17 INFO - 'LOGNAME': 'cltbld', 12:54:17 INFO - 'MAIL': '/var/mail/cltbld', 12:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:17 INFO - 'MOZ_NO_REMOTE': '1', 12:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:17 INFO - 'NO_EM_RESTART': '1', 12:54:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:17 INFO - 'PWD': '/builds/slave/test', 12:54:17 INFO - 'SHELL': '/bin/bash', 12:54:17 INFO - 'SHLVL': '1', 12:54:17 INFO - 'TERM': 'linux', 12:54:17 INFO - 'TMOUT': '86400', 12:54:17 INFO - 'USER': 'cltbld', 12:54:17 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:17 INFO - '_': '/tools/buildbot/bin/python'} 12:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:19 INFO - Installing collected packages: mozsystemmonitor 12:54:19 INFO - Running setup.py install for mozsystemmonitor 12:54:19 INFO - Successfully installed mozsystemmonitor 12:54:19 INFO - Cleaning up... 12:54:19 INFO - Return code: 0 12:54:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:19 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 12:54:19 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 12:54:19 INFO - Using env: {'DISPLAY': ':0', 12:54:19 INFO - 'HOME': '/home/cltbld', 12:54:19 INFO - 'LANG': 'en_US.UTF-8', 12:54:19 INFO - 'LANGUAGE': 'en_US:en', 12:54:19 INFO - 'LOGNAME': 'cltbld', 12:54:19 INFO - 'MAIL': '/var/mail/cltbld', 12:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:19 INFO - 'MOZ_NO_REMOTE': '1', 12:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:19 INFO - 'NO_EM_RESTART': '1', 12:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:19 INFO - 'PWD': '/builds/slave/test', 12:54:19 INFO - 'SHELL': '/bin/bash', 12:54:19 INFO - 'SHLVL': '1', 12:54:19 INFO - 'TERM': 'linux', 12:54:19 INFO - 'TMOUT': '86400', 12:54:19 INFO - 'USER': 'cltbld', 12:54:19 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:19 INFO - '_': '/tools/buildbot/bin/python'} 12:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:19 INFO - Downloading/unpacking jsonschema==2.5.1 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:22 INFO - warning: no files found matching '*.txt' 12:54:22 INFO - no previously-included directories found matching 'build' 12:54:22 INFO - no previously-included directories found matching 'dist' 12:54:22 INFO - no previously-included directories found matching '.git*' 12:54:22 INFO - Installing collected packages: jsonschema, functools32 12:54:22 INFO - Running setup.py install for functools32 12:54:22 INFO - warning: no files found matching '*.txt' 12:54:22 INFO - no previously-included directories found matching 'build' 12:54:22 INFO - no previously-included directories found matching 'dist' 12:54:22 INFO - no previously-included directories found matching '.git*' 12:54:22 INFO - Successfully installed jsonschema functools32 12:54:22 INFO - Cleaning up... 12:54:22 INFO - Return code: 0 12:54:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:22 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 12:54:22 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 12:54:22 INFO - Using env: {'DISPLAY': ':0', 12:54:22 INFO - 'HOME': '/home/cltbld', 12:54:22 INFO - 'LANG': 'en_US.UTF-8', 12:54:22 INFO - 'LANGUAGE': 'en_US:en', 12:54:22 INFO - 'LOGNAME': 'cltbld', 12:54:22 INFO - 'MAIL': '/var/mail/cltbld', 12:54:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:22 INFO - 'MOZ_NO_REMOTE': '1', 12:54:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:22 INFO - 'NO_EM_RESTART': '1', 12:54:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:22 INFO - 'PWD': '/builds/slave/test', 12:54:22 INFO - 'SHELL': '/bin/bash', 12:54:22 INFO - 'SHLVL': '1', 12:54:22 INFO - 'TERM': 'linux', 12:54:22 INFO - 'TMOUT': '86400', 12:54:22 INFO - 'USER': 'cltbld', 12:54:22 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:22 INFO - '_': '/tools/buildbot/bin/python'} 12:54:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:22 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 12:54:25 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:25 INFO - Downloading docopt-0.6.1.tar.gz 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:26 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:26 INFO - Running setup.py install for blobuploader 12:54:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:26 INFO - Running setup.py install for requests 12:54:26 INFO - Running setup.py install for docopt 12:54:26 INFO - Successfully installed blobuploader requests docopt 12:54:26 INFO - Cleaning up... 12:54:26 INFO - Return code: 0 12:54:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:26 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:26 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 12:54:26 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 12:54:26 INFO - Using env: {'DISPLAY': ':0', 12:54:26 INFO - 'HOME': '/home/cltbld', 12:54:26 INFO - 'LANG': 'en_US.UTF-8', 12:54:26 INFO - 'LANGUAGE': 'en_US:en', 12:54:26 INFO - 'LOGNAME': 'cltbld', 12:54:26 INFO - 'MAIL': '/var/mail/cltbld', 12:54:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:26 INFO - 'MOZ_NO_REMOTE': '1', 12:54:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:26 INFO - 'NO_EM_RESTART': '1', 12:54:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:26 INFO - 'PWD': '/builds/slave/test', 12:54:26 INFO - 'SHELL': '/bin/bash', 12:54:26 INFO - 'SHLVL': '1', 12:54:26 INFO - 'TERM': 'linux', 12:54:26 INFO - 'TMOUT': '86400', 12:54:26 INFO - 'USER': 'cltbld', 12:54:26 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:26 INFO - '_': '/tools/buildbot/bin/python'} 12:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:26 INFO - Running setup.py (path:/tmp/pip-kaFcif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:26 INFO - Running setup.py (path:/tmp/pip-tDYj2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:26 INFO - Running setup.py (path:/tmp/pip-26WEsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:27 INFO - Running setup.py (path:/tmp/pip-j2tHH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:27 INFO - Running setup.py (path:/tmp/pip-ZM0fCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:27 INFO - Running setup.py (path:/tmp/pip-h_vWcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:27 INFO - Running setup.py (path:/tmp/pip-5zovnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:27 INFO - Running setup.py (path:/tmp/pip-5za2ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:27 INFO - Running setup.py (path:/tmp/pip-E3etiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:27 INFO - Running setup.py (path:/tmp/pip-1c8mmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:27 INFO - Running setup.py (path:/tmp/pip-xZ0vM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:27 INFO - Running setup.py (path:/tmp/pip-HvutlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:27 INFO - Running setup.py (path:/tmp/pip-0yLXNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:27 INFO - Running setup.py (path:/tmp/pip-Ai7wOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:27 INFO - Running setup.py (path:/tmp/pip-k0FHWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:27 INFO - Running setup.py (path:/tmp/pip-O2mpLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:27 INFO - Running setup.py (path:/tmp/pip-rqdNA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:28 INFO - Running setup.py install for manifestparser 12:54:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Running setup.py install for mozcrash 12:54:28 INFO - Running setup.py install for mozdebug 12:54:28 INFO - Running setup.py install for mozdevice 12:54:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Running setup.py install for mozfile 12:54:28 INFO - Running setup.py install for mozhttpd 12:54:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Running setup.py install for mozinfo 12:54:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Running setup.py install for mozInstall 12:54:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:28 INFO - Running setup.py install for mozleak 12:54:28 INFO - Running setup.py install for mozlog 12:54:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Running setup.py install for moznetwork 12:54:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Running setup.py install for mozprocess 12:54:29 INFO - Running setup.py install for mozprofile 12:54:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Running setup.py install for mozrunner 12:54:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Running setup.py install for mozscreenshot 12:54:29 INFO - Running setup.py install for moztest 12:54:29 INFO - Running setup.py install for mozversion 12:54:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:29 INFO - Cleaning up... 12:54:29 INFO - Return code: 0 12:54:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:29 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:29 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 12:54:29 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 12:54:29 INFO - Using env: {'DISPLAY': ':0', 12:54:29 INFO - 'HOME': '/home/cltbld', 12:54:29 INFO - 'LANG': 'en_US.UTF-8', 12:54:29 INFO - 'LANGUAGE': 'en_US:en', 12:54:29 INFO - 'LOGNAME': 'cltbld', 12:54:29 INFO - 'MAIL': '/var/mail/cltbld', 12:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:29 INFO - 'MOZ_NO_REMOTE': '1', 12:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:29 INFO - 'NO_EM_RESTART': '1', 12:54:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:29 INFO - 'PWD': '/builds/slave/test', 12:54:29 INFO - 'SHELL': '/bin/bash', 12:54:29 INFO - 'SHLVL': '1', 12:54:29 INFO - 'TERM': 'linux', 12:54:29 INFO - 'TMOUT': '86400', 12:54:29 INFO - 'USER': 'cltbld', 12:54:29 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:29 INFO - '_': '/tools/buildbot/bin/python'} 12:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:30 INFO - Running setup.py (path:/tmp/pip-IcvZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:30 INFO - Running setup.py (path:/tmp/pip-RvUfhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:30 INFO - Running setup.py (path:/tmp/pip-d8k4YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:30 INFO - Running setup.py (path:/tmp/pip-DiXvZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:30 INFO - Running setup.py (path:/tmp/pip-vSILLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:30 INFO - Running setup.py (path:/tmp/pip-cusBUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:30 INFO - Running setup.py (path:/tmp/pip-RXW6ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:30 INFO - Running setup.py (path:/tmp/pip-1rbpLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:30 INFO - Running setup.py (path:/tmp/pip-RZOko7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:30 INFO - Running setup.py (path:/tmp/pip-NH0Xhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:30 INFO - Running setup.py (path:/tmp/pip-wzUqu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:30 INFO - Running setup.py (path:/tmp/pip-vxYMTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:30 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)) 12:54:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:30 INFO - Running setup.py (path:/tmp/pip-0Bp8bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:31 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)) 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:31 INFO - Running setup.py (path:/tmp/pip-oepzrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:31 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)) 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:31 INFO - Running setup.py (path:/tmp/pip-heE68r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:31 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)) 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:31 INFO - Running setup.py (path:/tmp/pip-bWWVKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:31 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)) 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:31 INFO - Running setup.py (path:/tmp/pip-v4r_Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:31 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)) 12:54:31 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)) 12:54:31 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)) 12:54:31 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)) 12:54:31 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)) 12:54:31 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)) 12:54:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:33 INFO - Downloading blessings-1.6.tar.gz 12:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:33 INFO - Installing collected packages: blessings 12:54:33 INFO - Running setup.py install for blessings 12:54:33 INFO - Successfully installed blessings 12:54:33 INFO - Cleaning up... 12:54:33 INFO - Return code: 0 12:54:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:33 INFO - Reading from file tmpfile_stdout 12:54:33 INFO - Current package versions: 12:54:33 INFO - argparse == 1.2.1 12:54:33 INFO - blessings == 1.6 12:54:33 INFO - blobuploader == 1.2.4 12:54:33 INFO - docopt == 0.6.1 12:54:33 INFO - functools32 == 3.2.3-2 12:54:33 INFO - jsonschema == 2.5.1 12:54:33 INFO - manifestparser == 1.1 12:54:33 INFO - mozInstall == 1.12 12:54:33 INFO - mozcrash == 0.17 12:54:33 INFO - mozdebug == 0.1 12:54:33 INFO - mozdevice == 0.48 12:54:33 INFO - mozfile == 1.2 12:54:33 INFO - mozhttpd == 0.7 12:54:33 INFO - mozinfo == 0.9 12:54:33 INFO - mozleak == 0.1 12:54:33 INFO - mozlog == 3.2 12:54:33 INFO - moznetwork == 0.27 12:54:33 INFO - mozprocess == 0.23 12:54:33 INFO - mozprofile == 0.28 12:54:33 INFO - mozrunner == 6.12 12:54:33 INFO - mozscreenshot == 0.1 12:54:33 INFO - mozsystemmonitor == 0.3 12:54:33 INFO - moztest == 0.7 12:54:33 INFO - mozversion == 1.4 12:54:33 INFO - psutil == 3.1.1 12:54:33 INFO - requests == 1.2.3 12:54:33 INFO - wsgiref == 0.1.2 12:54:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:33 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 12:54:33 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 12:54:33 INFO - Using env: {'DISPLAY': ':0', 12:54:33 INFO - 'HOME': '/home/cltbld', 12:54:33 INFO - 'LANG': 'en_US.UTF-8', 12:54:33 INFO - 'LANGUAGE': 'en_US:en', 12:54:33 INFO - 'LOGNAME': 'cltbld', 12:54:33 INFO - 'MAIL': '/var/mail/cltbld', 12:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:33 INFO - 'MOZ_NO_REMOTE': '1', 12:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:33 INFO - 'NO_EM_RESTART': '1', 12:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:33 INFO - 'PWD': '/builds/slave/test', 12:54:33 INFO - 'SHELL': '/bin/bash', 12:54:33 INFO - 'SHLVL': '1', 12:54:33 INFO - 'TERM': 'linux', 12:54:33 INFO - 'TMOUT': '86400', 12:54:33 INFO - 'USER': 'cltbld', 12:54:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:33 INFO - '_': '/tools/buildbot/bin/python'} 12:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 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)) 12:54:33 INFO - Cleaning up... 12:54:33 INFO - Return code: 0 12:54:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:33 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 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:33 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 12:54:33 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 12:54:33 INFO - Using env: {'DISPLAY': ':0', 12:54:33 INFO - 'HOME': '/home/cltbld', 12:54:33 INFO - 'LANG': 'en_US.UTF-8', 12:54:33 INFO - 'LANGUAGE': 'en_US:en', 12:54:33 INFO - 'LOGNAME': 'cltbld', 12:54:33 INFO - 'MAIL': '/var/mail/cltbld', 12:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:33 INFO - 'MOZ_NO_REMOTE': '1', 12:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:33 INFO - 'NO_EM_RESTART': '1', 12:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:33 INFO - 'PWD': '/builds/slave/test', 12:54:33 INFO - 'SHELL': '/bin/bash', 12:54:33 INFO - 'SHLVL': '1', 12:54:33 INFO - 'TERM': 'linux', 12:54:33 INFO - 'TMOUT': '86400', 12:54:33 INFO - 'USER': 'cltbld', 12:54:33 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:33 INFO - '_': '/tools/buildbot/bin/python'} 12:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:34 INFO - Cleaning up... 12:54:34 INFO - Return code: 0 12:54:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc469badf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x137f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', '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 12:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:54:34 INFO - Using env: {'DISPLAY': ':0', 12:54:34 INFO - 'HOME': '/home/cltbld', 12:54:34 INFO - 'LANG': 'en_US.UTF-8', 12:54:34 INFO - 'LANGUAGE': 'en_US:en', 12:54:34 INFO - 'LOGNAME': 'cltbld', 12:54:34 INFO - 'MAIL': '/var/mail/cltbld', 12:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:34 INFO - 'MOZ_NO_REMOTE': '1', 12:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:34 INFO - 'NO_EM_RESTART': '1', 12:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:34 INFO - 'PWD': '/builds/slave/test', 12:54:34 INFO - 'SHELL': '/bin/bash', 12:54:34 INFO - 'SHLVL': '1', 12:54:34 INFO - 'TERM': 'linux', 12:54:34 INFO - 'TMOUT': '86400', 12:54:34 INFO - 'USER': 'cltbld', 12:54:34 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:34 INFO - '_': '/tools/buildbot/bin/python'} 12:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:34 INFO - Downloading/unpacking flake8 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:54:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:54:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:37 INFO - no previously-included directories found matching 'docs/_build' 12:54:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:54:37 INFO - Running setup.py install for pep8 12:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:37 INFO - no previously-included directories found matching 'docs/_build' 12:54:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:54:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:54:37 INFO - Cleaning up... 12:54:37 INFO - Return code: 0 12:54:37 INFO - Running post-action listener: _resource_record_post_action 12:54:37 INFO - Running post-action listener: _start_resource_monitoring 12:54:37 INFO - Starting resource monitoring. 12:54:37 INFO - ##### 12:54:37 INFO - ##### Finished create-virtualenv step (success) 12:54:37 INFO - ##### 12:54:37 INFO - ##### 12:54:37 INFO - ##### Running install step. 12:54:37 INFO - ##### 12:54:37 INFO - Running pre-action listener: _resource_record_pre_action 12:54:37 INFO - Running main action method: install 12:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:37 INFO - Reading from file tmpfile_stdout 12:54:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:37 INFO - Reading from file tmpfile_stdout 12:54:37 INFO - Output received: 12:54:37 INFO - Usage: mozinstall [options] installer 12:54:37 INFO - Options: 12:54:37 INFO - -h, --help show this help message and exit 12:54:37 INFO - -d DEST, --destination=DEST 12:54:37 INFO - Directory to install application into. [default: 12:54:37 INFO - "/builds/slave/test"] 12:54:37 INFO - --app=APP Application being installed. [default: firefox] 12:54:37 INFO - mkdir: /builds/slave/test/build/application 12:54:37 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'] 12:54:37 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 12:54:53 INFO - Reading from file tmpfile_stdout 12:54:53 INFO - Output received: 12:54:53 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:53 INFO - Running post-action listener: _resource_record_post_action 12:54:53 INFO - ##### 12:54:53 INFO - ##### Finished install step (success) 12:54:53 INFO - ##### 12:54:53 INFO - ##### 12:54:53 INFO - ##### Running run-tests step. 12:54:53 INFO - ##### 12:54:53 INFO - Running pre-action listener: _resource_record_pre_action 12:54:53 INFO - Running main action method: run_tests 12:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:53 INFO - Python 2.7.3 12:54:53 INFO - Return code: 0 12:54:53 INFO - grabbing minidump binary from tooltool 12:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:53 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 0x14de2e0>, '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 0x144a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x144a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:53 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 12:54:53 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 12:54:53 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 12:54:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:53 INFO - Return code: 0 12:54:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:54:54 INFO - Return code: 0 12:54:54 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/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:54:54 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/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 12:54:54 INFO - Using env: {'DISPLAY': ':0', 12:54:54 INFO - 'HOME': '/home/cltbld', 12:54:54 INFO - 'LANG': 'en_US.UTF-8', 12:54:54 INFO - 'LANGUAGE': 'en_US:en', 12:54:54 INFO - 'LOGNAME': 'cltbld', 12:54:54 INFO - 'MAIL': '/var/mail/cltbld', 12:54:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:54 INFO - 'MOZ_NO_REMOTE': '1', 12:54:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:54 INFO - 'NO_EM_RESTART': '1', 12:54:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:54 INFO - 'PWD': '/builds/slave/test', 12:54:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:54 INFO - 'SHELL': '/bin/bash', 12:54:54 INFO - 'SHLVL': '1', 12:54:54 INFO - 'TERM': 'linux', 12:54:54 INFO - 'TMOUT': '86400', 12:54:54 INFO - 'USER': 'cltbld', 12:54:54 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151', 12:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:54 INFO - '_': '/tools/buildbot/bin/python'} 12:54:54 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/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 12:54:54 INFO - mozversion application_buildid: 20160722101826 12:54:54 INFO - mozversion application_changeset: ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e 12:54:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:54:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:54 INFO - mozversion application_name: Firefox 12:54:54 INFO - mozversion application_remotingname: firefox-dev 12:54:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:54 INFO - mozversion application_vendor: Mozilla 12:54:54 INFO - mozversion application_version: 49.0a2 12:54:54 INFO - mozversion platform_buildid: 20160722101826 12:54:54 INFO - mozversion platform_changeset: ccbdbee8d758c6aaf43b22c1b745cc9a13d51a6e 12:54:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:54 INFO - mozversion platform_version: 49.0a2 12:54:54 INFO - using testdate: 1469217294 12:54:54 INFO - actual date: 1469217294 12:54:54 INFO - starting webserver on 'localhost:59050' 12:54:54 INFO - SUITE-START | Running 2 tests 12:54:54 INFO - TEST-START | dromaeo_css 12:54:54 INFO - operating with platform_type : linux_ 12:54:54 INFO - Initialising browser for dromaeo_css test... 12:54:54 INFO - TEST-INFO | started process 17345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptRkzDl/profile http://localhost:59050/getInfo.html) 12:54:59 INFO - PROCESS | 17345 | __metrics Screen width/height:1600/1200 12:54:59 INFO - PROCESS | 17345 | colorDepth:24 12:54:59 INFO - PROCESS | 17345 | Browser inner width/height: 1024/697 12:54:59 INFO - PROCESS | 17345 | __metrics 12:55:00 ERROR - PROCESS | 17345 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:55:00 INFO - TEST-INFO | 17345: exit 0 12:55:00 INFO - Browser initialized. 12:55:00 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:00 INFO - TEST-INFO | started process 17475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptRkzDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:12 INFO - PROCESS | 17475 | RSS: Main: 155901952 12:55:12 INFO - PROCESS | 17475 | 12:56:02 INFO - PROCESS | 17475 | 1469217362253 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] 12:58:10 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59050/tests/dromaeo/cssquery-ext.html) 12:58:11 INFO - PROCESS | 17475 | RSS: Main: 159055872 12:58:11 INFO - PROCESS | 17475 | 13:01:13 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-ext.html (next: http://localhost:59050/tests/dromaeo/cssquery-jquery.html) 13:01:13 INFO - PROCESS | 17475 | RSS: Main: 156930048 13:01:13 INFO - PROCESS | 17475 | 13:04:15 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59050/tests/dromaeo/cssquery-mootools.html) 13:04:16 INFO - PROCESS | 17475 | RSS: Main: 157298688 13:04:16 INFO - PROCESS | 17475 | 13:07:17 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59050/tests/dromaeo/cssquery-prototype.html) 13:07:18 INFO - PROCESS | 17475 | RSS: Main: 155758592 13:07:18 INFO - PROCESS | 17475 | 13:10:20 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59050/tests/dromaeo/cssquery-yui.html) 13:10:21 INFO - PROCESS | 17475 | RSS: Main: 157859840 13:10:21 INFO - PROCESS | 17475 | 13:13:23 INFO - PROCESS | 17475 | Cycle 1(1): loaded http://localhost:59050/tests/dromaeo/cssquery-yui.html (next: http://localhost:59050/tests/dromaeo/cssquery-dojo.html) 13:13:24 INFO - PROCESS | 17475 | RSS: Main: 158842880 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | __start_tp_report 13:13:24 INFO - PROCESS | 17475 | _x_x_mozilla_page_load 13:13:24 INFO - PROCESS | 17475 | _x_x_mozilla_page_load_details 13:13:24 INFO - PROCESS | 17475 | |i|pagename|runs| 13:13:24 INFO - PROCESS | 17475 | |0;dojo.html;3357.479590663447;3403.69366756992;3404.0128362774794;3434.82825858707;3434.879779207728;5571.832845014651;5585.162225666142;5602.971985140079;5636.887262254758;5692.0323544997345;5643.633163844347;5654.547636189105;5674.460926212003;5701.857453563663;5731.713414329277;5119.539241468267;5147.768350424221;5171.120909445384;5204.505571970676;5205.479452054802;5082.288479612857;5091.490850914897;5197.766100525486;5203.453637368059;5243.397009343936;5174.767135478894;5190.766415511311;5196.948030519684;5201.817936372227;5206.739663016834;5249.658772179815;5249.947500525003;5255.08036093682;5258;5287.180487024518;4987.226979818134;5011.423686276088;5043.344365232533;5175.637705360627;5191.766370513336;5521.337439507285;5534.695591742453;5542.612017158801;5546.112621980464;5549.667019978814;6071.939280607182;6072.089186621998;6084.361142080063;6086.360932102154;6090.756369745249;5955.523558115384;5995.310539287994;5997.490213331872;6006.219191505076;6112.235970503687;5620.718964051822;5655.830325090254;5659.773609055633;5672.68800215988;5674.404187560329;6146.508279337642;6175.660338681416;6187.3503282155625;6210.285817130997;6214.285357183891;5822.650640961556;5899.911501327483;5910.99513082777;5976.850578735566;6017.458428741435;6055.545834062463;6056.515478761688;6058.1518587397795;6065.3934606539;6065.4541091302;5887.234659494324;6045.576809623284;6057.515398768088;6065.514758819284;6082.422169893853;5952.434518720715;5964.940350596438;5997.880042399128;6025.15647809307;6069;4642.675012749075;4659.184642687516;4665.580097791215;4685.531446855355;4700.153972284953;4121.690873184463;4122.237386083584;4144.067584793458;4174.373843923436;4178.644815190682;5683.630564013326;5707;5721.342045664802;5853.03424934881;5933.199018132583;5985.790497332572;5998.910016349758;6002.459778619857;6004.819855404345;6009.789657362059;5686.516646085046;5756.079027355603;5761.308642962787;5762.827115186551;5767.798127065616;5126.231065340155;5136.691798492103;5175.585953123741;5191;5223.164293713064;6112.235970503687;6178.258608966953;6181.350958149419;6189.226346706661;6192.690365481798;5955.166276721176;5969.432903874299;6045.335013148638;6094.634321940698;6097.23784526943;6141.723622436912;6194;6201.534884883742;6205.193324867739;6208.9689551551955;5978.163057172086;5983.37174596661;5984;6010.639361638141;6030.969845150747;5918.615290006136;5978.192943952685;5994.100884867305;6011.549133815069;6048.6975651218145;5833.183354330482;5836.649801011953;5871.178035075179;5933.614315069507;5957.434043765836;5862.589618726648;5867.20792692998;5890.7349169288345;5896.852578685395;5901.380355062656;5661.66030038199;5778.797742079007;5785.508231800176;5838.795642152504;5882.588218824641;5939.227900372924;5988.161657367885;5991.910121348096;6003.279606447254;6014.188084608521;5859.296884373903;5866.2373891393845;5873.177755114373;5889.5582831286965;5893.5874488787085 13:13:24 INFO - PROCESS | 17475 | |1;ext.html;580.8286555466137;647.8412788866727;663.5719960625397;664.7872680742163;666.0342503370115;46184;47911;48148.75925620372;48178.27732584014;50707.492925070736;48820;48912.755436222855;49010.26484602734;49182.262266066034;49766.75116624412;8934.06192349802;9106.271498280155;9123.08769123089;9162.496062716547;9226.123518265755;8957;9068.546572671374;9113.95443022784;9116.407433516833;9136.086391360877;9094.181523662903;9145.542722863864;9150.771230719252;9151.130642588943;9160.45037297761;9053.59258833354;9081.682141125062;9084.727458176265;9093.136152065543;9129.315301352392;9037.277017838556;9077.63689452421;9129.360944733804;9141.314401419853;9163.221126204215;44203.77898110521;44435.55564444346;44447.222111115516;44467.77766111149;44559.331610025874;3833;3833.252515759428;3889.027743064234;3907.648311651965;4006.779627120507;33812.49281260783;34663;34755.47866782;34852;35070.47394289088;4681.953180468186;4685.390899183119;4697.201475749131;4733.337332773414;4804.6876952997945;262411;262966;263284;264021;264844;63388;64127;64312.35687643157;64358.67820660867;64385.67807160934;39724.40413393801;40682.59317406788;40687.38968915468;42057.57942420598;42576;19136.330228441937;19163.13765880511;19196.520086997658;19199.136038878285;19292.4212273632;15087.24563771829;15162.090274583561;15200.771988420183;15208.923955380153;15233.923830380778;21558.46103847385;21716.89141554282;21736;21737.891310543662;21873.67189492159;7712.537247765152;7744.612769361509;8003.8799418008775;8035.236652518001;8074;1027.3117011602244;1094.7044298039643;1099.7191150635726;1192.7554851255472;1193.8567371915426;34029.82985085059;34173;34248.48627270593;34717;35030;1177.8645455772696;1269.5175833183332;1269.8920591749804;1279.929603871796;1305.8367704036996;17791.55521111957;17898.194581243875;17926.5518362042;18303.72544411835;18465.81534184668;606093;619218;621444;625351;999163;59976.40023599796;60715.08927366093;60759;60795;60799;1470.985290147085;1486.3385793322084;1495.6410461489165;1496.9625759356104;1504.5185540626894;32283.677163229007;33033.66966330402;33367.49948750722;33608.66391336153;33665.15837103994;52121.7393913028;52250;52457.47542524526;52641.210381843535;52645.47354526406;386308;388044;388873;388994;389427.10572893906;29292.707072929;29811.850940746026;30504;31092.844535777178;31512.054638360885;51081.23378149256;51552;52026.959460811326;52151;53061.734691326295;39913;42072.789636051624;42899.57100428956;43013.56986430221;44089.779551103326;41530.37704434496;41943.7902810484;42196.789016054725;42502.57497424986;43039.784801075795;43499.565004350814;43823;43966.340504891814;44051.33922991222;44345.55654443414;36315;36458.94581585188;36711.816440918694;37103.44344834776;37386;28826.711732882402;29480.557791632713;29626.111216663536;29657.406851863274;29727.851360743058 13:13:24 INFO - PROCESS | 17475 | |2;jquery.html;413.4253387790971;419.06966534293895;426.61817673182503;427.8352834158849;432.4378308199342;18555.814441855593;19436.90281548592;20194.59610807783;20205.797942020574;20339.59320813583;19015.239390424365;19015.429537113872;19185.52036199096;19864.900675496603;19916.900415497938;5853.5902486825835;6053.031514957607;6075.301340345873;6089.634621922699;6101.359357267467;4398.604125628693;5962.552808539355;6019.067044608093;6422.421982021617;6745.3591908768585;6791.864162716743;6798.150231221098;6816.454683625323;6827.863442731143;6832.111825462683;6507.869842603145;6709.161354830646;6712.697928593225;6747.156605424347;6757.763478278262;5808.070708686632;6016.458518733291;6029;6039.094135879609;6074.088886666991;23317;23422.531549369087;23609;23830.404239893967;23920.7607923922;2488.5147396257735;2557.936051598725;2638.722934091912;2651.6552848129813;2827.137722994486;14644.194569298685;15282.541523754306;15391.153486558234;15465.381384744596;15573.299201535958;2051.3435700575824;2064.7522297324417;2066.555690526544;2100.5063810004635;2123.1295168980796;79150;82811.5859420699;83192;83656;84078;11159.888401115884;11361.772764544663;11362.431878406212;11560.421978901022;11567.479463424166;16050;16170.75743863843;16225.51323460298;16286.755698664529;16317.531422172062;8726.476411415335;8853.867191992125;8872.822543549222;8968.417052891542;8997.595108220146;8615.655373785105;8616.827663446697;8648.610812513452;8649.783755406039;8743.213110820057;6875.174979002451;7037.824054398681;7056.54132481387;7076.2923707628825;7189.496735228484;1906.4757191772096;1907.389635316713;2034.7049677796933;2057.444489987695;2072.316135675254;1018.6842078955399;1076.6716151573846;1082.8105081610686;1098.9230753847314;1129.6046383765615;19478.318258861156;19902.203911843655;19967.600647986957;20030.799692003184;20365.592688146153;1097.2703152403722;1105.9557617695364;1129.565117429779;1151.3034614058543;1155.624422062833;11328.150388720878;11603.419829008515;11617.88382116185;11654.53381864716;11723.237989530653;537322;542972;545695;546981;550499;81850;81891;84923;85814.57092714496;86580;1098.2916019167592;1113.2263077161294;1119.1494464207099;1125.7748450309807;1134.5631931706187;17742.290308388037;18157.546061348043;18233.726494102335;18273.3604323848;18321.816781832546;38515.229695406495;39273.80363098166;39389.6061039386;39687.60312396839;41308.38037429381;53190.2021469686;53576.73211633917;53708;54018.18972715491;54021.45978540164;8616.526091065052;8832.779180520538;8846.424982376126;9083.04628014049;9163;12855.550055748005;13291.401886914919;13712.17726936387;13956.930215348859;14285.714285714435;11846.229995050639;11953.282803031845;12255.571055013388;12557.246565206116;12593.307368094842;11503.76992460163;12083.879161208275;12360.25838449696;12471.688207794878;12683.98528117767;6154.723037463235;10482.266241363031;12174.330411827434;12212.816807747713;12449.37753112359;8999.730008099768;9034.86447703272;9097.090290971115;9261.398009129385;9298.628054877729;12157.331346776013;12320.815187772012;12435.37823108859;12451.875481245072;12515.56195533152 13:13:24 INFO - PROCESS | 17475 | |3;mootools.html;1551.1236151574362;1552.9068255904642;1772.175938188742;1910.5892233169884;1918.63545926274;8455.408121431503;9036.68371606993;9148.817023659523;9657.806843863127;9659.951700241498;9242.30682698797;9479.336446448751;9505.049495050509;9595.088466595662;9609.855852162224;2434.172381390327;2490.9786987335196;2491.277529516438;2491.3397949543387;2491.4643351679383;2425.866577338246;2491.8878650460683;2498.462830491444;2499.487605040962;2499.7750202481775;2434.2332165367943;2454.361865914866;2504.2236906558933;2506.6616006839117;2509.648649189115;2385.4990452005013;2388.1402695029774;2390.1156572068357;2456.4350199454225;2458.0659349447274;2362.598358279097;2364.4443555764383;2375.928722138339;2380.8214383921104;2414.2153800015067;9451.669191578261;9479.763005924839;9562.95218523903;9580.281478889041;9611.56747946337;5509.724513774296;5657.264555607786;5671.06427439472;5674.687892165929;5686.829395118111;3404.131946353664;3420.110771199481;3484.9477257841154;3492.336456073338;3501.3872572299747;1195.9521619135223;1205.7769312677094;1208.9818652720128;1226.760781647579;1232.3961258983124;13158.342082895817;13176.802347964789;13227.404766785517;13269.402876870467;13298.933505332412;4761.714297142183;4795.335554497878;4882.7558622068755;4936.099601653389;4958.528939750718;11200.719982000515;11240.49417776202;11243.381614011145;11249.43752812356;11272.323660580392;5612.887742245214;5641.576881733887;5722.227499287626;5731.283589551306;5737.913931291034;4612.100640375162;5051.444341122474;5177.456367081478;5193.818216362409;5290.232916227125;4308.590683885026;4347.543507931685;4365.672574556921;4373.6282415994365;4397.978010109929;1285.4408332375447;1289.3231053696884;1308.3523655790254;1309.3518708239483;1337.9264140472367;1048.0881632979356;1053.7945100705442;1060.9787804243872;1071.7481391872905;1081.767420004687;6563.606183628997;6574.934250657432;6673.733050677918;6682.732690692415;6685.899711504331;491.8032786885203;502.03859608848643;503.6172508893267;509.0760270109739;513.3941948500805;4452.4211852458975;4452.977735111303;4476;4492.797824097924;4527.411436513298;11472.196946213686;12059.336736479578;12076.577319793765;12096.81854772179;12110.455029523693;11910.761784764256;11911;11918.927296543352;11925.821112683318;11936.343501107522;8495.872561911576;8702.564871756387;8762.430442021248;9007;9007.819843603222;6410.679466026773;6697.698603562949;6713.093732346266;6796.728130874907;6806.863862722619;10523.315984460985;10955.616553420592;11021.393823339793;11037.779244414905;11146.777064458827;11078.944605276922;11160.441977901235;11197.104231661284;11265.380404077854;11361.886381136082;8222;8335.416520843482;8454.873176902229;8494.1081186477;8500.574971251537;9175.816483670424;9176.08239176077;9181.173694367539;9241.953790231006;9288.396254243453;8291.461055031403;8433.831323373375;8447;8550.05949345559;8573.699920502753;8263.934974278096;8307.501549907025;8439.578021099043;8445.66217351299;8448.535330556879;7412.777616671508;7478.364339031025;7494.288042635941;7499.962500187464;7511.248875112664;5111.718855462986;5154.664946778447;5235.712035838065;5338.4394638563945;5363.03465376236;5291.391489978701;5340.305760251143;5402.621816472809;5447.346318441812;5570.275864137636 13:13:24 INFO - PROCESS | 17475 | |4;prototype.html;353.1859064855508;353.2422952766315;354.5514923621619;365.2694610778443;371.28527584400024;5590.965671350803;5780.884382312352;5783.6240644358195;5813.563982701298;5846.795362162326;5617.522510586605;5644.491995720385;5649.519790817785;5660.688662123582;5671.177679236519;4086.5504794472586;4433.13553856998;4490.393796837434;4516.864494065183;4527.411436513249;4387.210302145612;4401.119776044788;4415.867523974286;4429.379886815848;4436.600705936465;4348.826046958118;4392.5827046430695;4406.911861762763;4418.9337159942625;4421.823127074913;4280.935785963213;4418.801153948048;4427.734335939837;4431.512533621315;4475.261581839009;3948.861789837342;3964;3969.5236571611304;3977.940330895039;4000.7599544027453;5382.381026182;5461.262729531502;5470.343558772933;5473.589480788957;5478.890422191534;4948.777305021283;5126.308318254967;5127.461616530248;5134.870328527718;5148.61385396093;5923.200367950358;5935.020721580934;5945.583809133363;5948.434898684618;5949;4359.215341238576;4362.912741745179;4370.7159034662645;4373.497047839507;4375;5847.649141051551;6154.32302446735;6180.690965451754;6241.28225254097;6257.749690012394;4417;4479.59683628475;4480;4480.686351955332;4495.235809912323;4532.456105267323;4536.478304994902;4536.61438777701;4540.72755634663;4540.77296135192;5031.295618613397;5099.6685215460875;5118.59051275897;5136.306598609214;5158.200478925773;5890.8821823563285;5944.286685597756;5957.314908785458;5966.284045914431;5972.85067873298;1570.7565327374275;1581.8655414289683;1585.905725049712;1589.2609936379638;1599.9840001599835;995.1740055753708;1013.7769690668041;1014.680914810743;1015.21828192293;1040.7554224757175;5762.855928601734;5791.581062639681;5808.879758887975;5830;5842.591018628656;6014.849628759316;6017.0974353846395;6037.6679282639;6056.848578785565;6116.327204007555;5677.914831277534;5791.449812267912;5791.8552036199435;5808.738606762706;5866.67733274674;3258.1528802511043;3271.2639656077667;3273.216097227017;3291.8683252669625;3294.258791771832;5927.288725352985;6069.817905462844;6215.409536094064;6244.344343843922;6279.874402511924;6098.32918378978;6125.203723515914;6139.324674285825;6167.259928808482;6184.81445556634;6055.305389101807;6133.417325354084;6163.630182189083;6170.938290617126;6235.314115447388;5888.087346461305;6119.479844213113;6133.969330153321;6138;6138.907916381168;5952.375000625046;5991.2510936132985;6002.98899868549;6003.579749417673;6015.338312785678;5960.5827592068135;6177.536684748572;6179.84550386226;6330.968345158245;6348.460380867678;4303.289957157159;4346.673999450117;4349.739015659071;4360.825566977285;4376.365427013002;6220.968895155495;6246.46905013079;6269.059641053878;6279.748810047547;6292.276388215414;5771.961047011579;5975.312839023568;6071.787487437919;6102.908456373247;6114.174586430775;5992.610480318765;6029.909551356645;6044.9395506044375;6053.697315134137;6085.05681619332;5622.887542249214;5758.424157584208;5916.112583112567;5930.555208359304;5982.49148822355;5991.700414979321;6008.8798224036145;6009.969950150221;6086;6107.144999699956;5918.7928422505;5941.970290148522;6014.939850601438;6045.909311360245;6048.637081775108 13:13:24 INFO - PROCESS | 17475 | |5;yui.html;803.1085495100438;833.6998680475028;856.4818284937617;880.1066917079162;887.1173182683231;14808.259587020646;15444;15520.379184832607;15636.609084772857;15673.84326156741;15254.466093686724;15323.387064517407;15453.845461545381;15454.768178477332;15493.92253038736;711.8967749676319;838.8657814749641;849.2653854415933;859.5916939453772;861.2464093917822;851.9829603407928;855.5935930433056;856.8500512410335;859.6045818923303;860.3977215948829;905.0632595263903;908.0601577367426;909.3498148823589;909.3589019741099;912.2519533982104;898.0839543665425;902.7517432705993;902.7517432705993;904.1546154345642;904.9909500905005;662.7249691378072;664.621165935417;664.930182330858;666.2504682232488;666.3369946902862;15058.171800550965;15073.623159420993;15182.544523664197;15188.240587970668;15188.924055379652;14437.783433248509;16188.503107605567;16444.506664800076;16642.667146657;16802.83197168025;14057.086289391156;14247.715045699131;14545.854541454555;14823;14880.553583392515;4632.490426053131;4760.95239047612;4782.569568738831;4904.975475122637;4978.427480839714;64215.35784642141;66729.3327066728;66929.3307066928;75983.62008189979;76039.6198019012;12328.445219965122;12786.424610892345;12847.486100555872;12893.226406415457;12986.285754283605;22171.445713857283;22266.88866555657;22282;22318.330450086523;22320.776792232195;8974;8975.506347150838;9063.54682265884;9288.582013809395;9364.15722584957;5252.632315737938;5299.576033917355;5349.170878513836;5393.6224464287125;5487.314085739283;3787.696984241254;3804.752691075071;3928.5874983126932;3936.626020528045;3946.625070618287;702.0872865275122;709.0250905005618;719.4208662027014;720.2113685514354;723.1502983993786;642.7364780440091;745.7166276814776;793.1830214878685;809.4819315637997;818.1899919080187;10618.761277810341;10933.289336193122;10950.178736594788;11030.28303160292;11190.440477976068;721.404841006172;725.0972539188743;726.117766913203;788.3023524181141;821.5645707774889;5181.611379146504;5379.193121031876;5468.699221542774;5491.395946445888;5614.63504872182;128703.35648321698;132145.33927330494;133832;135720;135728;106309.4684526588;110847.44576277229;111214;115311;116222.41888790502;96879.03120968842;98880;100058.499707501;100683;102002;8140.267375936194;8354.331653467829;9717.951410242904;10221.693349199535;10303.072723454925;56846.147307791245;57996.55008624818;58106.83786324165;59140;59497.7025114889;49802.501974981235;49862.50137498578;54823.451765481834;84345.57827210825;84805;13253.271070090852;13301.80047299272;13538.052336336363;13543.458261669422;13917.443302267797;15051;15104.773428398363;15380.461683841011;15810.209489525707;15829;12824.871751282368;12908;13052.34738263102;13200.075994680665;13332.666683332607;13175.736485270048;13447.529336473177;13454.058215924792;14267.143971361336;14304.928475357972;14185.219812909976;14365.13809171453;14388.496402625859;14417.1349719013;14475.638109047359;11381.54473821038;11511.136664750346;11592.710182245512;11835.171537992257;12109.515619375126;11026.669199924016;11884.881151188378;11971.10216733731;12016.279023258632;12324.445399956845 13:13:24 INFO - PROCESS | 17475 | __end_tp_report 13:13:24 INFO - PROCESS | 17475 | __start_cc_report 13:13:24 INFO - PROCESS | 17475 | _x_x_mozilla_cycle_collect,329 13:13:24 INFO - PROCESS | 17475 | __end_cc_report 13:13:24 INFO - PROCESS | 17475 | __startTimestamp1469218404024__endTimestamp 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | ------- Summary: start ------- 13:13:24 INFO - PROCESS | 17475 | Number of tests: 6 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#0] dojo.html Cycles:165 Average:5617.83 Median:5862.59 stddev:609.21 (10.4%) stddev-sans-first:584.70 13:13:24 INFO - PROCESS | 17475 | Values: 3357.5 3403.7 3404.0 3434.8 3434.9 5571.8 5585.2 5603.0 5636.9 5692.0 5643.6 5654.5 5674.5 5701.9 5731.7 5119.5 5147.8 5171.1 5204.5 5205.5 5082.3 5091.5 5197.8 5203.5 5243.4 5174.8 5190.8 5196.9 5201.8 5206.7 5249.7 5249.9 5255.1 5258.0 5287.2 4987.2 5011.4 5043.3 5175.6 5191.8 5521.3 5534.7 5542.6 5546.1 5549.7 6071.9 6072.1 6084.4 6086.4 6090.8 5955.5 5995.3 5997.5 6006.2 6112.2 5620.7 5655.8 5659.8 5672.7 5674.4 6146.5 6175.7 6187.4 6210.3 6214.3 5822.7 5899.9 5911.0 5976.9 6017.5 6055.5 6056.5 6058.2 6065.4 6065.5 5887.2 6045.6 6057.5 6065.5 6082.4 5952.4 5964.9 5997.9 6025.2 6069.0 4642.7 4659.2 4665.6 4685.5 4700.2 4121.7 4122.2 4144.1 4174.4 4178.6 5683.6 5707.0 5721.3 5853.0 5933.2 5985.8 5998.9 6002.5 6004.8 6009.8 5686.5 5756.1 5761.3 5762.8 5767.8 5126.2 5136.7 5175.6 5191.0 5223.2 6112.2 6178.3 6181.4 6189.2 6192.7 5955.2 5969.4 6045.3 6094.6 6097.2 6141.7 6194.0 6201.5 6205.2 6209.0 5978.2 5983.4 5984.0 6010.6 6031.0 5918.6 5978.2 5994.1 6011.5 6048.7 5833.2 5836.6 5871.2 5933.6 5957.4 5862.6 5867.2 5890.7 5896.9 5901.4 5661.7 5778.8 5785.5 5838.8 5882.6 5939.2 5988.2 5991.9 6003.3 6014.2 5859.3 5866.2 5873.2 5889.6 5893.6 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#1] ext.html Cycles:180 Average:61845.41 Median:42737.79 stddev:131973.49 (308.8%) stddev-sans-first:132263.55 13:13:24 INFO - PROCESS | 17475 | Values: 580.8 647.8 663.6 664.8 666.0 46184.0 47911.0 48148.8 48178.3 50707.5 48820.0 48912.8 49010.3 49182.3 49766.8 8934.1 9106.3 9123.1 9162.5 9226.1 8957.0 9068.5 9114.0 9116.4 9136.1 9094.2 9145.5 9150.8 9151.1 9160.5 9053.6 9081.7 9084.7 9093.1 9129.3 9037.3 9077.6 9129.4 9141.3 9163.2 44203.8 44435.6 44447.2 44467.8 44559.3 3833.0 3833.3 3889.0 3907.6 4006.8 33812.5 34663.0 34755.5 34852.0 35070.5 4682.0 4685.4 4697.2 4733.3 4804.7 262411.0 262966.0 263284.0 264021.0 264844.0 63388.0 64127.0 64312.4 64358.7 64385.7 39724.4 40682.6 40687.4 42057.6 42576.0 19136.3 19163.1 19196.5 19199.1 19292.4 15087.2 15162.1 15200.8 15208.9 15233.9 21558.5 21716.9 21736.0 21737.9 21873.7 7712.5 7744.6 8003.9 8035.2 8074.0 1027.3 1094.7 1099.7 1192.8 1193.9 34029.8 34173.0 34248.5 34717.0 35030.0 1177.9 1269.5 1269.9 1279.9 1305.8 17791.6 17898.2 17926.6 18303.7 18465.8 606093.0 619218.0 621444.0 625351.0 999163.0 59976.4 60715.1 60759.0 60795.0 60799.0 1471.0 1486.3 1495.6 1497.0 1504.5 32283.7 33033.7 33367.5 33608.7 33665.2 52121.7 52250.0 52457.5 52641.2 52645.5 386308.0 388044.0 388873.0 388994.0 389427.1 29292.7 29811.9 30504.0 31092.8 31512.1 51081.2 51552.0 52027.0 52151.0 53061.7 39913.0 42072.8 42899.6 43013.6 44089.8 41530.4 41943.8 42196.8 42502.6 43039.8 43499.6 43823.0 43966.3 44051.3 44345.6 36315.0 36458.9 36711.8 37103.4 37386.0 28826.7 29480.6 29626.1 29657.4 29727.9 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#2] jquery.html Cycles:180 Average:30717.64 Median:23515.77 stddev:89266.31 (379.6%) stddev-sans-first:89487.72 13:13:24 INFO - PROCESS | 17475 | Values: 413.4 419.1 426.6 427.8 432.4 18555.8 19436.9 20194.6 20205.8 20339.6 19015.2 19015.4 19185.5 19864.9 19916.9 5853.6 6053.0 6075.3 6089.6 6101.4 4398.6 5962.6 6019.1 6422.4 6745.4 6791.9 6798.2 6816.5 6827.9 6832.1 6507.9 6709.2 6712.7 6747.2 6757.8 5808.1 6016.5 6029.0 6039.1 6074.1 23317.0 23422.5 23609.0 23830.4 23920.8 2488.5 2557.9 2638.7 2651.7 2827.1 14644.2 15282.5 15391.2 15465.4 15573.3 2051.3 2064.8 2066.6 2100.5 2123.1 79150.0 82811.6 83192.0 83656.0 84078.0 11159.9 11361.8 11362.4 11560.4 11567.5 16050.0 16170.8 16225.5 16286.8 16317.5 8726.5 8853.9 8872.8 8968.4 8997.6 8615.7 8616.8 8648.6 8649.8 8743.2 6875.2 7037.8 7056.5 7076.3 7189.5 1906.5 1907.4 2034.7 2057.4 2072.3 1018.7 1076.7 1082.8 1098.9 1129.6 19478.3 19902.2 19967.6 20030.8 20365.6 1097.3 1106.0 1129.6 1151.3 1155.6 11328.2 11603.4 11617.9 11654.5 11723.2 537322.0 542972.0 545695.0 546981.0 550499.0 81850.0 81891.0 84923.0 85814.6 86580.0 1098.3 1113.2 1119.1 1125.8 1134.6 17742.3 18157.5 18233.7 18273.4 18321.8 38515.2 39273.8 39389.6 39687.6 41308.4 53190.2 53576.7 53708.0 54018.2 54021.5 8616.5 8832.8 8846.4 9083.0 9163.0 12855.6 13291.4 13712.2 13956.9 14285.7 11846.2 11953.3 12255.6 12557.2 12593.3 11503.8 12083.9 12360.3 12471.7 12684.0 6154.7 10482.3 12174.3 12212.8 12449.4 8999.7 9034.9 9097.1 9261.4 9298.6 12157.3 12320.8 12435.4 12451.9 12515.6 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#3] mootools.html Cycles:180 Average:6251.28 Median:4686.91 stddev:3620.14 (77.2%) stddev-sans-first:3613.06 13:13:24 INFO - PROCESS | 17475 | Values: 1551.1 1552.9 1772.2 1910.6 1918.6 8455.4 9036.7 9148.8 9657.8 9660.0 9242.3 9479.3 9505.0 9595.1 9609.9 2434.2 2491.0 2491.3 2491.3 2491.5 2425.9 2491.9 2498.5 2499.5 2499.8 2434.2 2454.4 2504.2 2506.7 2509.6 2385.5 2388.1 2390.1 2456.4 2458.1 2362.6 2364.4 2375.9 2380.8 2414.2 9451.7 9479.8 9563.0 9580.3 9611.6 5509.7 5657.3 5671.1 5674.7 5686.8 3404.1 3420.1 3484.9 3492.3 3501.4 1196.0 1205.8 1209.0 1226.8 1232.4 13158.3 13176.8 13227.4 13269.4 13298.9 4761.7 4795.3 4882.8 4936.1 4958.5 11200.7 11240.5 11243.4 11249.4 11272.3 5612.9 5641.6 5722.2 5731.3 5737.9 4612.1 5051.4 5177.5 5193.8 5290.2 4308.6 4347.5 4365.7 4373.6 4398.0 1285.4 1289.3 1308.4 1309.4 1337.9 1048.1 1053.8 1061.0 1071.7 1081.8 6563.6 6574.9 6673.7 6682.7 6685.9 491.8 502.0 503.6 509.1 513.4 4452.4 4453.0 4476.0 4492.8 4527.4 11472.2 12059.3 12076.6 12096.8 12110.5 11910.8 11911.0 11918.9 11925.8 11936.3 8495.9 8702.6 8762.4 9007.0 9007.8 6410.7 6697.7 6713.1 6796.7 6806.9 10523.3 10955.6 11021.4 11037.8 11146.8 11078.9 11160.4 11197.1 11265.4 11361.9 8222.0 8335.4 8454.9 8494.1 8500.6 9175.8 9176.1 9181.2 9242.0 9288.4 8291.5 8433.8 8447.0 8550.1 8573.7 8263.9 8307.5 8439.6 8445.7 8448.5 7412.8 7478.4 7494.3 7500.0 7511.2 5111.7 5154.7 5235.7 5338.4 5363.0 5291.4 5340.3 5402.6 5447.3 5570.3 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#4] prototype.html Cycles:180 Average:5033.52 Median:5782.25 stddev:1463.10 (25.3%) stddev-sans-first:1424.41 13:13:24 INFO - PROCESS | 17475 | Values: 353.2 353.2 354.6 365.3 371.3 5591.0 5780.9 5783.6 5813.6 5846.8 5617.5 5644.5 5649.5 5660.7 5671.2 4086.6 4433.1 4490.4 4516.9 4527.4 4387.2 4401.1 4415.9 4429.4 4436.6 4348.8 4392.6 4406.9 4418.9 4421.8 4280.9 4418.8 4427.7 4431.5 4475.3 3948.9 3964.0 3969.5 3977.9 4000.8 5382.4 5461.3 5470.3 5473.6 5478.9 4948.8 5126.3 5127.5 5134.9 5148.6 5923.2 5935.0 5945.6 5948.4 5949.0 4359.2 4362.9 4370.7 4373.5 4375.0 5847.6 6154.3 6180.7 6241.3 6257.7 4417.0 4479.6 4480.0 4480.7 4495.2 4532.5 4536.5 4536.6 4540.7 4540.8 5031.3 5099.7 5118.6 5136.3 5158.2 5890.9 5944.3 5957.3 5966.3 5972.9 1570.8 1581.9 1585.9 1589.3 1600.0 995.2 1013.8 1014.7 1015.2 1040.8 5762.9 5791.6 5808.9 5830.0 5842.6 6014.8 6017.1 6037.7 6056.8 6116.3 5677.9 5791.4 5791.9 5808.7 5866.7 3258.2 3271.3 3273.2 3291.9 3294.3 5927.3 6069.8 6215.4 6244.3 6279.9 6098.3 6125.2 6139.3 6167.3 6184.8 6055.3 6133.4 6163.6 6170.9 6235.3 5888.1 6119.5 6134.0 6138.0 6138.9 5952.4 5991.3 6003.0 6003.6 6015.3 5960.6 6177.5 6179.8 6331.0 6348.5 4303.3 4346.7 4349.7 4360.8 4376.4 6221.0 6246.5 6269.1 6279.7 6292.3 5772.0 5975.3 6071.8 6102.9 6114.2 5992.6 6029.9 6044.9 6053.7 6085.1 5622.9 5758.4 5916.1 5930.6 5982.5 5991.7 6008.9 6010.0 6086.0 6107.1 5918.8 5942.0 6014.9 6045.9 6048.6 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - PROCESS | 17475 | [#5] yui.html Cycles:180 Average:22203.27 Median:3796.22 stddev:32910.62 (866.9%) stddev-sans-first:32963.72 13:13:24 INFO - PROCESS | 17475 | Values: 803.1 833.7 856.5 880.1 887.1 14808.3 15444.0 15520.4 15636.6 15673.8 15254.5 15323.4 15453.8 15454.8 15493.9 711.9 838.9 849.3 859.6 861.2 852.0 855.6 856.9 859.6 860.4 905.1 908.1 909.3 909.4 912.3 898.1 902.8 902.8 904.2 905.0 662.7 664.6 664.9 666.3 666.3 15058.2 15073.6 15182.5 15188.2 15188.9 14437.8 16188.5 16444.5 16642.7 16802.8 14057.1 14247.7 14545.9 14823.0 14880.6 4632.5 4761.0 4782.6 4905.0 4978.4 64215.4 66729.3 66929.3 75983.6 76039.6 12328.4 12786.4 12847.5 12893.2 12986.3 22171.4 22266.9 22282.0 22318.3 22320.8 8974.0 8975.5 9063.5 9288.6 9364.2 5252.6 5299.6 5349.2 5393.6 5487.3 3787.7 3804.8 3928.6 3936.6 3946.6 702.1 709.0 719.4 720.2 723.2 642.7 745.7 793.2 809.5 818.2 10618.8 10933.3 10950.2 11030.3 11190.4 721.4 725.1 726.1 788.3 821.6 5181.6 5379.2 5468.7 5491.4 5614.6 128703.4 132145.3 133832.0 135720.0 135728.0 106309.5 110847.4 111214.0 115311.0 116222.4 96879.0 98880.0 100058.5 100683.0 102002.0 8140.3 8354.3 9718.0 10221.7 10303.1 56846.1 57996.6 58106.8 59140.0 59497.7 49802.5 49862.5 54823.5 84345.6 84805.0 13253.3 13301.8 13538.1 13543.5 13917.4 15051.0 15104.8 15380.5 15810.2 15829.0 12824.9 12908.0 13052.3 13200.1 13332.7 13175.7 13447.5 13454.1 14267.1 14304.9 14185.2 14365.1 14388.5 14417.1 14475.6 11381.5 11511.1 11592.7 11835.2 12109.5 11026.7 11884.9 11971.1 12016.3 12324.4 13:13:24 INFO - PROCESS | 17475 | -------- Summary: end -------- 13:13:24 INFO - PROCESS | 17475 | 13:13:24 INFO - TEST-INFO | 17475: exit 0 13:13:24 INFO - TEST-OK | dromaeo_css | took 1110120ms 13:13:24 INFO - TEST-START | kraken 13:13:24 INFO - operating with platform_type : linux_ 13:13:24 INFO - Initialising browser for kraken test... 13:13:24 INFO - TEST-INFO | started process 17719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7WVEYa/profile http://localhost:59050/getInfo.html) 13:13:29 INFO - PROCESS | 17719 | __metrics Screen width/height:1600/1200 13:13:29 INFO - PROCESS | 17719 | colorDepth:24 13:13:29 INFO - PROCESS | 17719 | Browser inner width/height: 1024/697 13:13:29 INFO - PROCESS | 17719 | __metrics 13:13:30 ERROR - PROCESS | 17719 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:13:30 INFO - TEST-INFO | 17719: exit 0 13:13:30 INFO - Browser initialized. 13:13:30 INFO - Running cycle 1/1 for kraken test... 13:13:30 INFO - TEST-INFO | started process 17847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7WVEYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:42 INFO - PROCESS | 17847 | RSS: Main: 156135424 13:13:42 INFO - PROCESS | 17847 | 13:13:45 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59050/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:46 INFO - PROCESS | 17847 | RSS: Main: 162017280 13:13:46 INFO - PROCESS | 17847 | 13:13:48 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59050/tests/kraken/driver.html?testName=audio-dft) 13:13:49 INFO - PROCESS | 17847 | RSS: Main: 160751616 13:13:49 INFO - PROCESS | 17847 | 13:13:52 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59050/tests/kraken/driver.html?testName=audio-fft) 13:13:52 INFO - PROCESS | 17847 | RSS: Main: 161480704 13:13:52 INFO - PROCESS | 17847 | 13:13:55 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59050/tests/kraken/driver.html?testName=audio-oscillator) 13:13:55 INFO - PROCESS | 17847 | RSS: Main: 160735232 13:13:55 INFO - PROCESS | 17847 | 13:13:57 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59050/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:58 INFO - PROCESS | 17847 | RSS: Main: 160772096 13:13:58 INFO - PROCESS | 17847 | 13:14:01 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59050/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:02 INFO - PROCESS | 17847 | RSS: Main: 160370688 13:14:02 INFO - PROCESS | 17847 | 13:14:05 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59050/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:06 INFO - PROCESS | 17847 | RSS: Main: 160927744 13:14:06 INFO - PROCESS | 17847 | 13:14:09 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59050/tests/kraken/driver.html?testName=json-parse-financial) 13:14:09 INFO - PROCESS | 17847 | RSS: Main: 160976896 13:14:09 INFO - PROCESS | 17847 | 13:14:11 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59050/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:11 INFO - PROCESS | 17847 | RSS: Main: 160722944 13:14:11 INFO - PROCESS | 17847 | 13:14:13 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:14 INFO - PROCESS | 17847 | RSS: Main: 160792576 13:14:14 INFO - PROCESS | 17847 | 13:14:16 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:16 INFO - PROCESS | 17847 | RSS: Main: 160706560 13:14:16 INFO - PROCESS | 17847 | 13:14:19 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:20 INFO - PROCESS | 17847 | RSS: Main: 161763328 13:14:20 INFO - PROCESS | 17847 | 13:14:22 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:23 INFO - PROCESS | 17847 | RSS: Main: 161218560 13:14:23 INFO - PROCESS | 17847 | 13:14:24 INFO - PROCESS | 17847 | Cycle 1(1): loaded http://localhost:59050/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59050/tests/kraken/driver.html?testName=ai-astar) 13:14:25 INFO - PROCESS | 17847 | RSS: Main: 162082816 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | __start_tp_report 13:14:25 INFO - PROCESS | 17847 | _x_x_mozilla_page_load 13:14:25 INFO - PROCESS | 17847 | _x_x_mozilla_page_load_details 13:14:25 INFO - PROCESS | 17847 | |i|pagename|runs| 13:14:25 INFO - PROCESS | 17847 | |0;ai-astar;110;110;110;110;112;110;110;111;111;111 13:14:25 INFO - PROCESS | 17847 | |1;audio-beat-detection;158;124;150;169;126;152;160;125;192;131 13:14:25 INFO - PROCESS | 17847 | |2;audio-dft;166;163;161;163;162;164;163;166;162;162 13:14:25 INFO - PROCESS | 17847 | |3;audio-fft;75;75;75;170;74;74;75;78;168;77 13:14:25 INFO - PROCESS | 17847 | |4;audio-oscillator;84;85;150;85;86;85;146;85;85;143 13:14:25 INFO - PROCESS | 17847 | |5;imaging-gaussian-blur;117;117;117;117;118;117;120;117;117;120 13:14:25 INFO - PROCESS | 17847 | |6;imaging-darkroom;147;148;147;147;146;146;146;146;147;147 13:14:25 INFO - PROCESS | 17847 | |7;imaging-desaturate;96;96;97;95;96;96;96;95;96;95 13:14:25 INFO - PROCESS | 17847 | |8;json-parse-financial;52;54;51;53;51;51;53;51;50;52 13:14:25 INFO - PROCESS | 17847 | |9;json-stringify-tinderbox;58;59;59;59;59;59;59;59;58;59 13:14:25 INFO - PROCESS | 17847 | |10;stanford-crypto-aes;81;75;76;75;75;81;82;76;112;75 13:14:25 INFO - PROCESS | 17847 | |11;stanford-crypto-ccm;121;121;120;118;124;126;127;127;119;126 13:14:25 INFO - PROCESS | 17847 | |12;stanford-crypto-pbkdf2;163;154;164;160;160;156;149;148;153;152 13:14:25 INFO - PROCESS | 17847 | |13;stanford-crypto-sha256-iterative;61;72;62;63;70;65;62;63;64;64 13:14:25 INFO - PROCESS | 17847 | __end_tp_report 13:14:25 INFO - PROCESS | 17847 | __start_cc_report 13:14:25 INFO - PROCESS | 17847 | _x_x_mozilla_cycle_collect,903 13:14:25 INFO - PROCESS | 17847 | __end_cc_report 13:14:25 INFO - PROCESS | 17847 | __startTimestamp1469218465234__endTimestamp 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | ------- Summary: start ------- 13:14:25 INFO - PROCESS | 17847 | Number of tests: 14 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 13:14:25 INFO - PROCESS | 17847 | Values: 110.0 110.0 110.0 110.0 112.0 110.0 110.0 111.0 111.0 111.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:155.00 stddev:22.40 (14.4%) stddev-sans-first:23.50 13:14:25 INFO - PROCESS | 17847 | Values: 158.0 124.0 150.0 169.0 126.0 152.0 160.0 125.0 192.0 131.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:1.69 (1.0%) stddev-sans-first:1.45 13:14:25 INFO - PROCESS | 17847 | Values: 166.0 163.0 161.0 163.0 162.0 164.0 163.0 166.0 162.0 162.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:39.50 (52.7%) stddev-sans-first:41.28 13:14:25 INFO - PROCESS | 17847 | Values: 75.0 75.0 75.0 170.0 74.0 74.0 75.0 78.0 168.0 77.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:85.00 stddev:29.68 (34.9%) stddev-sans-first:30.64 13:14:25 INFO - PROCESS | 17847 | Values: 84.0 85.0 150.0 85.0 86.0 85.0 146.0 85.0 85.0 143.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.25 (1.1%) stddev-sans-first:1.30 13:14:25 INFO - PROCESS | 17847 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 120.0 117.0 117.0 120.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 13:14:25 INFO - PROCESS | 17847 | Values: 147.0 148.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 13:14:25 INFO - PROCESS | 17847 | Values: 96.0 96.0 97.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:1.23 (2.4%) stddev-sans-first:1.30 13:14:25 INFO - PROCESS | 17847 | Values: 52.0 54.0 51.0 53.0 51.0 51.0 53.0 51.0 50.0 52.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 13:14:25 INFO - PROCESS | 17847 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 59.0 59.0 58.0 59.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:76.00 stddev:11.33 (14.9%) stddev-sans-first:12.02 13:14:25 INFO - PROCESS | 17847 | Values: 81.0 75.0 76.0 75.0 75.0 81.0 82.0 76.0 112.0 75.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:125.00 stddev:3.48 (2.8%) stddev-sans-first:3.62 13:14:25 INFO - PROCESS | 17847 | Values: 121.0 121.0 120.0 118.0 124.0 126.0 127.0 127.0 119.0 126.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:158.00 stddev:5.65 (3.6%) stddev-sans-first:5.37 13:14:25 INFO - PROCESS | 17847 | Values: 163.0 154.0 164.0 160.0 160.0 156.0 149.0 148.0 153.0 152.0 13:14:25 INFO - PROCESS | 17847 | 13:14:25 INFO - PROCESS | 17847 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.00 stddev:3.60 (5.6%) stddev-sans-first:3.57 13:14:25 INFO - PROCESS | 17847 | Values: 61.0 72.0 62.0 63.0 70.0 65.0 62.0 63.0 64.0 64.0 13:14:25 INFO - PROCESS | 17847 | -------- Summary: end -------- 13:14:25 INFO - PROCESS | 17847 | 13:14:26 INFO - TEST-INFO | 17847: exit 0 13:14:26 INFO - TEST-OK | kraken | took 61479ms 13:14:26 INFO - SUITE-END | took 1171s 13:14:26 INFO - Completed test suite (00:19:31) 13:14:26 INFO - javascript benchmark 13:14:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7712.133404409992, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.479590663447, 3403.69366756992, 3404.0128362774794, 3434.82825858707, 3434.879779207728, 5571.832845014651, 5585.162225666142, 5602.971985140079, 5636.887262254758, 5692.0323544997345, 5643.633163844347, 5654.547636189105, 5674.460926212003, 5701.857453563663, 5731.713414329277, 5119.539241468267, 5147.768350424221, 5171.120909445384, 5204.505571970676, 5205.479452054802, 5082.288479612857, 5091.490850914897, 5197.766100525486, 5203.453637368059, 5243.397009343936, 5174.767135478894, 5190.766415511311, 5196.948030519684, 5201.817936372227, 5206.739663016834, 5249.658772179815, 5249.947500525003, 5255.08036093682, 5258.0, 5287.180487024518, 4987.226979818134, 5011.423686276088, 5043.344365232533, 5175.637705360627, 5191.766370513336, 5521.337439507285, 5534.695591742453, 5542.612017158801, 5546.112621980464, 5549.667019978814, 6071.939280607182, 6072.089186621998, 6084.361142080063, 6086.360932102154, 6090.756369745249, 5955.523558115384, 5995.310539287994, 5997.490213331872, 6006.219191505076, 6112.235970503687, 5620.718964051822, 5655.830325090254, 5659.773609055633, 5672.68800215988, 5674.404187560329, 6146.508279337642, 6175.660338681416, 6187.3503282155625, 6210.285817130997, 6214.285357183891, 5822.650640961556, 5899.911501327483, 5910.99513082777, 5976.850578735566, 6017.458428741435, 6055.545834062463, 6056.515478761688, 6058.1518587397795, 6065.3934606539, 6065.4541091302, 5887.234659494324, 6045.576809623284, 6057.515398768088, 6065.514758819284, 6082.422169893853, 5952.434518720715, 5964.940350596438, 5997.880042399128, 6025.15647809307, 6069.0, 4642.675012749075, 4659.184642687516, 4665.580097791215, 4685.531446855355, 4700.153972284953, 4121.690873184463, 4122.237386083584, 4144.067584793458, 4174.373843923436, 4178.644815190682, 5683.630564013326, 5707.0, 5721.342045664802, 5853.03424934881, 5933.199018132583, 5985.790497332572, 5998.910016349758, 6002.459778619857, 6004.819855404345, 6009.789657362059, 5686.516646085046, 5756.079027355603, 5761.308642962787, 5762.827115186551, 5767.798127065616, 5126.231065340155, 5136.691798492103, 5175.585953123741, 5191.0, 5223.164293713064, 6112.235970503687, 6178.258608966953, 6181.350958149419, 6189.226346706661, 6192.690365481798, 5955.166276721176, 5969.432903874299, 6045.335013148638, 6094.634321940698, 6097.23784526943, 6141.723622436912, 6194.0, 6201.534884883742, 6205.193324867739, 6208.9689551551955, 5978.163057172086, 5983.37174596661, 5984.0, 6010.639361638141, 6030.969845150747, 5918.615290006136, 5978.192943952685, 5994.100884867305, 6011.549133815069, 6048.6975651218145, 5833.183354330482, 5836.649801011953, 5871.178035075179, 5933.614315069507, 5957.434043765836, 5862.589618726648, 5867.20792692998, 5890.7349169288345, 5896.852578685395, 5901.380355062656, 5661.66030038199, 5778.797742079007, 5785.508231800176, 5838.795642152504, 5882.588218824641, 5939.227900372924, 5988.161657367885, 5991.910121348096, 6003.279606447254, 6014.188084608521, 5859.296884373903, 5866.2373891393845, 5873.177755114373, 5889.5582831286965, 5893.5874488787085], "value": 5578.964622009372, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8286555466137, 647.8412788866727, 663.5719960625397, 664.7872680742163, 666.0342503370115, 46184.0, 47911.0, 48148.75925620372, 48178.27732584014, 50707.492925070736, 48820.0, 48912.755436222855, 49010.26484602734, 49182.262266066034, 49766.75116624412, 8934.06192349802, 9106.271498280155, 9123.08769123089, 9162.496062716547, 9226.123518265755, 8957.0, 9068.546572671374, 9113.95443022784, 9116.407433516833, 9136.086391360877, 9094.181523662903, 9145.542722863864, 9150.771230719252, 9151.130642588943, 9160.45037297761, 9053.59258833354, 9081.682141125062, 9084.727458176265, 9093.136152065543, 9129.315301352392, 9037.277017838556, 9077.63689452421, 9129.360944733804, 9141.314401419853, 9163.221126204215, 44203.77898110521, 44435.55564444346, 44447.222111115516, 44467.77766111149, 44559.331610025874, 3833.0, 3833.252515759428, 3889.027743064234, 3907.648311651965, 4006.779627120507, 33812.49281260783, 34663.0, 34755.47866782, 34852.0, 35070.47394289088, 4681.953180468186, 4685.390899183119, 4697.201475749131, 4733.337332773414, 4804.6876952997945, 262411.0, 262966.0, 263284.0, 264021.0, 264844.0, 63388.0, 64127.0, 64312.35687643157, 64358.67820660867, 64385.67807160934, 39724.40413393801, 40682.59317406788, 40687.38968915468, 42057.57942420598, 42576.0, 19136.330228441937, 19163.13765880511, 19196.520086997658, 19199.136038878285, 19292.4212273632, 15087.24563771829, 15162.090274583561, 15200.771988420183, 15208.923955380153, 15233.923830380778, 21558.46103847385, 21716.89141554282, 21736.0, 21737.891310543662, 21873.67189492159, 7712.537247765152, 7744.612769361509, 8003.8799418008775, 8035.236652518001, 8074.0, 1027.3117011602244, 1094.7044298039643, 1099.7191150635726, 1192.7554851255472, 1193.8567371915426, 34029.82985085059, 34173.0, 34248.48627270593, 34717.0, 35030.0, 1177.8645455772696, 1269.5175833183332, 1269.8920591749804, 1279.929603871796, 1305.8367704036996, 17791.55521111957, 17898.194581243875, 17926.5518362042, 18303.72544411835, 18465.81534184668, 606093.0, 619218.0, 621444.0, 625351.0, 999163.0, 59976.40023599796, 60715.08927366093, 60759.0, 60795.0, 60799.0, 1470.985290147085, 1486.3385793322084, 1495.6410461489165, 1496.9625759356104, 1504.5185540626894, 32283.677163229007, 33033.66966330402, 33367.49948750722, 33608.66391336153, 33665.15837103994, 52121.7393913028, 52250.0, 52457.47542524526, 52641.210381843535, 52645.47354526406, 386308.0, 388044.0, 388873.0, 388994.0, 389427.10572893906, 29292.707072929, 29811.850940746026, 30504.0, 31092.844535777178, 31512.054638360885, 51081.23378149256, 51552.0, 52026.959460811326, 52151.0, 53061.734691326295, 39913.0, 42072.789636051624, 42899.57100428956, 43013.56986430221, 44089.779551103326, 41530.37704434496, 41943.7902810484, 42196.789016054725, 42502.57497424986, 43039.784801075795, 43499.565004350814, 43823.0, 43966.340504891814, 44051.33922991222, 44345.55654443414, 36315.0, 36458.94581585188, 36711.816440918694, 37103.44344834776, 37386.0, 28826.711732882402, 29480.557791632713, 29626.111216663536, 29657.406851863274, 29727.851360743058], "value": 21104.82777200261, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.4253387790971, 419.06966534293895, 426.61817673182503, 427.8352834158849, 432.4378308199342, 18555.814441855593, 19436.90281548592, 20194.59610807783, 20205.797942020574, 20339.59320813583, 19015.239390424365, 19015.429537113872, 19185.52036199096, 19864.900675496603, 19916.900415497938, 5853.5902486825835, 6053.031514957607, 6075.301340345873, 6089.634621922699, 6101.359357267467, 4398.604125628693, 5962.552808539355, 6019.067044608093, 6422.421982021617, 6745.3591908768585, 6791.864162716743, 6798.150231221098, 6816.454683625323, 6827.863442731143, 6832.111825462683, 6507.869842603145, 6709.161354830646, 6712.697928593225, 6747.156605424347, 6757.763478278262, 5808.070708686632, 6016.458518733291, 6029.0, 6039.094135879609, 6074.088886666991, 23317.0, 23422.531549369087, 23609.0, 23830.404239893967, 23920.7607923922, 2488.5147396257735, 2557.936051598725, 2638.722934091912, 2651.6552848129813, 2827.137722994486, 14644.194569298685, 15282.541523754306, 15391.153486558234, 15465.381384744596, 15573.299201535958, 2051.3435700575824, 2064.7522297324417, 2066.555690526544, 2100.5063810004635, 2123.1295168980796, 79150.0, 82811.5859420699, 83192.0, 83656.0, 84078.0, 11159.888401115884, 11361.772764544663, 11362.431878406212, 11560.421978901022, 11567.479463424166, 16050.0, 16170.75743863843, 16225.51323460298, 16286.755698664529, 16317.531422172062, 8726.476411415335, 8853.867191992125, 8872.822543549222, 8968.417052891542, 8997.595108220146, 8615.655373785105, 8616.827663446697, 8648.610812513452, 8649.783755406039, 8743.213110820057, 6875.174979002451, 7037.824054398681, 7056.54132481387, 7076.2923707628825, 7189.496735228484, 1906.4757191772096, 1907.389635316713, 2034.7049677796933, 2057.444489987695, 2072.316135675254, 1018.6842078955399, 1076.6716151573846, 1082.8105081610686, 1098.9230753847314, 1129.6046383765615, 19478.318258861156, 19902.203911843655, 19967.600647986957, 20030.799692003184, 20365.592688146153, 1097.2703152403722, 1105.9557617695364, 1129.565117429779, 1151.3034614058543, 1155.624422062833, 11328.150388720878, 11603.419829008515, 11617.88382116185, 11654.53381864716, 11723.237989530653, 537322.0, 542972.0, 545695.0, 546981.0, 550499.0, 81850.0, 81891.0, 84923.0, 85814.57092714496, 86580.0, 1098.2916019167592, 1113.2263077161294, 1119.1494464207099, 1125.7748450309807, 1134.5631931706187, 17742.290308388037, 18157.546061348043, 18233.726494102335, 18273.3604323848, 18321.816781832546, 38515.229695406495, 39273.80363098166, 39389.6061039386, 39687.60312396839, 41308.38037429381, 53190.2021469686, 53576.73211633917, 53708.0, 54018.18972715491, 54021.45978540164, 8616.526091065052, 8832.779180520538, 8846.424982376126, 9083.04628014049, 9163.0, 12855.550055748005, 13291.401886914919, 13712.17726936387, 13956.930215348859, 14285.714285714435, 11846.229995050639, 11953.282803031845, 12255.571055013388, 12557.246565206116, 12593.307368094842, 11503.76992460163, 12083.879161208275, 12360.25838449696, 12471.688207794878, 12683.98528117767, 6154.723037463235, 10482.266241363031, 12174.330411827434, 12212.816807747713, 12449.37753112359, 8999.730008099768, 9034.86447703272, 9097.090290971115, 9261.398009129385, 9298.628054877729, 12157.331346776013, 12320.815187772012, 12435.37823108859, 12451.875481245072, 12515.56195533152], "value": 9874.939418690405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1551.1236151574362, 1552.9068255904642, 1772.175938188742, 1910.5892233169884, 1918.63545926274, 8455.408121431503, 9036.68371606993, 9148.817023659523, 9657.806843863127, 9659.951700241498, 9242.30682698797, 9479.336446448751, 9505.049495050509, 9595.088466595662, 9609.855852162224, 2434.172381390327, 2490.9786987335196, 2491.277529516438, 2491.3397949543387, 2491.4643351679383, 2425.866577338246, 2491.8878650460683, 2498.462830491444, 2499.487605040962, 2499.7750202481775, 2434.2332165367943, 2454.361865914866, 2504.2236906558933, 2506.6616006839117, 2509.648649189115, 2385.4990452005013, 2388.1402695029774, 2390.1156572068357, 2456.4350199454225, 2458.0659349447274, 2362.598358279097, 2364.4443555764383, 2375.928722138339, 2380.8214383921104, 2414.2153800015067, 9451.669191578261, 9479.763005924839, 9562.95218523903, 9580.281478889041, 9611.56747946337, 5509.724513774296, 5657.264555607786, 5671.06427439472, 5674.687892165929, 5686.829395118111, 3404.131946353664, 3420.110771199481, 3484.9477257841154, 3492.336456073338, 3501.3872572299747, 1195.9521619135223, 1205.7769312677094, 1208.9818652720128, 1226.760781647579, 1232.3961258983124, 13158.342082895817, 13176.802347964789, 13227.404766785517, 13269.402876870467, 13298.933505332412, 4761.714297142183, 4795.335554497878, 4882.7558622068755, 4936.099601653389, 4958.528939750718, 11200.719982000515, 11240.49417776202, 11243.381614011145, 11249.43752812356, 11272.323660580392, 5612.887742245214, 5641.576881733887, 5722.227499287626, 5731.283589551306, 5737.913931291034, 4612.100640375162, 5051.444341122474, 5177.456367081478, 5193.818216362409, 5290.232916227125, 4308.590683885026, 4347.543507931685, 4365.672574556921, 4373.6282415994365, 4397.978010109929, 1285.4408332375447, 1289.3231053696884, 1308.3523655790254, 1309.3518708239483, 1337.9264140472367, 1048.0881632979356, 1053.7945100705442, 1060.9787804243872, 1071.7481391872905, 1081.767420004687, 6563.606183628997, 6574.934250657432, 6673.733050677918, 6682.732690692415, 6685.899711504331, 491.8032786885203, 502.03859608848643, 503.6172508893267, 509.0760270109739, 513.3941948500805, 4452.4211852458975, 4452.977735111303, 4476.0, 4492.797824097924, 4527.411436513298, 11472.196946213686, 12059.336736479578, 12076.577319793765, 12096.81854772179, 12110.455029523693, 11910.761784764256, 11911.0, 11918.927296543352, 11925.821112683318, 11936.343501107522, 8495.872561911576, 8702.564871756387, 8762.430442021248, 9007.0, 9007.819843603222, 6410.679466026773, 6697.698603562949, 6713.093732346266, 6796.728130874907, 6806.863862722619, 10523.315984460985, 10955.616553420592, 11021.393823339793, 11037.779244414905, 11146.777064458827, 11078.944605276922, 11160.441977901235, 11197.104231661284, 11265.380404077854, 11361.886381136082, 8222.0, 8335.416520843482, 8454.873176902229, 8494.1081186477, 8500.574971251537, 9175.816483670424, 9176.08239176077, 9181.173694367539, 9241.953790231006, 9288.396254243453, 8291.461055031403, 8433.831323373375, 8447.0, 8550.05949345559, 8573.699920502753, 8263.934974278096, 8307.501549907025, 8439.578021099043, 8445.66217351299, 8448.535330556879, 7412.777616671508, 7478.364339031025, 7494.288042635941, 7499.962500187464, 7511.248875112664, 5111.718855462986, 5154.664946778447, 5235.712035838065, 5338.4394638563945, 5363.03465376236, 5291.391489978701, 5340.305760251143, 5402.621816472809, 5447.346318441812, 5570.275864137636], "value": 4896.317154632981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1859064855508, 353.2422952766315, 354.5514923621619, 365.2694610778443, 371.28527584400024, 5590.965671350803, 5780.884382312352, 5783.6240644358195, 5813.563982701298, 5846.795362162326, 5617.522510586605, 5644.491995720385, 5649.519790817785, 5660.688662123582, 5671.177679236519, 4086.5504794472586, 4433.13553856998, 4490.393796837434, 4516.864494065183, 4527.411436513249, 4387.210302145612, 4401.119776044788, 4415.867523974286, 4429.379886815848, 4436.600705936465, 4348.826046958118, 4392.5827046430695, 4406.911861762763, 4418.9337159942625, 4421.823127074913, 4280.935785963213, 4418.801153948048, 4427.734335939837, 4431.512533621315, 4475.261581839009, 3948.861789837342, 3964.0, 3969.5236571611304, 3977.940330895039, 4000.7599544027453, 5382.381026182, 5461.262729531502, 5470.343558772933, 5473.589480788957, 5478.890422191534, 4948.777305021283, 5126.308318254967, 5127.461616530248, 5134.870328527718, 5148.61385396093, 5923.200367950358, 5935.020721580934, 5945.583809133363, 5948.434898684618, 5949.0, 4359.215341238576, 4362.912741745179, 4370.7159034662645, 4373.497047839507, 4375.0, 5847.649141051551, 6154.32302446735, 6180.690965451754, 6241.28225254097, 6257.749690012394, 4417.0, 4479.59683628475, 4480.0, 4480.686351955332, 4495.235809912323, 4532.456105267323, 4536.478304994902, 4536.61438777701, 4540.72755634663, 4540.77296135192, 5031.295618613397, 5099.6685215460875, 5118.59051275897, 5136.306598609214, 5158.200478925773, 5890.8821823563285, 5944.286685597756, 5957.314908785458, 5966.284045914431, 5972.85067873298, 1570.7565327374275, 1581.8655414289683, 1585.905725049712, 1589.2609936379638, 1599.9840001599835, 995.1740055753708, 1013.7769690668041, 1014.680914810743, 1015.21828192293, 1040.7554224757175, 5762.855928601734, 5791.581062639681, 5808.879758887975, 5830.0, 5842.591018628656, 6014.849628759316, 6017.0974353846395, 6037.6679282639, 6056.848578785565, 6116.327204007555, 5677.914831277534, 5791.449812267912, 5791.8552036199435, 5808.738606762706, 5866.67733274674, 3258.1528802511043, 3271.2639656077667, 3273.216097227017, 3291.8683252669625, 3294.258791771832, 5927.288725352985, 6069.817905462844, 6215.409536094064, 6244.344343843922, 6279.874402511924, 6098.32918378978, 6125.203723515914, 6139.324674285825, 6167.259928808482, 6184.81445556634, 6055.305389101807, 6133.417325354084, 6163.630182189083, 6170.938290617126, 6235.314115447388, 5888.087346461305, 6119.479844213113, 6133.969330153321, 6138.0, 6138.907916381168, 5952.375000625046, 5991.2510936132985, 6002.98899868549, 6003.579749417673, 6015.338312785678, 5960.5827592068135, 6177.536684748572, 6179.84550386226, 6330.968345158245, 6348.460380867678, 4303.289957157159, 4346.673999450117, 4349.739015659071, 4360.825566977285, 4376.365427013002, 6220.968895155495, 6246.46905013079, 6269.059641053878, 6279.748810047547, 6292.276388215414, 5771.961047011579, 5975.312839023568, 6071.787487437919, 6102.908456373247, 6114.174586430775, 5992.610480318765, 6029.909551356645, 6044.9395506044375, 6053.697315134137, 6085.05681619332, 5622.887542249214, 5758.424157584208, 5916.112583112567, 5930.555208359304, 5982.49148822355, 5991.700414979321, 6008.8798224036145, 6009.969950150221, 6086.0, 6107.144999699956, 5918.7928422505, 5941.970290148522, 6014.939850601438, 6045.909311360245, 6048.637081775108], "value": 4568.568012192293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.1085495100438, 833.6998680475028, 856.4818284937617, 880.1066917079162, 887.1173182683231, 14808.259587020646, 15444.0, 15520.379184832607, 15636.609084772857, 15673.84326156741, 15254.466093686724, 15323.387064517407, 15453.845461545381, 15454.768178477332, 15493.92253038736, 711.8967749676319, 838.8657814749641, 849.2653854415933, 859.5916939453772, 861.2464093917822, 851.9829603407928, 855.5935930433056, 856.8500512410335, 859.6045818923303, 860.3977215948829, 905.0632595263903, 908.0601577367426, 909.3498148823589, 909.3589019741099, 912.2519533982104, 898.0839543665425, 902.7517432705993, 902.7517432705993, 904.1546154345642, 904.9909500905005, 662.7249691378072, 664.621165935417, 664.930182330858, 666.2504682232488, 666.3369946902862, 15058.171800550965, 15073.623159420993, 15182.544523664197, 15188.240587970668, 15188.924055379652, 14437.783433248509, 16188.503107605567, 16444.506664800076, 16642.667146657, 16802.83197168025, 14057.086289391156, 14247.715045699131, 14545.854541454555, 14823.0, 14880.553583392515, 4632.490426053131, 4760.95239047612, 4782.569568738831, 4904.975475122637, 4978.427480839714, 64215.35784642141, 66729.3327066728, 66929.3307066928, 75983.62008189979, 76039.6198019012, 12328.445219965122, 12786.424610892345, 12847.486100555872, 12893.226406415457, 12986.285754283605, 22171.445713857283, 22266.88866555657, 22282.0, 22318.330450086523, 22320.776792232195, 8974.0, 8975.506347150838, 9063.54682265884, 9288.582013809395, 9364.15722584957, 5252.632315737938, 5299.576033917355, 5349.170878513836, 5393.6224464287125, 5487.314085739283, 3787.696984241254, 3804.752691075071, 3928.5874983126932, 3936.626020528045, 3946.625070618287, 702.0872865275122, 709.0250905005618, 719.4208662027014, 720.2113685514354, 723.1502983993786, 642.7364780440091, 745.7166276814776, 793.1830214878685, 809.4819315637997, 818.1899919080187, 10618.761277810341, 10933.289336193122, 10950.178736594788, 11030.28303160292, 11190.440477976068, 721.404841006172, 725.0972539188743, 726.117766913203, 788.3023524181141, 821.5645707774889, 5181.611379146504, 5379.193121031876, 5468.699221542774, 5491.395946445888, 5614.63504872182, 128703.35648321698, 132145.33927330494, 133832.0, 135720.0, 135728.0, 106309.4684526588, 110847.44576277229, 111214.0, 115311.0, 116222.41888790502, 96879.03120968842, 98880.0, 100058.499707501, 100683.0, 102002.0, 8140.267375936194, 8354.331653467829, 9717.951410242904, 10221.693349199535, 10303.072723454925, 56846.147307791245, 57996.55008624818, 58106.83786324165, 59140.0, 59497.7025114889, 49802.501974981235, 49862.50137498578, 54823.451765481834, 84345.57827210825, 84805.0, 13253.271070090852, 13301.80047299272, 13538.052336336363, 13543.458261669422, 13917.443302267797, 15051.0, 15104.773428398363, 15380.461683841011, 15810.209489525707, 15829.0, 12824.871751282368, 12908.0, 13052.34738263102, 13200.075994680665, 13332.666683332607, 13175.736485270048, 13447.529336473177, 13454.058215924792, 14267.143971361336, 14304.928475357972, 14185.219812909976, 14365.13809171453, 14388.496402625859, 14417.1349719013, 14475.638109047359, 11381.54473821038, 11511.136664750346, 11592.710182245512, 11835.171537992257, 12109.515619375126, 11026.669199924016, 11884.881151188378, 11971.10216733731, 12016.279023258632, 12324.445399956845], "value": 8088.830622872344, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 111.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 150.0, 169.0, 126.0, 152.0, 160.0, 125.0, 192.0, 131.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 161.0, 163.0, 162.0, 164.0, 163.0, 166.0, 162.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 170.0, 74.0, 74.0, 75.0, 78.0, 168.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 150.0, 85.0, 86.0, 85.0, 146.0, 85.0, 85.0, 143.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 117.0, 117.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 53.0, 51.0, 51.0, 53.0, 51.0, 50.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 75.0, 75.0, 81.0, 82.0, 76.0, 112.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 120.0, 118.0, 124.0, 126.0, 127.0, 127.0, 119.0, 126.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 154.0, 164.0, 160.0, 160.0, 156.0, 149.0, 148.0, 153.0, 152.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 72.0, 62.0, 63.0, 70.0, 65.0, 62.0, 63.0, 64.0, 64.0], "value": 64.6, "unit": "score"}]}]} 13:14:26 INFO - Return code: 0 13:14:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:26 ERROR - # TBPL SUCCESS # 13:14:26 INFO - Running post-action listener: _resource_record_post_action 13:14:26 INFO - ##### 13:14:26 INFO - ##### Finished run-tests step (success) 13:14:26 INFO - ##### 13:14:26 INFO - Running post-run listener: _resource_record_post_run 13:14:26 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511332352; Read time: 196; Write time: 586412 13:14:26 INFO - TinderboxPrint: CPU usage
13.4% 13:14:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 196 13:14:26 INFO - TinderboxPrint: I/O write bytes / time
511,332,352 / 586,412 13:14:26 INFO - TinderboxPrint: CPU idle
8,218.8 (86.6%) 13:14:26 INFO - TinderboxPrint: CPU user
1,209.8 (12.8%) 13:14:26 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:26 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 259932160; Read time: 0; Write time: 398296 13:14:26 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251400192; Read time: 196; Write time: 188116 13:14:27 INFO - Running post-run listener: _upload_blobber_files 13:14:27 INFO - Blob upload gear active. 13:14:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:27 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 13:14:27 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'] 13:14:27 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 13:14:27 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:14:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:14:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:28 INFO - (blobuploader) - INFO - Done attempting. 13:14:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:49 INFO - (blobuploader) - INFO - Done attempting. 13:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:14:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:50 INFO - (blobuploader) - INFO - Done attempting. 13:14:50 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:50 INFO - Return code: 0 13:14:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4796080262f3bdf395d04b05ac4cc10625c8410c61520f5752e891a6dce4a7af0662046659a233d9a69462acf694344d0e26d56a1f888221e4b5739e826ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06992b7e9eeca7b579391f3de5ec21e9f0310a872f310cf54ca9c509aceccb4f8a736ebd3a122ce6797e513d3d31e990d2009431c0a00c483fc2646d1cbc66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7781ba54cd48f0630e8682ad835258a5af4fc18c108d2d25a75d5c8e1353ea9a9ac17a3362d324ef02af837612bc2dfadaed5ba14838b3ca0a36f3a22ae5276"} 13:14:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:50 INFO - Contents: 13:14:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bdf4796080262f3bdf395d04b05ac4cc10625c8410c61520f5752e891a6dce4a7af0662046659a233d9a69462acf694344d0e26d56a1f888221e4b5739e826ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06992b7e9eeca7b579391f3de5ec21e9f0310a872f310cf54ca9c509aceccb4f8a736ebd3a122ce6797e513d3d31e990d2009431c0a00c483fc2646d1cbc66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7781ba54cd48f0630e8682ad835258a5af4fc18c108d2d25a75d5c8e1353ea9a9ac17a3362d324ef02af837612bc2dfadaed5ba14838b3ca0a36f3a22ae5276"} 13:14:50 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:50 INFO - Copying logs to upload dir... 13:14:50 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.787378 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-22 13:14:49.947712) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:49.951505) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 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/bdf4796080262f3bdf395d04b05ac4cc10625c8410c61520f5752e891a6dce4a7af0662046659a233d9a69462acf694344d0e26d56a1f888221e4b5739e826ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06992b7e9eeca7b579391f3de5ec21e9f0310a872f310cf54ca9c509aceccb4f8a736ebd3a122ce6797e513d3d31e990d2009431c0a00c483fc2646d1cbc66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7781ba54cd48f0630e8682ad835258a5af4fc18c108d2d25a75d5c8e1353ea9a9ac17a3362d324ef02af837612bc2dfadaed5ba14838b3ca0a36f3a22ae5276"} build_url:https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/BYqg4dkxT0Chm-XWnW3lcA/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/bdf4796080262f3bdf395d04b05ac4cc10625c8410c61520f5752e891a6dce4a7af0662046659a233d9a69462acf694344d0e26d56a1f888221e4b5739e826ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f06992b7e9eeca7b579391f3de5ec21e9f0310a872f310cf54ca9c509aceccb4f8a736ebd3a122ce6797e513d3d31e990d2009431c0a00c483fc2646d1cbc66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7781ba54cd48f0630e8682ad835258a5af4fc18c108d2d25a75d5c8e1353ea9a9ac17a3362d324ef02af837612bc2dfadaed5ba14838b3ca0a36f3a22ae5276"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:49.977173) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:49.977504) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1469217238.523367-1109377151 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 13:14:50.061271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:14:50.061726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 13:14:50.062203) ========= ========= Total master_lag: 0.18 =========