builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1469114680.17 results: success (0) buildid: 20160721053620 builduid: ffbb0662f45c4231825261b836b0a177 revision: 2a0945d032b12dd57f8e599b35a4d76f3557350e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.167697) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.168124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.168403) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.182848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.183166) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 08:24:40-- 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% 9.77M=0.001s 2016-07-21 08:24:40 (9.77 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.355383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.552381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.552697) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:40.602377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 08:24:40.602816) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2a0945d032b12dd57f8e599b35a4d76f3557350e --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 2a0945d032b12dd57f8e599b35a4d76f3557350e --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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 08:24:40,699 truncating revision to first 12 chars 2016-07-21 08:24:40,699 Setting DEBUG logging. 2016-07-21 08:24:40,699 attempt 1/10 2016-07-21 08:24:40,700 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2a0945d032b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 08:24:41,682 unpacking tar archive at: mozilla-aurora-2a0945d032b1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.389366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 08:24:42.009570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:42.010393) ========= script_repo_revision: 2a0945d032b12dd57f8e599b35a4d76f3557350e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:42.011275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:42.012011) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 08:24:42.023949) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-21 08:24:42.024371) ========= /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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:24:42 INFO - MultiFileLogger online at 20160721 08:24:42 in /builds/slave/test 08:24:42 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 08:24:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:24:42 INFO - {'append_to_log': False, 08:24:42 INFO - 'base_work_dir': '/builds/slave/test', 08:24:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:24:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:24:42 INFO - 'branch': 'Mozilla-Aurora', 08:24:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:24:42 INFO - 'config_files': ('talos/linux_config.py',), 08:24:42 INFO - 'default_actions': ('clobber', 08:24:42 INFO - 'read-buildbot-config', 08:24:42 INFO - 'download-and-extract', 08:24:42 INFO - 'populate-webroot', 08:24:42 INFO - 'create-virtualenv', 08:24:42 INFO - 'install', 08:24:42 INFO - 'run-tests'), 08:24:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:24:42 INFO - 'download_minidump_stackwalk': True, 08:24:42 INFO - 'download_symbols': 'ondemand', 08:24:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:24:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:24:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:24:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:24:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:24:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:24:42 INFO - 'installer_path': 'installer.exe', 08:24:42 INFO - 'log_level': 'info', 08:24:42 INFO - 'log_name': 'talos', 08:24:42 INFO - 'log_to_console': True, 08:24:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:24:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:24:42 INFO - 'opt_config_files': (), 08:24:42 INFO - 'pip_index': False, 08:24:42 INFO - 'sps_profile': False, 08:24:42 INFO - 'sps_profile_interval': 0, 08:24:42 INFO - 'suite': 'dromaeojs-e10s', 08:24:42 INFO - 'system_bits': '32', 08:24:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:24:42 INFO - 'title': 'talos-linux64-ix-011', 08:24:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:24:42 INFO - 'use_talos_json': True, 08:24:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:24:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:24:42 INFO - 'work_dir': 'build'} 08:24:42 INFO - ##### 08:24:42 INFO - ##### Running clobber step. 08:24:42 INFO - ##### 08:24:42 INFO - Running pre-action listener: _resource_record_pre_action 08:24:42 INFO - Running main action method: clobber 08:24:42 INFO - rmtree: /builds/slave/test/build 08:24:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:24:42 INFO - Running post-action listener: _resource_record_post_action 08:24:42 INFO - ##### 08:24:42 INFO - ##### Finished clobber step (success) 08:24:42 INFO - ##### 08:24:42 INFO - ##### 08:24:42 INFO - ##### Running read-buildbot-config step. 08:24:42 INFO - ##### 08:24:42 INFO - Running pre-action listener: _resource_record_pre_action 08:24:42 INFO - Running main action method: read_buildbot_config 08:24:42 INFO - Using buildbot properties: 08:24:42 INFO - { 08:24:42 INFO - "project": "", 08:24:42 INFO - "product": "firefox", 08:24:42 INFO - "script_repo_revision": "production", 08:24:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:24:42 INFO - "repository": "", 08:24:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:24:42 INFO - "buildid": "20160721053620", 08:24:42 INFO - "pgo_build": "True", 08:24:42 INFO - "basedir": "/builds/slave/test", 08:24:42 INFO - "buildnumber": 400, 08:24:42 INFO - "slavename": "talos-linux64-ix-011", 08:24:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:24:42 INFO - "platform": "ubuntu64_hw", 08:24:42 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:24:42 INFO - "branch": "mozilla-aurora", 08:24:42 INFO - "repo_path": "releases/mozilla-aurora", 08:24:42 INFO - "revision": "2a0945d032b12dd57f8e599b35a4d76f3557350e", 08:24:42 INFO - "stage_platform": "linux64-pgo", 08:24:42 INFO - "builduid": "ffbb0662f45c4231825261b836b0a177", 08:24:42 INFO - "slavebuilddir": "test" 08:24:42 INFO - } 08:24:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 08:24:42 INFO - Running post-action listener: _resource_record_post_action 08:24:42 INFO - ##### 08:24:42 INFO - ##### Finished read-buildbot-config step (success) 08:24:42 INFO - ##### 08:24:42 INFO - ##### 08:24:42 INFO - ##### Running download-and-extract step. 08:24:42 INFO - ##### 08:24:42 INFO - Running pre-action listener: _resource_record_pre_action 08:24:42 INFO - Running main action method: download_and_extract 08:24:42 INFO - mkdir: /builds/slave/test/build/tests 08:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:42 INFO - https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:43 INFO - Downloaded 1361 bytes. 08:24:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:24:43 INFO - Using the following test package requirements: 08:24:43 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:24:43 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:24:43 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:24:43 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'jsshell-linux-x86_64.zip'], 08:24:43 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:24:43 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:24:43 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:24:43 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:24:43 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:24:43 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:24:43 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:24:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:43 INFO - https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:44 INFO - Downloaded 24489879 bytes. 08:24:44 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'] 08:24:44 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 08:24:45 INFO - Return code: 0 08:24:45 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 08:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:45 INFO - https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:24:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:24:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:24:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:46 INFO - Downloaded 24489879 bytes. 08:24:46 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'] 08:24:46 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 08:24:47 INFO - Return code: 0 08:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:47 INFO - https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:24:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:24:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:24:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:48 INFO - Downloaded 10833369 bytes. 08:24:48 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'] 08:24:48 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 08:24:48 INFO - Return code: 0 08:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:48 INFO - https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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 08:24:50 INFO - Downloaded 63638687 bytes. 08:24:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:24:50 INFO - mkdir: /builds/slave/test/properties 08:24:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:24:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:24:50 INFO - Contents: 08:24:50 INFO - build_url:https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:24:50 INFO - Running post-action listener: _resource_record_post_action 08:24:50 INFO - Running post-action listener: set_extra_try_arguments 08:24:50 INFO - ##### 08:24:50 INFO - ##### Finished download-and-extract step (success) 08:24:50 INFO - ##### 08:24:50 INFO - ##### 08:24:50 INFO - ##### Running populate-webroot step. 08:24:50 INFO - ##### 08:24:50 INFO - Running pre-action listener: _resource_record_pre_action 08:24:50 INFO - Running main action method: populate_webroot 08:24:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:24:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:24:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:24:50 INFO - '--tppagecycles', 08:24:50 INFO - '7'], 08:24:50 INFO - 'tests': ['tsvgm']}}, 08:24:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:24:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:24:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:24:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:24:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:24:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['damp', 'tps']}, 08:24:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'tests': ['damp', 'tps']}, 08:24:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['dromaeo_dom']}, 08:24:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:24:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['a11yr', 08:24:50 INFO - 'ts_paint', 08:24:50 INFO - 'tpaint', 08:24:50 INFO - 'sessionrestore', 08:24:50 INFO - 'sessionrestore_no_auto_restore', 08:24:50 INFO - 'tabpaint']}, 08:24:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['tsvgx', 08:24:50 INFO - 'tsvgr_opacity', 08:24:50 INFO - 'tart', 08:24:50 INFO - 'tscrollx', 08:24:50 INFO - 'cart']}, 08:24:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:24:50 INFO - 'tsvgr_opacity', 08:24:50 INFO - 'tart', 08:24:50 INFO - 'tscrollx', 08:24:50 INFO - 'cart']}, 08:24:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'talos_options': ['--disable-e10s'], 08:24:50 INFO - 'tests': ['tp5o']}, 08:24:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'tests': ['tp5o']}, 08:24:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'talos_options': ['--disable-e10s', 08:24:50 INFO - '--xperf_path', 08:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:50 INFO - 'tests': ['tp5n']}, 08:24:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:24:50 INFO - 'talos_options': ['--xperf_path', 08:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:24:50 INFO - 'tests': ['tp5n']}}, 08:24:50 INFO - 'talos.zip': {'path': '', 08:24:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:24:50 INFO - Running post-action listener: _resource_record_post_action 08:24:50 INFO - ##### 08:24:50 INFO - ##### Finished populate-webroot step (success) 08:24:50 INFO - ##### 08:24:50 INFO - ##### 08:24:50 INFO - ##### Running create-virtualenv step. 08:24:50 INFO - ##### 08:24:50 INFO - Running pre-action listener: _resource_record_pre_action 08:24:50 INFO - Running main action method: create_virtualenv 08:24:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:24:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:24:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:24:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:24:51 INFO - Using real prefix '/usr' 08:24:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:24:51 INFO - Installing distribute.............................................................................................................................................................................................done. 08:24:53 INFO - Installing pip.................done. 08:24:53 INFO - Return code: 0 08:24:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:24:53 INFO - Using env: {'DISPLAY': ':0', 08:24:53 INFO - 'HOME': '/home/cltbld', 08:24:53 INFO - 'LANG': 'en_US.UTF-8', 08:24:53 INFO - 'LANGUAGE': 'en_US:en', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MAIL': '/var/mail/cltbld', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SHLVL': '1', 08:24:53 INFO - 'TERM': 'linux', 08:24:53 INFO - 'TMOUT': '86400', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - '_': '/tools/buildbot/bin/python'} 08:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:24:53 INFO - Cleaning up... 08:24:53 INFO - Return code: 0 08:24:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:53 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:24:53 INFO - Using env: {'DISPLAY': ':0', 08:24:53 INFO - 'HOME': '/home/cltbld', 08:24:53 INFO - 'LANG': 'en_US.UTF-8', 08:24:53 INFO - 'LANGUAGE': 'en_US:en', 08:24:53 INFO - 'LOGNAME': 'cltbld', 08:24:53 INFO - 'MAIL': '/var/mail/cltbld', 08:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:53 INFO - 'MOZ_NO_REMOTE': '1', 08:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:53 INFO - 'NO_EM_RESTART': '1', 08:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:53 INFO - 'PWD': '/builds/slave/test', 08:24:53 INFO - 'SHELL': '/bin/bash', 08:24:53 INFO - 'SHLVL': '1', 08:24:53 INFO - 'TERM': 'linux', 08:24:53 INFO - 'TMOUT': '86400', 08:24:53 INFO - 'USER': 'cltbld', 08:24:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:53 INFO - '_': '/tools/buildbot/bin/python'} 08:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:54 INFO - Downloading/unpacking psutil>=3.1.1 08:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:56 INFO - Installing collected packages: psutil 08:24:56 INFO - Running setup.py install for psutil 08:24:56 INFO - building 'psutil._psutil_linux' extension 08:24:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:24:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:24:56 INFO - building 'psutil._psutil_posix' extension 08:24:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:24:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:24:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:24:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:24:56 INFO - Successfully installed psutil 08:24:56 INFO - Cleaning up... 08:24:56 INFO - Return code: 0 08:24:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:56 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:24:56 INFO - Using env: {'DISPLAY': ':0', 08:24:56 INFO - 'HOME': '/home/cltbld', 08:24:56 INFO - 'LANG': 'en_US.UTF-8', 08:24:56 INFO - 'LANGUAGE': 'en_US:en', 08:24:56 INFO - 'LOGNAME': 'cltbld', 08:24:56 INFO - 'MAIL': '/var/mail/cltbld', 08:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:56 INFO - 'MOZ_NO_REMOTE': '1', 08:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:56 INFO - 'NO_EM_RESTART': '1', 08:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:56 INFO - 'PWD': '/builds/slave/test', 08:24:56 INFO - 'SHELL': '/bin/bash', 08:24:56 INFO - 'SHLVL': '1', 08:24:56 INFO - 'TERM': 'linux', 08:24:56 INFO - 'TMOUT': '86400', 08:24:56 INFO - 'USER': 'cltbld', 08:24:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:56 INFO - '_': '/tools/buildbot/bin/python'} 08:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:24:58 INFO - Installing collected packages: mozsystemmonitor 08:24:58 INFO - Running setup.py install for mozsystemmonitor 08:24:58 INFO - Successfully installed mozsystemmonitor 08:24:58 INFO - Cleaning up... 08:24:59 INFO - Return code: 0 08:24:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:24:59 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:24:59 INFO - Using env: {'DISPLAY': ':0', 08:24:59 INFO - 'HOME': '/home/cltbld', 08:24:59 INFO - 'LANG': 'en_US.UTF-8', 08:24:59 INFO - 'LANGUAGE': 'en_US:en', 08:24:59 INFO - 'LOGNAME': 'cltbld', 08:24:59 INFO - 'MAIL': '/var/mail/cltbld', 08:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:24:59 INFO - 'MOZ_NO_REMOTE': '1', 08:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:24:59 INFO - 'NO_EM_RESTART': '1', 08:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:24:59 INFO - 'PWD': '/builds/slave/test', 08:24:59 INFO - 'SHELL': '/bin/bash', 08:24:59 INFO - 'SHLVL': '1', 08:24:59 INFO - 'TERM': 'linux', 08:24:59 INFO - 'TMOUT': '86400', 08:24:59 INFO - 'USER': 'cltbld', 08:24:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:24:59 INFO - '_': '/tools/buildbot/bin/python'} 08:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:24:59 INFO - Downloading/unpacking jsonschema==2.5.1 08:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:25:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:25:01 INFO - warning: no files found matching '*.txt' 08:25:01 INFO - no previously-included directories found matching 'build' 08:25:01 INFO - no previously-included directories found matching 'dist' 08:25:01 INFO - no previously-included directories found matching '.git*' 08:25:01 INFO - Installing collected packages: jsonschema, functools32 08:25:01 INFO - Running setup.py install for functools32 08:25:01 INFO - warning: no files found matching '*.txt' 08:25:01 INFO - no previously-included directories found matching 'build' 08:25:01 INFO - no previously-included directories found matching 'dist' 08:25:01 INFO - no previously-included directories found matching '.git*' 08:25:01 INFO - Successfully installed jsonschema functools32 08:25:01 INFO - Cleaning up... 08:25:01 INFO - Return code: 0 08:25:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:25: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')]} 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25: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')]} 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:01 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:25:01 INFO - Using env: {'DISPLAY': ':0', 08:25:01 INFO - 'HOME': '/home/cltbld', 08:25:01 INFO - 'LANG': 'en_US.UTF-8', 08:25:01 INFO - 'LANGUAGE': 'en_US:en', 08:25:01 INFO - 'LOGNAME': 'cltbld', 08:25:01 INFO - 'MAIL': '/var/mail/cltbld', 08:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:01 INFO - 'MOZ_NO_REMOTE': '1', 08:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:01 INFO - 'NO_EM_RESTART': '1', 08:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:01 INFO - 'PWD': '/builds/slave/test', 08:25:01 INFO - 'SHELL': '/bin/bash', 08:25:01 INFO - 'SHLVL': '1', 08:25:01 INFO - 'TERM': 'linux', 08:25:01 INFO - 'TMOUT': '86400', 08:25:01 INFO - 'USER': 'cltbld', 08:25:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:01 INFO - '_': '/tools/buildbot/bin/python'} 08:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:04 INFO - Downloading docopt-0.6.1.tar.gz 08:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:25:04 INFO - Running setup.py install for blobuploader 08:25:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:25:04 INFO - Running setup.py install for requests 08:25:04 INFO - Running setup.py install for docopt 08:25:05 INFO - Successfully installed blobuploader requests docopt 08:25:05 INFO - Cleaning up... 08:25:05 INFO - Return code: 0 08:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:05 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:05 INFO - Using env: {'DISPLAY': ':0', 08:25:05 INFO - 'HOME': '/home/cltbld', 08:25:05 INFO - 'LANG': 'en_US.UTF-8', 08:25:05 INFO - 'LANGUAGE': 'en_US:en', 08:25:05 INFO - 'LOGNAME': 'cltbld', 08:25:05 INFO - 'MAIL': '/var/mail/cltbld', 08:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:05 INFO - 'MOZ_NO_REMOTE': '1', 08:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:05 INFO - 'NO_EM_RESTART': '1', 08:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:05 INFO - 'PWD': '/builds/slave/test', 08:25:05 INFO - 'SHELL': '/bin/bash', 08:25:05 INFO - 'SHLVL': '1', 08:25:05 INFO - 'TERM': 'linux', 08:25:05 INFO - 'TMOUT': '86400', 08:25:05 INFO - 'USER': 'cltbld', 08:25:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:05 INFO - '_': '/tools/buildbot/bin/python'} 08:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:05 INFO - Running setup.py (path:/tmp/pip-nUA9G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:05 INFO - Running setup.py (path:/tmp/pip-RoP08P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:05 INFO - Running setup.py (path:/tmp/pip-eGNJWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:05 INFO - Running setup.py (path:/tmp/pip-ytt1iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:05 INFO - Running setup.py (path:/tmp/pip-OcvA4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:05 INFO - Running setup.py (path:/tmp/pip-rxGqz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:05 INFO - Running setup.py (path:/tmp/pip-eu2XIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:05 INFO - Running setup.py (path:/tmp/pip-eqvnMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:05 INFO - Running setup.py (path:/tmp/pip-2x9CC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:05 INFO - Running setup.py (path:/tmp/pip-BN3o2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:06 INFO - Running setup.py (path:/tmp/pip-YIGF63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:06 INFO - Running setup.py (path:/tmp/pip-5qPKmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:06 INFO - Running setup.py (path:/tmp/pip-92u4lC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:06 INFO - Running setup.py (path:/tmp/pip-KYAw3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:06 INFO - Running setup.py (path:/tmp/pip-_jKyXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:06 INFO - Running setup.py (path:/tmp/pip-pd5XIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:06 INFO - Running setup.py (path:/tmp/pip-ppszZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:25:06 INFO - Running setup.py install for manifestparser 08:25:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozcrash 08:25:06 INFO - Running setup.py install for mozdebug 08:25:06 INFO - Running setup.py install for mozdevice 08:25:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:25:06 INFO - Running setup.py install for mozfile 08:25:07 INFO - Running setup.py install for mozhttpd 08:25:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozinfo 08:25:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozInstall 08:25:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozleak 08:25:07 INFO - Running setup.py install for mozlog 08:25:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for moznetwork 08:25:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozprocess 08:25:07 INFO - Running setup.py install for mozprofile 08:25:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozrunner 08:25:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:25:07 INFO - Running setup.py install for mozscreenshot 08:25:08 INFO - Running setup.py install for moztest 08:25:08 INFO - Running setup.py install for mozversion 08:25:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:25:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:25:08 INFO - Cleaning up... 08:25:08 INFO - Return code: 0 08:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:08 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:08 INFO - Using env: {'DISPLAY': ':0', 08:25:08 INFO - 'HOME': '/home/cltbld', 08:25:08 INFO - 'LANG': 'en_US.UTF-8', 08:25:08 INFO - 'LANGUAGE': 'en_US:en', 08:25:08 INFO - 'LOGNAME': 'cltbld', 08:25:08 INFO - 'MAIL': '/var/mail/cltbld', 08:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:08 INFO - 'MOZ_NO_REMOTE': '1', 08:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:08 INFO - 'NO_EM_RESTART': '1', 08:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:08 INFO - 'PWD': '/builds/slave/test', 08:25:08 INFO - 'SHELL': '/bin/bash', 08:25:08 INFO - 'SHLVL': '1', 08:25:08 INFO - 'TERM': 'linux', 08:25:08 INFO - 'TMOUT': '86400', 08:25:08 INFO - 'USER': 'cltbld', 08:25:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:08 INFO - '_': '/tools/buildbot/bin/python'} 08:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:25:08 INFO - Running setup.py (path:/tmp/pip-dweH6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:25:08 INFO - Running setup.py (path:/tmp/pip-MHeu2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:25:08 INFO - Running setup.py (path:/tmp/pip-mEtepR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:25:08 INFO - Running setup.py (path:/tmp/pip-orA8hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:25:08 INFO - Running setup.py (path:/tmp/pip-E34FL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:25:08 INFO - Running setup.py (path:/tmp/pip-OFNfb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:25:08 INFO - Running setup.py (path:/tmp/pip-Snv06s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:25:09 INFO - Running setup.py (path:/tmp/pip-UzjNMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:25:09 INFO - Running setup.py (path:/tmp/pip-XPmeWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:25:09 INFO - Running setup.py (path:/tmp/pip-zoBqAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:25:09 INFO - Running setup.py (path:/tmp/pip-9k3zH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:25:09 INFO - Running setup.py (path:/tmp/pip-Qm_ymv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:25:09 INFO - Running setup.py (path:/tmp/pip-HROaLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:25:09 INFO - Running setup.py (path:/tmp/pip-a80N6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:25:09 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)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:09 INFO - Running setup.py (path:/tmp/pip-As_IRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:25:09 INFO - Running setup.py (path:/tmp/pip-XUEDYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:25:09 INFO - Running setup.py (path:/tmp/pip-BfdYCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:25:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:11 INFO - Downloading blessings-1.6.tar.gz 08:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:25:11 INFO - Installing collected packages: blessings 08:25:11 INFO - Running setup.py install for blessings 08:25:11 INFO - Successfully installed blessings 08:25:11 INFO - Cleaning up... 08:25:11 INFO - Return code: 0 08:25:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:12 INFO - Reading from file tmpfile_stdout 08:25:12 INFO - Current package versions: 08:25:12 INFO - argparse == 1.2.1 08:25:12 INFO - blessings == 1.6 08:25:12 INFO - blobuploader == 1.2.4 08:25:12 INFO - docopt == 0.6.1 08:25:12 INFO - functools32 == 3.2.3-2 08:25:12 INFO - jsonschema == 2.5.1 08:25:12 INFO - manifestparser == 1.1 08:25:12 INFO - mozInstall == 1.12 08:25:12 INFO - mozcrash == 0.17 08:25:12 INFO - mozdebug == 0.1 08:25:12 INFO - mozdevice == 0.48 08:25:12 INFO - mozfile == 1.2 08:25:12 INFO - mozhttpd == 0.7 08:25:12 INFO - mozinfo == 0.9 08:25:12 INFO - mozleak == 0.1 08:25:12 INFO - mozlog == 3.2 08:25:12 INFO - moznetwork == 0.27 08:25:12 INFO - mozprocess == 0.23 08:25:12 INFO - mozprofile == 0.28 08:25:12 INFO - mozrunner == 6.12 08:25:12 INFO - mozscreenshot == 0.1 08:25:12 INFO - mozsystemmonitor == 0.3 08:25:12 INFO - moztest == 0.7 08:25:12 INFO - mozversion == 1.4 08:25:12 INFO - psutil == 3.1.1 08:25:12 INFO - requests == 1.2.3 08:25:12 INFO - wsgiref == 0.1.2 08:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 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 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:25:12 INFO - Using env: {'DISPLAY': ':0', 08:25:12 INFO - 'HOME': '/home/cltbld', 08:25:12 INFO - 'LANG': 'en_US.UTF-8', 08:25:12 INFO - 'LANGUAGE': 'en_US:en', 08:25:12 INFO - 'LOGNAME': 'cltbld', 08:25:12 INFO - 'MAIL': '/var/mail/cltbld', 08:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:12 INFO - 'MOZ_NO_REMOTE': '1', 08:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:12 INFO - 'NO_EM_RESTART': '1', 08:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:12 INFO - 'PWD': '/builds/slave/test', 08:25:12 INFO - 'SHELL': '/bin/bash', 08:25:12 INFO - 'SHLVL': '1', 08:25:12 INFO - 'TERM': 'linux', 08:25:12 INFO - 'TMOUT': '86400', 08:25:12 INFO - 'USER': 'cltbld', 08:25:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:12 INFO - '_': '/tools/buildbot/bin/python'} 08:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:25:12 INFO - Cleaning up... 08:25:12 INFO - Return code: 0 08:25:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:25:12 INFO - Using env: {'DISPLAY': ':0', 08:25:12 INFO - 'HOME': '/home/cltbld', 08:25:12 INFO - 'LANG': 'en_US.UTF-8', 08:25:12 INFO - 'LANGUAGE': 'en_US:en', 08:25:12 INFO - 'LOGNAME': 'cltbld', 08:25:12 INFO - 'MAIL': '/var/mail/cltbld', 08:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:12 INFO - 'MOZ_NO_REMOTE': '1', 08:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:12 INFO - 'NO_EM_RESTART': '1', 08:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:12 INFO - 'PWD': '/builds/slave/test', 08:25:12 INFO - 'SHELL': '/bin/bash', 08:25:12 INFO - 'SHLVL': '1', 08:25:12 INFO - 'TERM': 'linux', 08:25:12 INFO - 'TMOUT': '86400', 08:25:12 INFO - 'USER': 'cltbld', 08:25:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:12 INFO - '_': '/tools/buildbot/bin/python'} 08:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:25:12 INFO - Cleaning up... 08:25:12 INFO - Return code: 0 08:25:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:25:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f341782bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d8d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e58350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, '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': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:25:12 INFO - Using env: {'DISPLAY': ':0', 08:25:12 INFO - 'HOME': '/home/cltbld', 08:25:12 INFO - 'LANG': 'en_US.UTF-8', 08:25:12 INFO - 'LANGUAGE': 'en_US:en', 08:25:12 INFO - 'LOGNAME': 'cltbld', 08:25:12 INFO - 'MAIL': '/var/mail/cltbld', 08:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:12 INFO - 'MOZ_NO_REMOTE': '1', 08:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:12 INFO - 'NO_EM_RESTART': '1', 08:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:12 INFO - 'PWD': '/builds/slave/test', 08:25:12 INFO - 'SHELL': '/bin/bash', 08:25:12 INFO - 'SHLVL': '1', 08:25:12 INFO - 'TERM': 'linux', 08:25:12 INFO - 'TMOUT': '86400', 08:25:12 INFO - 'USER': 'cltbld', 08:25:12 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:12 INFO - '_': '/tools/buildbot/bin/python'} 08:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:25:12 INFO - Downloading/unpacking flake8 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:25:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:25:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25: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 08:25:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:25:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:15 INFO - no previously-included directories found matching 'docs/_build' 08:25:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:25:15 INFO - Running setup.py install for pep8 08:25:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:25:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:25:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:25:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:25:15 INFO - no previously-included directories found matching 'docs/_build' 08:25:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:25:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:25:15 INFO - Cleaning up... 08:25:15 INFO - Return code: 0 08:25:15 INFO - Running post-action listener: _resource_record_post_action 08:25:15 INFO - Running post-action listener: _start_resource_monitoring 08:25:15 INFO - Starting resource monitoring. 08:25:15 INFO - ##### 08:25:15 INFO - ##### Finished create-virtualenv step (success) 08:25:15 INFO - ##### 08:25:15 INFO - ##### 08:25:15 INFO - ##### Running install step. 08:25:15 INFO - ##### 08:25:15 INFO - Running pre-action listener: _resource_record_pre_action 08:25:15 INFO - Running main action method: install 08:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:25:15 INFO - Reading from file tmpfile_stdout 08:25:15 INFO - Detecting whether we're running mozinstall >=1.0... 08:25:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:25:16 INFO - Reading from file tmpfile_stdout 08:25:16 INFO - Output received: 08:25:16 INFO - Usage: mozinstall [options] installer 08:25:16 INFO - Options: 08:25:16 INFO - -h, --help show this help message and exit 08:25:16 INFO - -d DEST, --destination=DEST 08:25:16 INFO - Directory to install application into. [default: 08:25:16 INFO - "/builds/slave/test"] 08:25:16 INFO - --app=APP Application being installed. [default: firefox] 08:25:16 INFO - mkdir: /builds/slave/test/build/application 08:25:16 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'] 08:25:16 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 08:25:32 INFO - Reading from file tmpfile_stdout 08:25:32 INFO - Output received: 08:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 08:25:32 INFO - Running post-action listener: _resource_record_post_action 08:25:32 INFO - ##### 08:25:32 INFO - ##### Finished install step (success) 08:25:32 INFO - ##### 08:25:32 INFO - ##### 08:25:32 INFO - ##### Running run-tests step. 08:25:32 INFO - ##### 08:25:32 INFO - Running pre-action listener: _resource_record_pre_action 08:25:32 INFO - Running main action method: run_tests 08:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:25:32 INFO - Python 2.7.3 08:25:32 INFO - Return code: 0 08:25:32 INFO - grabbing minidump binary from tooltool 08:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:25:32 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 0x1ee71c0>, '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 0x1ee80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:25:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:25:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:25:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:25:32 INFO - Return code: 0 08:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:25:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:25:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:25:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:25:33 INFO - Return code: 0 08:25:33 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/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:25:33 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/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 08:25:33 INFO - Using env: {'DISPLAY': ':0', 08:25:33 INFO - 'HOME': '/home/cltbld', 08:25:33 INFO - 'LANG': 'en_US.UTF-8', 08:25:33 INFO - 'LANGUAGE': 'en_US:en', 08:25:33 INFO - 'LOGNAME': 'cltbld', 08:25:33 INFO - 'MAIL': '/var/mail/cltbld', 08:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:33 INFO - 'MOZ_NO_REMOTE': '1', 08:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:33 INFO - 'NO_EM_RESTART': '1', 08:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:33 INFO - 'PWD': '/builds/slave/test', 08:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:33 INFO - 'SHELL': '/bin/bash', 08:25:33 INFO - 'SHLVL': '1', 08:25:33 INFO - 'TERM': 'linux', 08:25:33 INFO - 'TMOUT': '86400', 08:25:33 INFO - 'USER': 'cltbld', 08:25:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116', 08:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:33 INFO - '_': '/tools/buildbot/bin/python'} 08:25:33 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/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:25:33 INFO - mozversion application_buildid: 20160721053620 08:25:33 INFO - mozversion application_changeset: 2a0945d032b12dd57f8e599b35a4d76f3557350e 08:25:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:25:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:25:33 INFO - mozversion application_name: Firefox 08:25:33 INFO - mozversion application_remotingname: firefox-dev 08:25:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:25:33 INFO - mozversion application_vendor: Mozilla 08:25:33 INFO - mozversion application_version: 49.0a2 08:25:33 INFO - mozversion platform_buildid: 20160721053620 08:25:33 INFO - mozversion platform_changeset: 2a0945d032b12dd57f8e599b35a4d76f3557350e 08:25:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:25:33 INFO - mozversion platform_version: 49.0a2 08:25:33 INFO - using testdate: 1469114733 08:25:33 INFO - actual date: 1469114733 08:25:33 INFO - starting webserver on 'localhost:38626' 08:25:33 INFO - SUITE-START | Running 2 tests 08:25:33 INFO - TEST-START | dromaeo_css 08:25:33 INFO - operating with platform_type : linux_ 08:25:33 INFO - Initialising browser for dromaeo_css test... 08:25:33 INFO - TEST-INFO | started process 5215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vtB6S/profile http://localhost:38626/getInfo.html) 08:25:38 INFO - PROCESS | 5215 | __metrics Screen width/height:1600/1200 08:25:38 INFO - PROCESS | 5215 | colorDepth:24 08:25:38 INFO - PROCESS | 5215 | Browser inner width/height: 1024/697 08:25:38 INFO - PROCESS | 5215 | __metrics 08:25:39 ERROR - PROCESS | 5215 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:25:40 INFO - TEST-INFO | 5215: exit 0 08:25:40 INFO - Browser initialized. 08:25:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:25:40 INFO - TEST-INFO | started process 5344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6vtB6S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:51 INFO - PROCESS | 5344 | RSS: Main: 156176384 08:25:51 INFO - PROCESS | 5344 | 08:26:41 INFO - PROCESS | 5344 | 1469114801494 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:28:49 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38626/tests/dromaeo/cssquery-ext.html) 08:28:50 INFO - PROCESS | 5344 | RSS: Main: 159260672 08:28:50 INFO - PROCESS | 5344 | 08:31:52 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-ext.html (next: http://localhost:38626/tests/dromaeo/cssquery-jquery.html) 08:31:52 INFO - PROCESS | 5344 | RSS: Main: 157528064 08:31:52 INFO - PROCESS | 5344 | 08:34:54 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38626/tests/dromaeo/cssquery-mootools.html) 08:34:55 INFO - PROCESS | 5344 | RSS: Main: 157188096 08:34:55 INFO - PROCESS | 5344 | 08:37:57 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38626/tests/dromaeo/cssquery-prototype.html) 08:37:57 INFO - PROCESS | 5344 | RSS: Main: 156475392 08:37:57 INFO - PROCESS | 5344 | 08:41:00 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38626/tests/dromaeo/cssquery-yui.html) 08:41:00 INFO - PROCESS | 5344 | RSS: Main: 158437376 08:41:00 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | Cycle 1(1): loaded http://localhost:38626/tests/dromaeo/cssquery-yui.html (next: http://localhost:38626/tests/dromaeo/cssquery-dojo.html) 08:44:03 INFO - PROCESS | 5344 | RSS: Main: 158765056 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | __start_tp_report 08:44:03 INFO - PROCESS | 5344 | _x_x_mozilla_page_load 08:44:03 INFO - PROCESS | 5344 | _x_x_mozilla_page_load_details 08:44:03 INFO - PROCESS | 5344 | |i|pagename|runs| 08:44:03 INFO - PROCESS | 5344 | |0;dojo.html;3359.9664003359967;3388.5594872666547;3400.4219282721942;3402.744794140437;3407.9318413631727;5541.307336582927;5574.944250557493;5600.215969764231;5601.495865372116;5658.43415658434;5598.496135347828;5663.5186009189165;5675.489205971462;5679.375268720438;5685;5056.721880296592;5098;5155.896882062357;5160.354955630546;5167.173252279636;4990.026944745776;5002.074616195997;5135.05001574708;5174.974125129388;5182.196759502283;5124.052050370675;5138.511841375082;5151.4075881273575;5153.896922061556;5262.394824595182;5209.114450543379;5230.032443997872;5246.291750613656;5258.395284542288;5259.027079990195;4866.9513304867205;5013.623978201649;5097.235414687826;5111.361079865017;5147.588192944593;5511.283533140666;5544.500994910437;5573.693446860421;5588.692621905793;5593.04918163909;6000.549958753111;6030.035194368924;6046.18376519173;6052.455279024909;6068.271807383142;5801.53587712982;5931.703414829241;5948.553858460589;6056.454919057306;6069.393060693939;5660.915086273709;5674.631148975303;5677.545796336283;5680.0627896397045;5705.400932902027;6181.567290289727;6193.194884664965;6206.875862482725;6211.534134939898;6222.719977601018;5679.829605111853;5824.126381042877;5842.298924129132;5863.149843272701;5918.763249470059;5965.403459654;5978.461938425476;6005.789797357072;6007.429294217042;6020.187274717857;5959.731812068468;5977.342492325841;5989.31122920861;6002.789902353484;6019.157317975487;5865.061590145556;5954.315253745788;5973.104034394789;6003.8198854034445;6091.0558863376245;4636.420447444069;4645.628349732014;4656.2498446424825;4658.976705116453;4683.274092515598;4079.204555111725;4167.083241686824;4186.267403204488;4190.790460477025;4200.705950583491;5579.330480342385;5700.315962084494;5752;5772.307323121252;5795.536357091422;6007.849803754941;6021.909671354933;6103.816885493442;6114.877702445926;6135.233095863017;5641.633293835887;5820.243368362086;5830.4461076197695;5833.679147646835;5851.561132915049;5103.948960510347;5114.3862736471865;5119.104156772624;5149.098907691139;5149.536541711264;6195.845103872349;6220.253569571681;6243.968780156161;6248.31268560458;6263.655498947511;5903.91144132847;6027.969860150846;6056.242969628885;6067.180930574316;6076.817695469143;6205.131281620667;6337.904931426125;6368.108464815023;6373.203349581302;6376.458001069961;5910.970445147746;5927.170196172626;5985.341612422717;5992.730327135202;6017.578769486094;5850.678212698343;5941.881162376815;5988.850278743066;6103.542234332354;6104.633721976696;5902.321233058254;5950.7917222896995;5955.821325360246;5957.791477298447;5974.4324289192455;5819.301683797802;5918.911216331672;5921.289445266596;5941.0197317442135;5941.732622031933;5596.048671725735;5701.287339082614;5712.143178523254;5749.8275051748515;5833.0375488044;5736.68448235351;5861.1501332305725;5943.197668314895;5950.910736339045;5970.701464926823;5796.159556864315;5823.35943046273;5828.53371730269;5843.1235314703135;5849.883002339844 08:44:03 INFO - PROCESS | 5344 | |1;ext.html;591.3701907468545;632.7184402940693;651.9152510173677;653.4543656047198;665.7603262825384;35474.58101675933;39307.213855722905;46011.079778404455;47142.76428617852;47232;48853;48936;49200;49414.25878611824;49458.75270623642;8971.82056358874;8982.910170898273;9075.455472671627;9087.409318394282;9120;8921.687740929068;8937.106289371044;9018.729438116867;9021.774455638595;9027.684031058914;9019.188273055424;9042.864357034618;9091.727248182531;9106.499142547158;9118.635254589808;8982.236509896635;9011.909880901205;9038.954805225998;9047.81904361909;9071.591778369957;8870.112988701143;8884.8667269991;8916.687915922976;8948.328875334377;8958.283337332998;46216;46279.5372046282;46363.76818115922;46561.76719116417;46579;3675.9264814703556;3700.1119731264303;3705.555333359987;3860.4595356650093;3881;34902.30195396103;35263.29473410543;35881.46177807335;36156;36733.63266367329;4750.840933522913;4753.453352864396;4766.118268120409;4807.206810876201;4850.223964165752;395282;409236;409277;412581;413279;67274;67433;67951.32048679549;67974.32025679779;68045.65977170083;39546.40680389797;39554.80222598926;40049.19901601952;42723.14553708908;42731.57268427338;19532.511687207934;19717.211311547664;19735.802641973398;19751.308704195286;19803.306884258982;14703;14861.405543778128;14934.551963441114;14979.101253924582;15005.849941500444;21237.78762212389;21439.464013399476;21605.135794568356;21643.891780541;21782.56434871294;7458.627068646654;7657.808554786175;7715.4599178057;7952.801179970547;7965.761027169194;1017.2675673515205;1064.5369264370024;1093.3658478082693;1159.646307876106;1173.3018853781987;33236.50145247823;33429.83285083559;33536.83231583826;33686.15784605355;34111.14722131967;1225.9754804903853;1247.8627350991383;1269.6571925580042;1274.8278982337451;1321.7224382879704;17485.65028699444;17952.19215135322;17986.640267194845;18028.549286267687;18059.187336569885;656544;684162;689124;689790;690572;65338.67330663411;65465.345346545924;66118.66940665265;66124.6693766528;66161.33838661648;1487.3381345301455;1493.5817970967928;1493.6340596553914;1495.155237290927;1511.3878879054;32763.508547372287;33097.338053239284;33316.33367332688;33466.49800253047;33700.99562085887;58015.41984580269;58527.4147258539;58706.412935870096;58754.412455876605;58795;513182;518159;518268;518499;519049;30866.84566577153;31084.689153109084;32013.199670007503;32144.19639509031;33810.49284260787;53893.19160212522;54067.72966135144;54471;55004.449955499935;55650.44349556453;44750;44818;45137.548624514646;45726.54273457223;46311;43675.344869826346;43731.562684374025;43768;44717.329240060775;45110.77444612756;45233.77383113195;45317.320240197085;46448.30327545022;46750;48865.267020994004;39034.80482597569;39672.40491392574;39695;39696.801515992236;40137.799311003255;29301.706982929896;30191.849040754656;30455.84772076214;30669.8466507666;30967 08:44:03 INFO - PROCESS | 5344 | |2;jquery.html;434.6913691279191;437.2108344438292;437.25448110970797;437.94087798147245;443.2464809823299;18583.25666973321;19613;20463.795362046374;20580.1767929283;20673.276435324766;18715.43853684388;19319;19441.902790486063;19503.512412189702;19948.800511994876;5392;5580.888382232373;5616.438356164392;5617.634853734515;5628;5462.180672899057;5500.367457742371;5504;5661.830145095633;6043.728032238538;5985.790497332594;5993.250843644544;6006.699665016754;6030.66831324277;6034.879302413971;5474.753636086386;5754.251947246831;5765.596408251424;5971.313298970631;5991.670458124801;5636.4927156556105;5642.322921249435;5656.575756818255;5699.601027928046;6135.631862088289;14813.111213327235;14967.550973470814;15165.848341516554;15211.391544338214;24418;2322.4310044039316;2390.892409841544;2464.1868183499582;2543.8728063596745;2778.597103420013;10303.33028353162;10509.9474502627;10881.891181088167;10930.726731831688;11906.821397679041;2040.4286799696108;2056.629806634805;2088.373487953623;2100.380387785607;2131.3925531223526;59692;73828.63085684537;75566.24433755648;80752;84914;11563.595274165533;11693.532258709556;11826.822597661041;12040.879591204151;12118.75762484763;16545.172741362883;16595.83404165967;16656.33374665024;16672.833271667372;16694.6661066778;8498.362622803315;8529.957350213333;8651.740447786577;8753.168448997336;8824.691135810215;8193.4674246175;8269.710560130367;8304;8349.206825351703;8378.371622128365;4957.553820156203;5061.772220250097;5080.822171223989;5086.415062267813;5106.361704786902;2056.393363957636;2133.839962002825;2134.2423439679;2144.57108578285;2149.355193441961;999.8250306196387;1034.5551412892528;1105.160078340467;1109.6116359274351;1156.7686462707493;19981.300654477025;20002.299919502748;20273.69589456159;20379.388618341472;20418;1029.8815636201782;1031.5615863258085;1074.5594306334365;1103.9779204415868;1105.4362275239685;10488.31825931312;11269.380184089954;11345.94327028376;11490.310581365145;11517.193796434336;366368;368433;370164;479945;507235.39146912826;94787;98249.50875245577;101385;102269.48865255775;102990.48504757429;1095.5453486803046;1115.4813011949482;1127.7124333294958;1135.9091272698165;1136.5908273021705;18095.185716643045;18103.275868965095;18194.45416637503;18247.81752182514;18576.907115464335;41158.9710257246;42026.159476810906;42047.15905681808;43233.56766432421;44051.33922991222;59817.700911495165;61204.38795611987;61984;62700.372996269456;62739.372606273355;8973;9244.445333280024;9394.577244024173;9535.713928582154;9598.32811703174;13980.231087290296;14395.64010899694;14416;14424.711505770036;14479.710405792035;12431;12573.93713031429;12632.242065475733;12674.619761407173;12701.491940322283;11772.764544708887;11855.881441185478;11889.881101188877;12365.443555039865;12454.25274483534;12509.249445033327;12733.872661273268;12850.55023074188;12868.292243926673;12876.613701588967;9327.533623318672;9374.343795934219;9401.435913845191;9497.905020949702;9521.095495927875;10695.304805187638;12556.183848049848;12735.363231838557;12805.679858003625;12826.294553799258 08:44:03 INFO - PROCESS | 5344 | |3;mootools.html;1566.1621032747482;1613.032180691585;1812.3203798575535;1926.9903650481745;1946.4452631000167;8792.164744349277;9528.142467177953;9617.182539484153;10242.436665983369;10310.329828561138;9734.123928846402;10011.849822252654;10099.29304948654;10104.797904041914;10115.089641932225;2567.640530325751;2593.6368908352847;2596.1692258477296;2596.623489594008;2598.3634009667658;2521.8991240350365;2582.0317380982133;2587.3531617095728;2593.0535354595627;2602.9739702603015;2542.1356738708837;2550.4899020195944;2589.1196993022368;2591.0542651932096;2593.390553219992;2410.6986626671664;2462.7167875694254;2462.827602067856;2498.7001559812757;2505.6241563765398;2454.4968281502247;2470.2465747946867;2488.029668429314;2505.248425472351;2546.567083595793;9806.90193098074;9980.850287245625;9991.150752186073;10049.949750251202;10068.94965525175;5836.824895253149;6021.397860213988;6022.548308876808;6034.939650603482;6052;3933.213357328546;3969.7816620085882;4032.3951407288846;4088.34586466164;4092.2224777292217;1271.4151490314466;1313.4811749359046;1343.984023964054;1357.104311154643;1366.2075995922341;14148.717025659533;14221.644458888508;14355.85644143566;14370.20963846988;14438.711225775425;5191.480851914778;5214.608904332114;5377.435369286247;5414.593905457106;5424.05079111154;11834.88165118355;11852.940735296268;11860.169788114921;11920.046396288277;11942;5955.28536575605;6038.426349496791;6064.423879731418;6083.330833608299;6107.114468402056;4826.927596086061;5339.252504649352;5480.424555421703;5489.615726899079;5593.580481463907;4474.597286244254;4497.64018878489;4547.3406356078185;4594.724316541018;4596.655250856199;1410.6825964157983;1417.574727581742;1432.7421064208543;1440.942362305517;1462.5831637983124;1042.47876061969;1047.4657924458581;1061.193492945367;1074.6292529077455;1092.202692034819;6781.8643627127185;6812.4550035997;6850.554713943578;6924.688389022506;6950.79147625572;504.50306448148547;515.0548743056534;518.7406296851574;520.97916083357;533.5331584863245;4649.465311489222;4658.767061646972;4663.145434832336;4690.085433340534;4713.151632706077;12350.876491235153;12539.184952978027;12723.745525089631;12827.743445131046;12857;12056.758864822654;12446.502139914483;12636.55772047974;12654.746905061847;12655.177413468095;9041.502717350477;9418.811623767486;9453.76365590852;9471.052894710474;9528.237740980705;6564.376384243489;6642.767503137367;6721.092652491851;6746.730130794714;6817.352351526597;11447.370394628375;11708.590199343324;11807.645770626896;11808.468618912342;11982.460789264329;11673.649790506299;11832.881671183179;11920.642380728592;11927.46326415296;12085;7715.807104822425;8790.560471976247;8903.421277617193;9041.141091596288;9056.230220431336;9956.452395118338;10019.348742331726;10035.297529172887;10038;10053;8195.71315003972;8362.331013518782;8402.369822263478;8649.437786543855;8879.11208879107;8288;8415.495070295801;8610.61252243638;8671.34964877624;8876.423032502867;7762.7671169865;7769;7837.216278372117;7853.175416581176;7866.095399029185;5695.174199741097;5947.524198064231;5983.551233657406;6009.699515024144;6081.787137450168;6007.219061521974;6019.277686677627;6041.426064524039;6113.02191649334;6161.938380616137 08:44:03 INFO - PROCESS | 5344 | |4;prototype.html;352.6050823078153;361.0576395607464;362.3640510903365;370.4517314374727;370.53312825839436;5615.80344687936;5641.68970706612;5758.337791154018;5793.856273178924;5822.534197264219;5643;5668;5692.829215123553;5700.258966334371;5741.511971482429;4413.521470307451;4429.585875697744;4446.933296000547;4458.375827384169;4460.66545009124;4368.868933931971;4409.845655402061;4436.401085853401;4448.354988526662;4468.396766436538;4376.759278239696;4377.649788016967;4391.407160033403;4400.185965596359;4401.66987475939;4402.801873915681;4448.97571604919;4452.710573812724;4464.977675111636;4472.709273897186;3680.35593771089;3866.7099967502268;3956.4658771066115;3960.2277555876617;3963.1677347756718;5408.8377348679605;5425.321834770653;5455.918161227585;5470.370907345627;5491.533219676332;4988.82539111133;4997.550220480138;5010.4739002404585;5017.519831649672;5022.447530771612;5596.720163991825;5839.153322768218;5847.590668653196;5867.858231745425;5872.265966754156;4218.388333691598;4220.775974967256;4224.281872081723;4248.277792775236;4259.148170365939;6110.266767987825;6154.692265386758;6162.7534898604;6221.626702397825;6222.097795819581;4218.1861501729545;4351.912961740747;4362.5821607976895;4365.214261432909;4396.1867054595;4371.388005679208;4371.650267978554;4372.213001659668;4420.872677467225;4456.729831997865;4988.152014157602;5002.374228375792;5037.899242015139;5055.51972562606;5074.441811400743;5699.715014249271;5882.55880808941;5919.904817608756;5937.643741375445;6005;1500.5219858439427;1523.6190952261934;1528.6547837902574;1540.1990964698518;1541.7456119740118;969.0454901921602;971.8396464583406;976.6776963601994;976.7606936300651;995.4674249276748;5167.328247327899;5211.452797456288;5228.843134705965;5243.898781255903;5251.553617942442;5468.043092458884;5474.288342515527;5487;5496.890062198733;5534.667919924736;5048.697078175322;5151.22731590257;5158.587313014949;5163.66436181647;5250.422453530108;2968.717971792676;2969.62879640045;2969.9554506682416;2986.581878536963;2994.31130839908;5553.861153471114;5570.802277510274;5594.608377413623;5618.522425593788;5649.943500565024;5125.820596279113;5525.171224316385;5531.834044978657;5536.667799932017;5545.445455454503;5572.659483017062;5587.396129496452;5598.916016259759;5657.916435542639;5671.149327600893;5203.297554830201;5480.753366098455;5512.298973503035;5520;5554.944450555443;5371.355437347544;5401.405845357086;5404.378496472956;5406.134883465198;5414.648047876875;5609.971950140223;5647.265855438766;5697.515711164431;5717.742701578356;5719;3977.3437382832667;3981.6416522513114;4044.9191016180102;4365.1229971112725;4375.803088861073;5936.7922122725495;6053.909191362045;6079.118527813531;6108.969455152695;6116.327204007466;5885.205497257986;5927.31835838884;6007.459328660441;6029.472758436364;6029.78895738647;5957.7319020645045;5959.851003724942;6002.609830361187;6039.939600603938;6040.909386359121;5733.283339582552;5885.5880088395115;5914.142449344735;5922.230110085661;5981.401859814157;5995.250593675791;6035.491127218195;6055.848603784941;6058.5153187745755;6072.72672729737;5697.943020569907;5936.168936349001;5944.286685597756;5947.553933454921;5952.5833191676165 08:44:03 INFO - PROCESS | 5344 | |5;yui.html;796.9800754981128;807.5235610989515;813.1705660226565;853.2832420766556;902.9413088149265;15946.760798588017;16163.434279800209;16365.42721004765;16373.181340932966;16378.83621163788;15394.384224631029;15456.536303910872;15497.457588984387;15590.844091559082;15598.766018509732;732.6995931668004;873.4933738431727;887.8446271902424;890.1499068389672;892.0232345581578;855.80744332525;861.1001503428931;867.6182479708908;868.15355028847;868.5396739727954;901.3960646366917;916.2990312411011;916.4592890194783;918.1140199707281;919.1865199298602;903.9593218305192;908.4322298563397;910.508325504227;912.3522299167565;913.137085454246;669.7722774256777;673.3300366135677;673.7944926797325;676.0062707819498;678.1455366238525;13933.442662293495;13950.302484875716;13963.79054314186;13970.161790292615;13984.091034082752;14990;15414.76094570059;15729.528114156594;15913.840861591467;16275.348986040544;13176.472941082346;13386.062975591713;13506.122102063433;13518.662033449144;13570.660733481644;4063.3904914262803;4117.75293482392;4213.557576454459;4214.093969796509;4214.262504061808;79387.60306198432;80516.59741701312;80581;80615.5969220156;81759.59120204361;12531.812022819666;12606.684832879251;12724.045696572794;12813.295268760121;13110.803337949937;20482.38552843417;20696.896515517627;20709.0680919359;20723.481912951996;20814;9485.857712134324;9499.145076943109;9561.187299079656;9601.615935362508;10033.498325083716;4950.876228094255;5157.381114266237;5284.9735751320995;5426.945730542644;5515.09001014828;4111.444954931106;4275.957240427618;4284.700070995063;4310.61204491591;4313.266744653353;705.3158436316764;709.7125664106045;717.7703134996856;729.533098816747;733.8092096055065;789.2856964447185;818.1613845808095;847.2459511035183;847.7075408983891;863.9848178390366;10338.689839304832;10788.946055269831;10983.231173817916;10984.945075274572;11132.721681958015;666.7327125024709;819.3486178488116;820.0692214336771;823.1603764160642;856.5973992223645;4807.807687692453;4818.7831547580445;4843.709377437294;4872.731999739977;4981.178105612534;69263.65368173127;70485;70844;71136.64431677808;90719;95655.52172239234;95847.52076239574;96422.51788741011;98769.50615247022;102270.48864755628;90946.54526727456;90950.09049909416;91121.54439227762;91997.99999999866;93052.53473732724;9754.9024509754;9908.157806586232;10541.262111652111;10891.18316126278;11004.889951100387;37740.81129594334;43888.780556098296;43931.78034109809;44072.118557628026;48085.5191448081;51659.741701292754;52860.47139528555;76024;77256.61371693331;77753;13889.374978125807;14449.85550144485;14522.85477145215;14567.562973110824;14682;15221.162836044125;15824.683506330039;15886.16607087752;15953.521394358188;16029.67940641204;13855.930720346334;15227.847721522643;15263.618409539851;15663.451779187673;16095.75856362179;15117.697646046798;15466.381344746535;15759.369625214864;16369.263383147549;16382.262798173871;12600.117991740857;12683.746325073631;12703.42834572465;12716.237025778482;12791.616251512469;12267.141300108906;12456.31490268044;12511.874881251435;12649.494020239088;13019.674508137372;12099.697507562381;12215.877841221474;12424.198921830415;12529.749405012031;12575.371231438574 08:44:03 INFO - PROCESS | 5344 | __end_tp_report 08:44:03 INFO - PROCESS | 5344 | __start_cc_report 08:44:03 INFO - PROCESS | 5344 | _x_x_mozilla_cycle_collect,334 08:44:03 INFO - PROCESS | 5344 | __end_cc_report 08:44:03 INFO - PROCESS | 5344 | __startTimestamp1469115843494__endTimestamp 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | ------- Summary: start ------- 08:44:03 INFO - PROCESS | 5344 | Number of tests: 6 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#0] dojo.html Cycles:165 Average:5604.68 Median:5824.13 stddev:617.63 (10.6%) stddev-sans-first:593.89 08:44:03 INFO - PROCESS | 5344 | Values: 3360.0 3388.6 3400.4 3402.7 3407.9 5541.3 5574.9 5600.2 5601.5 5658.4 5598.5 5663.5 5675.5 5679.4 5685.0 5056.7 5098.0 5155.9 5160.4 5167.2 4990.0 5002.1 5135.1 5175.0 5182.2 5124.1 5138.5 5151.4 5153.9 5262.4 5209.1 5230.0 5246.3 5258.4 5259.0 4867.0 5013.6 5097.2 5111.4 5147.6 5511.3 5544.5 5573.7 5588.7 5593.0 6000.5 6030.0 6046.2 6052.5 6068.3 5801.5 5931.7 5948.6 6056.5 6069.4 5660.9 5674.6 5677.5 5680.1 5705.4 6181.6 6193.2 6206.9 6211.5 6222.7 5679.8 5824.1 5842.3 5863.1 5918.8 5965.4 5978.5 6005.8 6007.4 6020.2 5959.7 5977.3 5989.3 6002.8 6019.2 5865.1 5954.3 5973.1 6003.8 6091.1 4636.4 4645.6 4656.2 4659.0 4683.3 4079.2 4167.1 4186.3 4190.8 4200.7 5579.3 5700.3 5752.0 5772.3 5795.5 6007.8 6021.9 6103.8 6114.9 6135.2 5641.6 5820.2 5830.4 5833.7 5851.6 5103.9 5114.4 5119.1 5149.1 5149.5 6195.8 6220.3 6244.0 6248.3 6263.7 5903.9 6028.0 6056.2 6067.2 6076.8 6205.1 6337.9 6368.1 6373.2 6376.5 5911.0 5927.2 5985.3 5992.7 6017.6 5850.7 5941.9 5988.9 6103.5 6104.6 5902.3 5950.8 5955.8 5957.8 5974.4 5819.3 5918.9 5921.3 5941.0 5941.7 5596.0 5701.3 5712.1 5749.8 5833.0 5736.7 5861.2 5943.2 5950.9 5970.7 5796.2 5823.4 5828.5 5843.1 5849.9 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#1] ext.html Cycles:180 Average:69840.79 Median:45275.55 stddev:145942.11 (322.3%) stddev-sans-first:146258.90 08:44:03 INFO - PROCESS | 5344 | Values: 591.4 632.7 651.9 653.5 665.8 35474.6 39307.2 46011.1 47142.8 47232.0 48853.0 48936.0 49200.0 49414.3 49458.8 8971.8 8982.9 9075.5 9087.4 9120.0 8921.7 8937.1 9018.7 9021.8 9027.7 9019.2 9042.9 9091.7 9106.5 9118.6 8982.2 9011.9 9039.0 9047.8 9071.6 8870.1 8884.9 8916.7 8948.3 8958.3 46216.0 46279.5 46363.8 46561.8 46579.0 3675.9 3700.1 3705.6 3860.5 3881.0 34902.3 35263.3 35881.5 36156.0 36733.6 4750.8 4753.5 4766.1 4807.2 4850.2 395282.0 409236.0 409277.0 412581.0 413279.0 67274.0 67433.0 67951.3 67974.3 68045.7 39546.4 39554.8 40049.2 42723.1 42731.6 19532.5 19717.2 19735.8 19751.3 19803.3 14703.0 14861.4 14934.6 14979.1 15005.8 21237.8 21439.5 21605.1 21643.9 21782.6 7458.6 7657.8 7715.5 7952.8 7965.8 1017.3 1064.5 1093.4 1159.6 1173.3 33236.5 33429.8 33536.8 33686.2 34111.1 1226.0 1247.9 1269.7 1274.8 1321.7 17485.7 17952.2 17986.6 18028.5 18059.2 656544.0 684162.0 689124.0 689790.0 690572.0 65338.7 65465.3 66118.7 66124.7 66161.3 1487.3 1493.6 1493.6 1495.2 1511.4 32763.5 33097.3 33316.3 33466.5 33701.0 58015.4 58527.4 58706.4 58754.4 58795.0 513182.0 518159.0 518268.0 518499.0 519049.0 30866.8 31084.7 32013.2 32144.2 33810.5 53893.2 54067.7 54471.0 55004.4 55650.4 44750.0 44818.0 45137.5 45726.5 46311.0 43675.3 43731.6 43768.0 44717.3 45110.8 45233.8 45317.3 46448.3 46750.0 48865.3 39034.8 39672.4 39695.0 39696.8 40137.8 29301.7 30191.8 30455.8 30669.8 30967.0 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#2] jquery.html Cycles:180 Average:27414.33 Median:2115.89 stddev:70315.94 (3323.2%) stddev-sans-first:70484.01 08:44:03 INFO - PROCESS | 5344 | Values: 434.7 437.2 437.3 437.9 443.2 18583.3 19613.0 20463.8 20580.2 20673.3 18715.4 19319.0 19441.9 19503.5 19948.8 5392.0 5580.9 5616.4 5617.6 5628.0 5462.2 5500.4 5504.0 5661.8 6043.7 5985.8 5993.3 6006.7 6030.7 6034.9 5474.8 5754.3 5765.6 5971.3 5991.7 5636.5 5642.3 5656.6 5699.6 6135.6 14813.1 14967.6 15165.8 15211.4 24418.0 2322.4 2390.9 2464.2 2543.9 2778.6 10303.3 10509.9 10881.9 10930.7 11906.8 2040.4 2056.6 2088.4 2100.4 2131.4 59692.0 73828.6 75566.2 80752.0 84914.0 11563.6 11693.5 11826.8 12040.9 12118.8 16545.2 16595.8 16656.3 16672.8 16694.7 8498.4 8530.0 8651.7 8753.2 8824.7 8193.5 8269.7 8304.0 8349.2 8378.4 4957.6 5061.8 5080.8 5086.4 5106.4 2056.4 2133.8 2134.2 2144.6 2149.4 999.8 1034.6 1105.2 1109.6 1156.8 19981.3 20002.3 20273.7 20379.4 20418.0 1029.9 1031.6 1074.6 1104.0 1105.4 10488.3 11269.4 11345.9 11490.3 11517.2 366368.0 368433.0 370164.0 479945.0 507235.4 94787.0 98249.5 101385.0 102269.5 102990.5 1095.5 1115.5 1127.7 1135.9 1136.6 18095.2 18103.3 18194.5 18247.8 18576.9 41159.0 42026.2 42047.2 43233.6 44051.3 59817.7 61204.4 61984.0 62700.4 62739.4 8973.0 9244.4 9394.6 9535.7 9598.3 13980.2 14395.6 14416.0 14424.7 14479.7 12431.0 12573.9 12632.2 12674.6 12701.5 11772.8 11855.9 11889.9 12365.4 12454.3 12509.2 12733.9 12850.6 12868.3 12876.6 9327.5 9374.3 9401.4 9497.9 9521.1 10695.3 12556.2 12735.4 12805.7 12826.3 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#3] mootools.html Cycles:180 Average:6611.38 Median:4090.28 stddev:3836.00 (93.8%) stddev-sans-first:3828.02 08:44:03 INFO - PROCESS | 5344 | Values: 1566.2 1613.0 1812.3 1927.0 1946.4 8792.2 9528.1 9617.2 10242.4 10310.3 9734.1 10011.8 10099.3 10104.8 10115.1 2567.6 2593.6 2596.2 2596.6 2598.4 2521.9 2582.0 2587.4 2593.1 2603.0 2542.1 2550.5 2589.1 2591.1 2593.4 2410.7 2462.7 2462.8 2498.7 2505.6 2454.5 2470.2 2488.0 2505.2 2546.6 9806.9 9980.9 9991.2 10049.9 10068.9 5836.8 6021.4 6022.5 6034.9 6052.0 3933.2 3969.8 4032.4 4088.3 4092.2 1271.4 1313.5 1344.0 1357.1 1366.2 14148.7 14221.6 14355.9 14370.2 14438.7 5191.5 5214.6 5377.4 5414.6 5424.1 11834.9 11852.9 11860.2 11920.0 11942.0 5955.3 6038.4 6064.4 6083.3 6107.1 4826.9 5339.3 5480.4 5489.6 5593.6 4474.6 4497.6 4547.3 4594.7 4596.7 1410.7 1417.6 1432.7 1440.9 1462.6 1042.5 1047.5 1061.2 1074.6 1092.2 6781.9 6812.5 6850.6 6924.7 6950.8 504.5 515.1 518.7 521.0 533.5 4649.5 4658.8 4663.1 4690.1 4713.2 12350.9 12539.2 12723.7 12827.7 12857.0 12056.8 12446.5 12636.6 12654.7 12655.2 9041.5 9418.8 9453.8 9471.1 9528.2 6564.4 6642.8 6721.1 6746.7 6817.4 11447.4 11708.6 11807.6 11808.5 11982.5 11673.6 11832.9 11920.6 11927.5 12085.0 7715.8 8790.6 8903.4 9041.1 9056.2 9956.5 10019.3 10035.3 10038.0 10053.0 8195.7 8362.3 8402.4 8649.4 8879.1 8288.0 8415.5 8610.6 8671.3 8876.4 7762.8 7769.0 7837.2 7853.2 7866.1 5695.2 5947.5 5983.6 6009.7 6081.8 6007.2 6019.3 6041.4 6113.0 6161.9 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#4] prototype.html Cycles:180 Average:4840.57 Median:5469.21 stddev:1394.40 (25.5%) stddev-sans-first:1357.01 08:44:03 INFO - PROCESS | 5344 | Values: 352.6 361.1 362.4 370.5 370.5 5615.8 5641.7 5758.3 5793.9 5822.5 5643.0 5668.0 5692.8 5700.3 5741.5 4413.5 4429.6 4446.9 4458.4 4460.7 4368.9 4409.8 4436.4 4448.4 4468.4 4376.8 4377.6 4391.4 4400.2 4401.7 4402.8 4449.0 4452.7 4465.0 4472.7 3680.4 3866.7 3956.5 3960.2 3963.2 5408.8 5425.3 5455.9 5470.4 5491.5 4988.8 4997.6 5010.5 5017.5 5022.4 5596.7 5839.2 5847.6 5867.9 5872.3 4218.4 4220.8 4224.3 4248.3 4259.1 6110.3 6154.7 6162.8 6221.6 6222.1 4218.2 4351.9 4362.6 4365.2 4396.2 4371.4 4371.7 4372.2 4420.9 4456.7 4988.2 5002.4 5037.9 5055.5 5074.4 5699.7 5882.6 5919.9 5937.6 6005.0 1500.5 1523.6 1528.7 1540.2 1541.7 969.0 971.8 976.7 976.8 995.5 5167.3 5211.5 5228.8 5243.9 5251.6 5468.0 5474.3 5487.0 5496.9 5534.7 5048.7 5151.2 5158.6 5163.7 5250.4 2968.7 2969.6 2970.0 2986.6 2994.3 5553.9 5570.8 5594.6 5618.5 5649.9 5125.8 5525.2 5531.8 5536.7 5545.4 5572.7 5587.4 5598.9 5657.9 5671.1 5203.3 5480.8 5512.3 5520.0 5554.9 5371.4 5401.4 5404.4 5406.1 5414.6 5610.0 5647.3 5697.5 5717.7 5719.0 3977.3 3981.6 4044.9 4365.1 4375.8 5936.8 6053.9 6079.1 6109.0 6116.3 5885.2 5927.3 6007.5 6029.5 6029.8 5957.7 5959.9 6002.6 6039.9 6040.9 5733.3 5885.6 5914.1 5922.2 5981.4 5995.3 6035.5 6055.8 6058.5 6072.7 5697.9 5936.2 5944.3 5947.6 5952.6 08:44:03 INFO - PROCESS | 5344 | 08:44:03 INFO - PROCESS | 5344 | [#5] yui.html Cycles:180 Average:19975.83 Median:24101.02 stddev:26848.02 (111.4%) stddev-sans-first:26884.72 08:44:03 INFO - PROCESS | 5344 | Values: 797.0 807.5 813.2 853.3 902.9 15946.8 16163.4 16365.4 16373.2 16378.8 15394.4 15456.5 15497.5 15590.8 15598.8 732.7 873.5 887.8 890.1 892.0 855.8 861.1 867.6 868.2 868.5 901.4 916.3 916.5 918.1 919.2 904.0 908.4 910.5 912.4 913.1 669.8 673.3 673.8 676.0 678.1 13933.4 13950.3 13963.8 13970.2 13984.1 14990.0 15414.8 15729.5 15913.8 16275.3 13176.5 13386.1 13506.1 13518.7 13570.7 4063.4 4117.8 4213.6 4214.1 4214.3 79387.6 80516.6 80581.0 80615.6 81759.6 12531.8 12606.7 12724.0 12813.3 13110.8 20482.4 20696.9 20709.1 20723.5 20814.0 9485.9 9499.1 9561.2 9601.6 10033.5 4950.9 5157.4 5285.0 5426.9 5515.1 4111.4 4276.0 4284.7 4310.6 4313.3 705.3 709.7 717.8 729.5 733.8 789.3 818.2 847.2 847.7 864.0 10338.7 10788.9 10983.2 10984.9 11132.7 666.7 819.3 820.1 823.2 856.6 4807.8 4818.8 4843.7 4872.7 4981.2 69263.7 70485.0 70844.0 71136.6 90719.0 95655.5 95847.5 96422.5 98769.5 102270.5 90946.5 90950.1 91121.5 91998.0 93052.5 9754.9 9908.2 10541.3 10891.2 11004.9 37740.8 43888.8 43931.8 44072.1 48085.5 51659.7 52860.5 76024.0 77256.6 77753.0 13889.4 14449.9 14522.9 14567.6 14682.0 15221.2 15824.7 15886.2 15953.5 16029.7 13855.9 15227.8 15263.6 15663.5 16095.8 15117.7 15466.4 15759.4 16369.3 16382.3 12600.1 12683.7 12703.4 12716.2 12791.6 12267.1 12456.3 12511.9 12649.5 13019.7 12099.7 12215.9 12424.2 12529.7 12575.4 08:44:03 INFO - PROCESS | 5344 | -------- Summary: end -------- 08:44:03 INFO - PROCESS | 5344 | 08:44:04 INFO - TEST-INFO | 5344: exit 0 08:44:04 INFO - TEST-OK | dromaeo_css | took 1111001ms 08:44:04 INFO - TEST-START | kraken 08:44:04 INFO - operating with platform_type : linux_ 08:44:04 INFO - Initialising browser for kraken test... 08:44:04 INFO - TEST-INFO | started process 5594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIkjfK/profile http://localhost:38626/getInfo.html) 08:44:08 INFO - PROCESS | 5594 | __metrics Screen width/height:1600/1200 08:44:08 INFO - PROCESS | 5594 | colorDepth:24 08:44:08 INFO - PROCESS | 5594 | Browser inner width/height: 1024/697 08:44:08 INFO - PROCESS | 5594 | __metrics 08:44:09 ERROR - PROCESS | 5594 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 08:44:10 INFO - TEST-INFO | 5594: exit 0 08:44:10 INFO - Browser initialized. 08:44:10 INFO - Running cycle 1/1 for kraken test... 08:44:10 INFO - TEST-INFO | started process 5722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkIkjfK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:22 INFO - PROCESS | 5722 | RSS: Main: 156098560 08:44:22 INFO - PROCESS | 5722 | 08:44:24 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38626/tests/kraken/driver.html?testName=audio-beat-detection) 08:44:25 INFO - PROCESS | 5722 | RSS: Main: 161062912 08:44:25 INFO - PROCESS | 5722 | 08:44:28 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38626/tests/kraken/driver.html?testName=audio-dft) 08:44:28 INFO - PROCESS | 5722 | RSS: Main: 160464896 08:44:28 INFO - PROCESS | 5722 | 08:44:31 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38626/tests/kraken/driver.html?testName=audio-fft) 08:44:32 INFO - PROCESS | 5722 | RSS: Main: 161816576 08:44:32 INFO - PROCESS | 5722 | 08:44:34 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38626/tests/kraken/driver.html?testName=audio-oscillator) 08:44:35 INFO - PROCESS | 5722 | RSS: Main: 161263616 08:44:35 INFO - PROCESS | 5722 | 08:44:37 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:44:37 INFO - PROCESS | 5722 | RSS: Main: 161234944 08:44:37 INFO - PROCESS | 5722 | 08:44:41 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38626/tests/kraken/driver.html?testName=imaging-darkroom) 08:44:41 INFO - PROCESS | 5722 | RSS: Main: 160542720 08:44:41 INFO - PROCESS | 5722 | 08:44:45 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38626/tests/kraken/driver.html?testName=imaging-desaturate) 08:44:45 INFO - PROCESS | 5722 | RSS: Main: 157749248 08:44:45 INFO - PROCESS | 5722 | 08:44:48 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38626/tests/kraken/driver.html?testName=json-parse-financial) 08:44:49 INFO - PROCESS | 5722 | RSS: Main: 158568448 08:44:49 INFO - PROCESS | 5722 | 08:44:50 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:44:51 INFO - PROCESS | 5722 | RSS: Main: 159084544 08:44:51 INFO - PROCESS | 5722 | 08:44:53 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:44:53 INFO - PROCESS | 5722 | RSS: Main: 159571968 08:44:53 INFO - PROCESS | 5722 | 08:44:55 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:44:56 INFO - PROCESS | 5722 | RSS: Main: 159637504 08:44:56 INFO - PROCESS | 5722 | 08:44:59 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:44:59 INFO - PROCESS | 5722 | RSS: Main: 160145408 08:44:59 INFO - PROCESS | 5722 | 08:45:02 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:45:03 INFO - PROCESS | 5722 | RSS: Main: 160301056 08:45:03 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | Cycle 1(1): loaded http://localhost:38626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38626/tests/kraken/driver.html?testName=ai-astar) 08:45:04 INFO - PROCESS | 5722 | RSS: Main: 160915456 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | __start_tp_report 08:45:04 INFO - PROCESS | 5722 | _x_x_mozilla_page_load 08:45:04 INFO - PROCESS | 5722 | _x_x_mozilla_page_load_details 08:45:04 INFO - PROCESS | 5722 | |i|pagename|runs| 08:45:04 INFO - PROCESS | 5722 | |0;ai-astar;109;104;109;110;110;110;110;109;110;109 08:45:04 INFO - PROCESS | 5722 | |1;audio-beat-detection;152;131;159;185;126;157;158;133;182;125 08:45:04 INFO - PROCESS | 5722 | |2;audio-dft;162;163;161;161;161;161;166;166;163;161 08:45:04 INFO - PROCESS | 5722 | |3;audio-fft;76;79;76;178;75;75;75;75;185;76 08:45:04 INFO - PROCESS | 5722 | |4;audio-oscillator;83;86;140;84;84;85;142;85;83;141 08:45:04 INFO - PROCESS | 5722 | |5;imaging-gaussian-blur;117;117;116;117;117;117;121;117;117;121 08:45:04 INFO - PROCESS | 5722 | |6;imaging-darkroom;147;147;146;147;148;146;147;146;146;146 08:45:04 INFO - PROCESS | 5722 | |7;imaging-desaturate;96;96;95;95;95;96;95;95;96;95 08:45:04 INFO - PROCESS | 5722 | |8;json-parse-financial;60;52;51;54;52;53;55;52;55;51 08:45:04 INFO - PROCESS | 5722 | |9;json-stringify-tinderbox;60;60;59;60;67;59;60;59;59;59 08:45:04 INFO - PROCESS | 5722 | |10;stanford-crypto-aes;77;77;82;82;78;78;82;78;106;79 08:45:04 INFO - PROCESS | 5722 | |11;stanford-crypto-ccm;121;121;124;129;122;128;136;138;143;130 08:45:04 INFO - PROCESS | 5722 | |12;stanford-crypto-pbkdf2;156;159;161;157;158;161;167;159;158;156 08:45:04 INFO - PROCESS | 5722 | |13;stanford-crypto-sha256-iterative;62;65;62;62;61;62;64;62;62;62 08:45:04 INFO - PROCESS | 5722 | __end_tp_report 08:45:04 INFO - PROCESS | 5722 | __start_cc_report 08:45:04 INFO - PROCESS | 5722 | _x_x_mozilla_cycle_collect,893 08:45:04 INFO - PROCESS | 5722 | __end_cc_report 08:45:04 INFO - PROCESS | 5722 | __startTimestamp1469115904949__endTimestamp 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | ------- Summary: start ------- 08:45:04 INFO - PROCESS | 5722 | Number of tests: 14 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.83 (1.7%) stddev-sans-first:1.94 08:45:04 INFO - PROCESS | 5722 | Values: 109.0 104.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:157.50 stddev:21.84 (13.9%) stddev-sans-first:23.16 08:45:04 INFO - PROCESS | 5722 | Values: 152.0 131.0 159.0 185.0 126.0 157.0 158.0 133.0 182.0 125.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:2.01 (1.2%) stddev-sans-first:2.13 08:45:04 INFO - PROCESS | 5722 | Values: 162.0 163.0 161.0 161.0 161.0 161.0 166.0 166.0 163.0 161.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#3] audio-fft Cycles:10 Average:97.00 Median:75.50 stddev:44.58 (59.0%) stddev-sans-first:46.63 08:45:04 INFO - PROCESS | 5722 | Values: 76.0 79.0 76.0 178.0 75.0 75.0 75.0 75.0 185.0 76.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#4] audio-oscillator Cycles:10 Average:101.30 Median:84.00 stddev:27.41 (32.6%) stddev-sans-first:28.27 08:45:04 INFO - PROCESS | 5722 | Values: 83.0 86.0 140.0 84.0 84.0 85.0 142.0 85.0 83.0 141.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.77 (1.5%) stddev-sans-first:1.86 08:45:04 INFO - PROCESS | 5722 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 121.0 117.0 117.0 121.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:45:04 INFO - PROCESS | 5722 | Values: 147.0 147.0 146.0 147.0 148.0 146.0 147.0 146.0 146.0 146.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:45:04 INFO - PROCESS | 5722 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:2.72 (5.1%) stddev-sans-first:1.56 08:45:04 INFO - PROCESS | 5722 | Values: 60.0 52.0 51.0 54.0 52.0 53.0 55.0 52.0 55.0 51.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:2.44 (4.1%) stddev-sans-first:2.59 08:45:04 INFO - PROCESS | 5722 | Values: 60.0 60.0 59.0 60.0 67.0 59.0 60.0 59.0 59.0 59.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:78.50 stddev:8.71 (11.1%) stddev-sans-first:9.06 08:45:04 INFO - PROCESS | 5722 | Values: 77.0 77.0 82.0 82.0 78.0 78.0 82.0 78.0 106.0 79.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:129.50 stddev:7.67 (5.9%) stddev-sans-first:7.54 08:45:04 INFO - PROCESS | 5722 | Values: 121.0 121.0 124.0 129.0 122.0 128.0 136.0 138.0 143.0 130.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:159.00 stddev:3.26 (2.0%) stddev-sans-first:3.24 08:45:04 INFO - PROCESS | 5722 | Values: 156.0 159.0 161.0 157.0 158.0 161.0 167.0 159.0 158.0 156.0 08:45:04 INFO - PROCESS | 5722 | 08:45:04 INFO - PROCESS | 5722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.17 (1.9%) stddev-sans-first:1.24 08:45:04 INFO - PROCESS | 5722 | Values: 62.0 65.0 62.0 62.0 61.0 62.0 64.0 62.0 62.0 62.0 08:45:04 INFO - PROCESS | 5722 | -------- Summary: end -------- 08:45:04 INFO - PROCESS | 5722 | 08:45:05 INFO - TEST-INFO | 5722: exit 0 08:45:05 INFO - TEST-OK | kraken | took 61680ms 08:45:05 INFO - SUITE-END | took 1172s 08:45:06 INFO - Completed test suite (00:19:32) 08:45:06 INFO - javascript benchmark 08:45:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7712.1113084028075, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.9664003359967, 3388.5594872666547, 3400.4219282721942, 3402.744794140437, 3407.9318413631727, 5541.307336582927, 5574.944250557493, 5600.215969764231, 5601.495865372116, 5658.43415658434, 5598.496135347828, 5663.5186009189165, 5675.489205971462, 5679.375268720438, 5685.0, 5056.721880296592, 5098.0, 5155.896882062357, 5160.354955630546, 5167.173252279636, 4990.026944745776, 5002.074616195997, 5135.05001574708, 5174.974125129388, 5182.196759502283, 5124.052050370675, 5138.511841375082, 5151.4075881273575, 5153.896922061556, 5262.394824595182, 5209.114450543379, 5230.032443997872, 5246.291750613656, 5258.395284542288, 5259.027079990195, 4866.9513304867205, 5013.623978201649, 5097.235414687826, 5111.361079865017, 5147.588192944593, 5511.283533140666, 5544.500994910437, 5573.693446860421, 5588.692621905793, 5593.04918163909, 6000.549958753111, 6030.035194368924, 6046.18376519173, 6052.455279024909, 6068.271807383142, 5801.53587712982, 5931.703414829241, 5948.553858460589, 6056.454919057306, 6069.393060693939, 5660.915086273709, 5674.631148975303, 5677.545796336283, 5680.0627896397045, 5705.400932902027, 6181.567290289727, 6193.194884664965, 6206.875862482725, 6211.534134939898, 6222.719977601018, 5679.829605111853, 5824.126381042877, 5842.298924129132, 5863.149843272701, 5918.763249470059, 5965.403459654, 5978.461938425476, 6005.789797357072, 6007.429294217042, 6020.187274717857, 5959.731812068468, 5977.342492325841, 5989.31122920861, 6002.789902353484, 6019.157317975487, 5865.061590145556, 5954.315253745788, 5973.104034394789, 6003.8198854034445, 6091.0558863376245, 4636.420447444069, 4645.628349732014, 4656.2498446424825, 4658.976705116453, 4683.274092515598, 4079.204555111725, 4167.083241686824, 4186.267403204488, 4190.790460477025, 4200.705950583491, 5579.330480342385, 5700.315962084494, 5752.0, 5772.307323121252, 5795.536357091422, 6007.849803754941, 6021.909671354933, 6103.816885493442, 6114.877702445926, 6135.233095863017, 5641.633293835887, 5820.243368362086, 5830.4461076197695, 5833.679147646835, 5851.561132915049, 5103.948960510347, 5114.3862736471865, 5119.104156772624, 5149.098907691139, 5149.536541711264, 6195.845103872349, 6220.253569571681, 6243.968780156161, 6248.31268560458, 6263.655498947511, 5903.91144132847, 6027.969860150846, 6056.242969628885, 6067.180930574316, 6076.817695469143, 6205.131281620667, 6337.904931426125, 6368.108464815023, 6373.203349581302, 6376.458001069961, 5910.970445147746, 5927.170196172626, 5985.341612422717, 5992.730327135202, 6017.578769486094, 5850.678212698343, 5941.881162376815, 5988.850278743066, 6103.542234332354, 6104.633721976696, 5902.321233058254, 5950.7917222896995, 5955.821325360246, 5957.791477298447, 5974.4324289192455, 5819.301683797802, 5918.911216331672, 5921.289445266596, 5941.0197317442135, 5941.732622031933, 5596.048671725735, 5701.287339082614, 5712.143178523254, 5749.8275051748515, 5833.0375488044, 5736.68448235351, 5861.1501332305725, 5943.197668314895, 5950.910736339045, 5970.701464926823, 5796.159556864315, 5823.35943046273, 5828.53371730269, 5843.1235314703135, 5849.883002339844], "value": 5565.005780642413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.3701907468545, 632.7184402940693, 651.9152510173677, 653.4543656047198, 665.7603262825384, 35474.58101675933, 39307.213855722905, 46011.079778404455, 47142.76428617852, 47232.0, 48853.0, 48936.0, 49200.0, 49414.25878611824, 49458.75270623642, 8971.82056358874, 8982.910170898273, 9075.455472671627, 9087.409318394282, 9120.0, 8921.687740929068, 8937.106289371044, 9018.729438116867, 9021.774455638595, 9027.684031058914, 9019.188273055424, 9042.864357034618, 9091.727248182531, 9106.499142547158, 9118.635254589808, 8982.236509896635, 9011.909880901205, 9038.954805225998, 9047.81904361909, 9071.591778369957, 8870.112988701143, 8884.8667269991, 8916.687915922976, 8948.328875334377, 8958.283337332998, 46216.0, 46279.5372046282, 46363.76818115922, 46561.76719116417, 46579.0, 3675.9264814703556, 3700.1119731264303, 3705.555333359987, 3860.4595356650093, 3881.0, 34902.30195396103, 35263.29473410543, 35881.46177807335, 36156.0, 36733.63266367329, 4750.840933522913, 4753.453352864396, 4766.118268120409, 4807.206810876201, 4850.223964165752, 395282.0, 409236.0, 409277.0, 412581.0, 413279.0, 67274.0, 67433.0, 67951.32048679549, 67974.32025679779, 68045.65977170083, 39546.40680389797, 39554.80222598926, 40049.19901601952, 42723.14553708908, 42731.57268427338, 19532.511687207934, 19717.211311547664, 19735.802641973398, 19751.308704195286, 19803.306884258982, 14703.0, 14861.405543778128, 14934.551963441114, 14979.101253924582, 15005.849941500444, 21237.78762212389, 21439.464013399476, 21605.135794568356, 21643.891780541, 21782.56434871294, 7458.627068646654, 7657.808554786175, 7715.4599178057, 7952.801179970547, 7965.761027169194, 1017.2675673515205, 1064.5369264370024, 1093.3658478082693, 1159.646307876106, 1173.3018853781987, 33236.50145247823, 33429.83285083559, 33536.83231583826, 33686.15784605355, 34111.14722131967, 1225.9754804903853, 1247.8627350991383, 1269.6571925580042, 1274.8278982337451, 1321.7224382879704, 17485.65028699444, 17952.19215135322, 17986.640267194845, 18028.549286267687, 18059.187336569885, 656544.0, 684162.0, 689124.0, 689790.0, 690572.0, 65338.67330663411, 65465.345346545924, 66118.66940665265, 66124.6693766528, 66161.33838661648, 1487.3381345301455, 1493.5817970967928, 1493.6340596553914, 1495.155237290927, 1511.3878879054, 32763.508547372287, 33097.338053239284, 33316.33367332688, 33466.49800253047, 33700.99562085887, 58015.41984580269, 58527.4147258539, 58706.412935870096, 58754.412455876605, 58795.0, 513182.0, 518159.0, 518268.0, 518499.0, 519049.0, 30866.84566577153, 31084.689153109084, 32013.199670007503, 32144.19639509031, 33810.49284260787, 53893.19160212522, 54067.72966135144, 54471.0, 55004.449955499935, 55650.44349556453, 44750.0, 44818.0, 45137.548624514646, 45726.54273457223, 46311.0, 43675.344869826346, 43731.562684374025, 43768.0, 44717.329240060775, 45110.77444612756, 45233.77383113195, 45317.320240197085, 46448.30327545022, 46750.0, 48865.267020994004, 39034.80482597569, 39672.40491392574, 39695.0, 39696.801515992236, 40137.799311003255, 29301.706982929896, 30191.849040754656, 30455.84772076214, 30669.8466507666, 30967.0], "value": 21784.401475461116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.6913691279191, 437.2108344438292, 437.25448110970797, 437.94087798147245, 443.2464809823299, 18583.25666973321, 19613.0, 20463.795362046374, 20580.1767929283, 20673.276435324766, 18715.43853684388, 19319.0, 19441.902790486063, 19503.512412189702, 19948.800511994876, 5392.0, 5580.888382232373, 5616.438356164392, 5617.634853734515, 5628.0, 5462.180672899057, 5500.367457742371, 5504.0, 5661.830145095633, 6043.728032238538, 5985.790497332594, 5993.250843644544, 6006.699665016754, 6030.66831324277, 6034.879302413971, 5474.753636086386, 5754.251947246831, 5765.596408251424, 5971.313298970631, 5991.670458124801, 5636.4927156556105, 5642.322921249435, 5656.575756818255, 5699.601027928046, 6135.631862088289, 14813.111213327235, 14967.550973470814, 15165.848341516554, 15211.391544338214, 24418.0, 2322.4310044039316, 2390.892409841544, 2464.1868183499582, 2543.8728063596745, 2778.597103420013, 10303.33028353162, 10509.9474502627, 10881.891181088167, 10930.726731831688, 11906.821397679041, 2040.4286799696108, 2056.629806634805, 2088.373487953623, 2100.380387785607, 2131.3925531223526, 59692.0, 73828.63085684537, 75566.24433755648, 80752.0, 84914.0, 11563.595274165533, 11693.532258709556, 11826.822597661041, 12040.879591204151, 12118.75762484763, 16545.172741362883, 16595.83404165967, 16656.33374665024, 16672.833271667372, 16694.6661066778, 8498.362622803315, 8529.957350213333, 8651.740447786577, 8753.168448997336, 8824.691135810215, 8193.4674246175, 8269.710560130367, 8304.0, 8349.206825351703, 8378.371622128365, 4957.553820156203, 5061.772220250097, 5080.822171223989, 5086.415062267813, 5106.361704786902, 2056.393363957636, 2133.839962002825, 2134.2423439679, 2144.57108578285, 2149.355193441961, 999.8250306196387, 1034.5551412892528, 1105.160078340467, 1109.6116359274351, 1156.7686462707493, 19981.300654477025, 20002.299919502748, 20273.69589456159, 20379.388618341472, 20418.0, 1029.8815636201782, 1031.5615863258085, 1074.5594306334365, 1103.9779204415868, 1105.4362275239685, 10488.31825931312, 11269.380184089954, 11345.94327028376, 11490.310581365145, 11517.193796434336, 366368.0, 368433.0, 370164.0, 479945.0, 507235.39146912826, 94787.0, 98249.50875245577, 101385.0, 102269.48865255775, 102990.48504757429, 1095.5453486803046, 1115.4813011949482, 1127.7124333294958, 1135.9091272698165, 1136.5908273021705, 18095.185716643045, 18103.275868965095, 18194.45416637503, 18247.81752182514, 18576.907115464335, 41158.9710257246, 42026.159476810906, 42047.15905681808, 43233.56766432421, 44051.33922991222, 59817.700911495165, 61204.38795611987, 61984.0, 62700.372996269456, 62739.372606273355, 8973.0, 9244.445333280024, 9394.577244024173, 9535.713928582154, 9598.32811703174, 13980.231087290296, 14395.64010899694, 14416.0, 14424.711505770036, 14479.710405792035, 12431.0, 12573.93713031429, 12632.242065475733, 12674.619761407173, 12701.491940322283, 11772.764544708887, 11855.881441185478, 11889.881101188877, 12365.443555039865, 12454.25274483534, 12509.249445033327, 12733.872661273268, 12850.55023074188, 12868.292243926673, 12876.613701588967, 9327.533623318672, 9374.343795934219, 9401.435913845191, 9497.905020949702, 9521.095495927875, 10695.304805187638, 12556.183848049848, 12735.363231838557, 12805.679858003625, 12826.294553799258], "value": 9574.17842415604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.1621032747482, 1613.032180691585, 1812.3203798575535, 1926.9903650481745, 1946.4452631000167, 8792.164744349277, 9528.142467177953, 9617.182539484153, 10242.436665983369, 10310.329828561138, 9734.123928846402, 10011.849822252654, 10099.29304948654, 10104.797904041914, 10115.089641932225, 2567.640530325751, 2593.6368908352847, 2596.1692258477296, 2596.623489594008, 2598.3634009667658, 2521.8991240350365, 2582.0317380982133, 2587.3531617095728, 2593.0535354595627, 2602.9739702603015, 2542.1356738708837, 2550.4899020195944, 2589.1196993022368, 2591.0542651932096, 2593.390553219992, 2410.6986626671664, 2462.7167875694254, 2462.827602067856, 2498.7001559812757, 2505.6241563765398, 2454.4968281502247, 2470.2465747946867, 2488.029668429314, 2505.248425472351, 2546.567083595793, 9806.90193098074, 9980.850287245625, 9991.150752186073, 10049.949750251202, 10068.94965525175, 5836.824895253149, 6021.397860213988, 6022.548308876808, 6034.939650603482, 6052.0, 3933.213357328546, 3969.7816620085882, 4032.3951407288846, 4088.34586466164, 4092.2224777292217, 1271.4151490314466, 1313.4811749359046, 1343.984023964054, 1357.104311154643, 1366.2075995922341, 14148.717025659533, 14221.644458888508, 14355.85644143566, 14370.20963846988, 14438.711225775425, 5191.480851914778, 5214.608904332114, 5377.435369286247, 5414.593905457106, 5424.05079111154, 11834.88165118355, 11852.940735296268, 11860.169788114921, 11920.046396288277, 11942.0, 5955.28536575605, 6038.426349496791, 6064.423879731418, 6083.330833608299, 6107.114468402056, 4826.927596086061, 5339.252504649352, 5480.424555421703, 5489.615726899079, 5593.580481463907, 4474.597286244254, 4497.64018878489, 4547.3406356078185, 4594.724316541018, 4596.655250856199, 1410.6825964157983, 1417.574727581742, 1432.7421064208543, 1440.942362305517, 1462.5831637983124, 1042.47876061969, 1047.4657924458581, 1061.193492945367, 1074.6292529077455, 1092.202692034819, 6781.8643627127185, 6812.4550035997, 6850.554713943578, 6924.688389022506, 6950.79147625572, 504.50306448148547, 515.0548743056534, 518.7406296851574, 520.97916083357, 533.5331584863245, 4649.465311489222, 4658.767061646972, 4663.145434832336, 4690.085433340534, 4713.151632706077, 12350.876491235153, 12539.184952978027, 12723.745525089631, 12827.743445131046, 12857.0, 12056.758864822654, 12446.502139914483, 12636.55772047974, 12654.746905061847, 12655.177413468095, 9041.502717350477, 9418.811623767486, 9453.76365590852, 9471.052894710474, 9528.237740980705, 6564.376384243489, 6642.767503137367, 6721.092652491851, 6746.730130794714, 6817.352351526597, 11447.370394628375, 11708.590199343324, 11807.645770626896, 11808.468618912342, 11982.460789264329, 11673.649790506299, 11832.881671183179, 11920.642380728592, 11927.46326415296, 12085.0, 7715.807104822425, 8790.560471976247, 8903.421277617193, 9041.141091596288, 9056.230220431336, 9956.452395118338, 10019.348742331726, 10035.297529172887, 10038.0, 10053.0, 8195.71315003972, 8362.331013518782, 8402.369822263478, 8649.437786543855, 8879.11208879107, 8288.0, 8415.495070295801, 8610.61252243638, 8671.34964877624, 8876.423032502867, 7762.7671169865, 7769.0, 7837.216278372117, 7853.175416581176, 7866.095399029185, 5695.174199741097, 5947.524198064231, 5983.551233657406, 6009.699515024144, 6081.787137450168, 6007.219061521974, 6019.277686677627, 6041.426064524039, 6113.02191649334, 6161.938380616137], "value": 5171.552741458525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.6050823078153, 361.0576395607464, 362.3640510903365, 370.4517314374727, 370.53312825839436, 5615.80344687936, 5641.68970706612, 5758.337791154018, 5793.856273178924, 5822.534197264219, 5643.0, 5668.0, 5692.829215123553, 5700.258966334371, 5741.511971482429, 4413.521470307451, 4429.585875697744, 4446.933296000547, 4458.375827384169, 4460.66545009124, 4368.868933931971, 4409.845655402061, 4436.401085853401, 4448.354988526662, 4468.396766436538, 4376.759278239696, 4377.649788016967, 4391.407160033403, 4400.185965596359, 4401.66987475939, 4402.801873915681, 4448.97571604919, 4452.710573812724, 4464.977675111636, 4472.709273897186, 3680.35593771089, 3866.7099967502268, 3956.4658771066115, 3960.2277555876617, 3963.1677347756718, 5408.8377348679605, 5425.321834770653, 5455.918161227585, 5470.370907345627, 5491.533219676332, 4988.82539111133, 4997.550220480138, 5010.4739002404585, 5017.519831649672, 5022.447530771612, 5596.720163991825, 5839.153322768218, 5847.590668653196, 5867.858231745425, 5872.265966754156, 4218.388333691598, 4220.775974967256, 4224.281872081723, 4248.277792775236, 4259.148170365939, 6110.266767987825, 6154.692265386758, 6162.7534898604, 6221.626702397825, 6222.097795819581, 4218.1861501729545, 4351.912961740747, 4362.5821607976895, 4365.214261432909, 4396.1867054595, 4371.388005679208, 4371.650267978554, 4372.213001659668, 4420.872677467225, 4456.729831997865, 4988.152014157602, 5002.374228375792, 5037.899242015139, 5055.51972562606, 5074.441811400743, 5699.715014249271, 5882.55880808941, 5919.904817608756, 5937.643741375445, 6005.0, 1500.5219858439427, 1523.6190952261934, 1528.6547837902574, 1540.1990964698518, 1541.7456119740118, 969.0454901921602, 971.8396464583406, 976.6776963601994, 976.7606936300651, 995.4674249276748, 5167.328247327899, 5211.452797456288, 5228.843134705965, 5243.898781255903, 5251.553617942442, 5468.043092458884, 5474.288342515527, 5487.0, 5496.890062198733, 5534.667919924736, 5048.697078175322, 5151.22731590257, 5158.587313014949, 5163.66436181647, 5250.422453530108, 2968.717971792676, 2969.62879640045, 2969.9554506682416, 2986.581878536963, 2994.31130839908, 5553.861153471114, 5570.802277510274, 5594.608377413623, 5618.522425593788, 5649.943500565024, 5125.820596279113, 5525.171224316385, 5531.834044978657, 5536.667799932017, 5545.445455454503, 5572.659483017062, 5587.396129496452, 5598.916016259759, 5657.916435542639, 5671.149327600893, 5203.297554830201, 5480.753366098455, 5512.298973503035, 5520.0, 5554.944450555443, 5371.355437347544, 5401.405845357086, 5404.378496472956, 5406.134883465198, 5414.648047876875, 5609.971950140223, 5647.265855438766, 5697.515711164431, 5717.742701578356, 5719.0, 3977.3437382832667, 3981.6416522513114, 4044.9191016180102, 4365.1229971112725, 4375.803088861073, 5936.7922122725495, 6053.909191362045, 6079.118527813531, 6108.969455152695, 6116.327204007466, 5885.205497257986, 5927.31835838884, 6007.459328660441, 6029.472758436364, 6029.78895738647, 5957.7319020645045, 5959.851003724942, 6002.609830361187, 6039.939600603938, 6040.909386359121, 5733.283339582552, 5885.5880088395115, 5914.142449344735, 5922.230110085661, 5981.401859814157, 5995.250593675791, 6035.491127218195, 6055.848603784941, 6058.5153187745755, 6072.72672729737, 5697.943020569907, 5936.168936349001, 5944.286685597756, 5947.553933454921, 5952.5833191676165], "value": 4401.507577692646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.9800754981128, 807.5235610989515, 813.1705660226565, 853.2832420766556, 902.9413088149265, 15946.760798588017, 16163.434279800209, 16365.42721004765, 16373.181340932966, 16378.83621163788, 15394.384224631029, 15456.536303910872, 15497.457588984387, 15590.844091559082, 15598.766018509732, 732.6995931668004, 873.4933738431727, 887.8446271902424, 890.1499068389672, 892.0232345581578, 855.80744332525, 861.1001503428931, 867.6182479708908, 868.15355028847, 868.5396739727954, 901.3960646366917, 916.2990312411011, 916.4592890194783, 918.1140199707281, 919.1865199298602, 903.9593218305192, 908.4322298563397, 910.508325504227, 912.3522299167565, 913.137085454246, 669.7722774256777, 673.3300366135677, 673.7944926797325, 676.0062707819498, 678.1455366238525, 13933.442662293495, 13950.302484875716, 13963.79054314186, 13970.161790292615, 13984.091034082752, 14990.0, 15414.76094570059, 15729.528114156594, 15913.840861591467, 16275.348986040544, 13176.472941082346, 13386.062975591713, 13506.122102063433, 13518.662033449144, 13570.660733481644, 4063.3904914262803, 4117.75293482392, 4213.557576454459, 4214.093969796509, 4214.262504061808, 79387.60306198432, 80516.59741701312, 80581.0, 80615.5969220156, 81759.59120204361, 12531.812022819666, 12606.684832879251, 12724.045696572794, 12813.295268760121, 13110.803337949937, 20482.38552843417, 20696.896515517627, 20709.0680919359, 20723.481912951996, 20814.0, 9485.857712134324, 9499.145076943109, 9561.187299079656, 9601.615935362508, 10033.498325083716, 4950.876228094255, 5157.381114266237, 5284.9735751320995, 5426.945730542644, 5515.09001014828, 4111.444954931106, 4275.957240427618, 4284.700070995063, 4310.61204491591, 4313.266744653353, 705.3158436316764, 709.7125664106045, 717.7703134996856, 729.533098816747, 733.8092096055065, 789.2856964447185, 818.1613845808095, 847.2459511035183, 847.7075408983891, 863.9848178390366, 10338.689839304832, 10788.946055269831, 10983.231173817916, 10984.945075274572, 11132.721681958015, 666.7327125024709, 819.3486178488116, 820.0692214336771, 823.1603764160642, 856.5973992223645, 4807.807687692453, 4818.7831547580445, 4843.709377437294, 4872.731999739977, 4981.178105612534, 69263.65368173127, 70485.0, 70844.0, 71136.64431677808, 90719.0, 95655.52172239234, 95847.52076239574, 96422.51788741011, 98769.50615247022, 102270.48864755628, 90946.54526727456, 90950.09049909416, 91121.54439227762, 91997.99999999866, 93052.53473732724, 9754.9024509754, 9908.157806586232, 10541.262111652111, 10891.18316126278, 11004.889951100387, 37740.81129594334, 43888.780556098296, 43931.78034109809, 44072.118557628026, 48085.5191448081, 51659.741701292754, 52860.47139528555, 76024.0, 77256.61371693331, 77753.0, 13889.374978125807, 14449.85550144485, 14522.85477145215, 14567.562973110824, 14682.0, 15221.162836044125, 15824.683506330039, 15886.16607087752, 15953.521394358188, 16029.67940641204, 13855.930720346334, 15227.847721522643, 15263.618409539851, 15663.451779187673, 16095.75856362179, 15117.697646046798, 15466.381344746535, 15759.369625214864, 16369.263383147549, 16382.262798173871, 12600.117991740857, 12683.746325073631, 12703.42834572465, 12716.237025778482, 12791.616251512469, 12267.141300108906, 12456.31490268044, 12511.874881251435, 12649.494020239088, 13019.674508137372, 12099.697507562381, 12215.877841221474, 12424.198921830415, 12529.749405012031, 12575.371231438574], "value": 7962.728698911542, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 104.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 159.0, 185.0, 126.0, 157.0, 158.0, 133.0, 182.0, 125.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 161.0, 161.0, 166.0, 166.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 178.0, 75.0, 75.0, 75.0, 75.0, 185.0, 76.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 140.0, 84.0, 84.0, 85.0, 142.0, 85.0, 83.0, 141.0], "value": 101.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 121.0, 117.0, 117.0, 121.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 52.0, 51.0, 54.0, 52.0, 53.0, 55.0, 52.0, 55.0, 51.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 67.0, 59.0, 60.0, 59.0, 59.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 82.0, 82.0, 78.0, 78.0, 82.0, 78.0, 106.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 121.0, 124.0, 129.0, 122.0, 128.0, 136.0, 138.0, 143.0, 130.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 159.0, 161.0, 157.0, 158.0, 161.0, 167.0, 159.0, 158.0, 156.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 62.0, 61.0, 62.0, 64.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}]}]} 08:45:06 INFO - Return code: 0 08:45:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:45:06 ERROR - # TBPL SUCCESS # 08:45:06 INFO - Running post-action listener: _resource_record_post_action 08:45:06 INFO - ##### 08:45:06 INFO - ##### Finished run-tests step (success) 08:45:06 INFO - ##### 08:45:06 INFO - Running post-run listener: _resource_record_post_run 08:45:06 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503681024; Read time: 12; Write time: 728756 08:45:06 INFO - TinderboxPrint: CPU usage
13.5% 08:45:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:45:06 INFO - TinderboxPrint: I/O write bytes / time
503,681,024 / 728,756 08:45:06 INFO - TinderboxPrint: CPU idle
8,215.2 (86.5%) 08:45:06 INFO - TinderboxPrint: CPU user
1,217.9 (12.8%) 08:45:06 INFO - TinderboxPrint: Swap in / out
0 / 0 08:45:06 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 253403136; Read time: 0; Write time: 441816 08:45:06 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250138624; Read time: 12; Write time: 286892 08:45:06 INFO - Running post-run listener: _upload_blobber_files 08:45:06 INFO - Blob upload gear active. 08:45:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:45:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:45:06 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'] 08:45:06 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 08:45:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:08 INFO - (blobuploader) - INFO - Done attempting. 08:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:09 INFO - (blobuploader) - INFO - Done attempting. 08:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:45:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:45:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:45:19 INFO - (blobuploader) - INFO - Done attempting. 08:45:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:45:19 INFO - Return code: 0 08:45:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:45:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:45:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06a270e058c750cba2687d5d26fc39da2a739b52fbd2387f53d03efbc81270062a70b4705d6ed1bf982b7f6ea6bcc654fe8417b198630d49f5c4f2218223733e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99a7259106aaf9cc4fbd83129dfc4cd5b2b4e7c38f52d48566d547cb0dd855fe48351bdb4ada46c9766b026cdfcc4a49c40ee6fc3abc1b7a3d42db7c2d1a974e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361acbf3e277c2267a38fb15a49c9aaf0bfc2ad666661cae46b8f09bbee3c1225e58c9fb1e357a4dce10668a0449efe52579618135775eef45507e2b67745641"} 08:45:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:45:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:45:19 INFO - Contents: 08:45:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/06a270e058c750cba2687d5d26fc39da2a739b52fbd2387f53d03efbc81270062a70b4705d6ed1bf982b7f6ea6bcc654fe8417b198630d49f5c4f2218223733e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99a7259106aaf9cc4fbd83129dfc4cd5b2b4e7c38f52d48566d547cb0dd855fe48351bdb4ada46c9766b026cdfcc4a49c40ee6fc3abc1b7a3d42db7c2d1a974e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361acbf3e277c2267a38fb15a49c9aaf0bfc2ad666661cae46b8f09bbee3c1225e58c9fb1e357a4dce10668a0449efe52579618135775eef45507e2b67745641"} 08:45:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:45:19 INFO - Copying logs to upload dir... 08:45:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:45:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.388400 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-21 08:45:19.436703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:45:19.440346) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 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/06a270e058c750cba2687d5d26fc39da2a739b52fbd2387f53d03efbc81270062a70b4705d6ed1bf982b7f6ea6bcc654fe8417b198630d49f5c4f2218223733e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99a7259106aaf9cc4fbd83129dfc4cd5b2b4e7c38f52d48566d547cb0dd855fe48351bdb4ada46c9766b026cdfcc4a49c40ee6fc3abc1b7a3d42db7c2d1a974e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361acbf3e277c2267a38fb15a49c9aaf0bfc2ad666661cae46b8f09bbee3c1225e58c9fb1e357a4dce10668a0449efe52579618135775eef45507e2b67745641"} build_url:https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/RbXgFBWHR0-YzoV5GWrrbQ/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/06a270e058c750cba2687d5d26fc39da2a739b52fbd2387f53d03efbc81270062a70b4705d6ed1bf982b7f6ea6bcc654fe8417b198630d49f5c4f2218223733e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/99a7259106aaf9cc4fbd83129dfc4cd5b2b4e7c38f52d48566d547cb0dd855fe48351bdb4ada46c9766b026cdfcc4a49c40ee6fc3abc1b7a3d42db7c2d1a974e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361acbf3e277c2267a38fb15a49c9aaf0bfc2ad666661cae46b8f09bbee3c1225e58c9fb1e357a4dce10668a0449efe52579618135775eef45507e2b67745641"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 08:45:19.470099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:45:19.470781) ========= 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=5cf47e208febbcd81da23b2e0000026f-1469114679.295920-1106004116 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 08:45:19.550648) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:45:19.551084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 08:45:19.551502) ========= ========= Total master_lag: 0.18 =========