builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1469038662.9 results: success (0) buildid: 20160720071222 builduid: 10aa7b53e3ed49a4a3802c75e6be36f5 revision: aa3cda908cd8e68ee429a293e9683629543af7f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:42.896443) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:42.896918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:42.897218) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:42.913127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:42.913551) ========= 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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 11:17:43-- 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% 222M=0s 2016-07-20 11:17:43 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.056826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.057143) ========= 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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.106156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.106525) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aa3cda908cd8e68ee429a293e9683629543af7f1 --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 aa3cda908cd8e68ee429a293e9683629543af7f1 --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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 11:17:43,425 truncating revision to first 12 chars 2016-07-20 11:17:43,425 Setting DEBUG logging. 2016-07-20 11:17:43,425 attempt 1/10 2016-07-20 11:17:43,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/aa3cda908cd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 11:17:43,754 unpacking tar archive at: mozilla-aurora-aa3cda908cd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701636 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.821734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.822242) ========= script_repo_revision: aa3cda908cd8e68ee429a293e9683629543af7f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.822701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.822971) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 11:17:43.833363) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-20 11:17:43.833787) ========= /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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:17:44 INFO - MultiFileLogger online at 20160720 11:17:44 in /builds/slave/test 11:17:44 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 11:17:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:44 INFO - {'append_to_log': False, 11:17:44 INFO - 'base_work_dir': '/builds/slave/test', 11:17:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:17:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:44 INFO - 'branch': 'Mozilla-Aurora', 11:17:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:44 INFO - 'config_files': ('talos/linux_config.py',), 11:17:44 INFO - 'default_actions': ('clobber', 11:17:44 INFO - 'read-buildbot-config', 11:17:44 INFO - 'download-and-extract', 11:17:44 INFO - 'populate-webroot', 11:17:44 INFO - 'create-virtualenv', 11:17:44 INFO - 'install', 11:17:44 INFO - 'run-tests'), 11:17:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:44 INFO - 'download_minidump_stackwalk': True, 11:17:44 INFO - 'download_symbols': 'ondemand', 11:17:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:44 INFO - 'installer_path': 'installer.exe', 11:17:44 INFO - 'log_level': 'info', 11:17:44 INFO - 'log_name': 'talos', 11:17:44 INFO - 'log_to_console': True, 11:17:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:17:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:17:44 INFO - 'opt_config_files': (), 11:17:44 INFO - 'pip_index': False, 11:17:44 INFO - 'sps_profile': False, 11:17:44 INFO - 'sps_profile_interval': 0, 11:17:44 INFO - 'suite': 'dromaeojs-e10s', 11:17:44 INFO - 'system_bits': '32', 11:17:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:44 INFO - 'title': 'talos-linux64-ix-043', 11:17:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:44 INFO - 'use_talos_json': True, 11:17:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:44 INFO - 'work_dir': 'build'} 11:17:44 INFO - ##### 11:17:44 INFO - ##### Running clobber step. 11:17:44 INFO - ##### 11:17:44 INFO - Running pre-action listener: _resource_record_pre_action 11:17:44 INFO - Running main action method: clobber 11:17:44 INFO - rmtree: /builds/slave/test/build 11:17:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:45 INFO - Running post-action listener: _resource_record_post_action 11:17:45 INFO - ##### 11:17:45 INFO - ##### Finished clobber step (success) 11:17:45 INFO - ##### 11:17:45 INFO - ##### 11:17:45 INFO - ##### Running read-buildbot-config step. 11:17:45 INFO - ##### 11:17:45 INFO - Running pre-action listener: _resource_record_pre_action 11:17:45 INFO - Running main action method: read_buildbot_config 11:17:45 INFO - Using buildbot properties: 11:17:45 INFO - { 11:17:45 INFO - "project": "", 11:17:45 INFO - "product": "firefox", 11:17:45 INFO - "script_repo_revision": "production", 11:17:45 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:17:45 INFO - "repository": "", 11:17:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:17:45 INFO - "buildid": "20160720071222", 11:17:45 INFO - "pgo_build": "True", 11:17:45 INFO - "basedir": "/builds/slave/test", 11:17:45 INFO - "buildnumber": 433, 11:17:45 INFO - "slavename": "talos-linux64-ix-043", 11:17:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:17:45 INFO - "platform": "ubuntu64_hw", 11:17:45 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:17:45 INFO - "branch": "mozilla-aurora", 11:17:45 INFO - "repo_path": "releases/mozilla-aurora", 11:17:45 INFO - "revision": "aa3cda908cd8e68ee429a293e9683629543af7f1", 11:17:45 INFO - "stage_platform": "linux64-pgo", 11:17:45 INFO - "builduid": "10aa7b53e3ed49a4a3802c75e6be36f5", 11:17:45 INFO - "slavebuilddir": "test" 11:17:45 INFO - } 11:17:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 11:17:45 INFO - Running post-action listener: _resource_record_post_action 11:17:45 INFO - ##### 11:17:45 INFO - ##### Finished read-buildbot-config step (success) 11:17:45 INFO - ##### 11:17:45 INFO - ##### 11:17:45 INFO - ##### Running download-and-extract step. 11:17:45 INFO - ##### 11:17:45 INFO - Running pre-action listener: _resource_record_pre_action 11:17:45 INFO - Running main action method: download_and_extract 11:17:45 INFO - mkdir: /builds/slave/test/build/tests 11:17: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')]} 11:17:45 INFO - https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:17:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:17:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:17:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:45 INFO - Downloaded 1361 bytes. 11:17:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 11:17:45 INFO - Using the following test package requirements: 11:17:45 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:17:45 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:17:45 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:17:45 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'jsshell-linux-x86_64.zip'], 11:17:45 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:17:45 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 11:17:45 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:17:45 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:17:45 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:17:45 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 11:17:45 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:17:45 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:17: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')]} 11:17:45 INFO - https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:17:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:17:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:46 INFO - Downloaded 24491324 bytes. 11:17: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'] 11:17: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 11:17:48 INFO - Return code: 0 11:17:48 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 11:17: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')]} 11:17:48 INFO - https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 11:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:49 INFO - Downloaded 24491324 bytes. 11:17:49 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'] 11:17:49 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 11:17:50 INFO - Return code: 0 11:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:17:50 INFO - https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 11:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:51 INFO - Downloaded 10833369 bytes. 11:17:51 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'] 11:17:51 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 11:17:51 INFO - Return code: 0 11:17:51 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')]} 11:17:51 INFO - https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:17:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:17:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:17:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IyLF0G-CRBysJH6fxwCGRw/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 11:17:53 INFO - Downloaded 63613864 bytes. 11:17:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:17:53 INFO - mkdir: /builds/slave/test/properties 11:17:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:53 INFO - Contents: 11:17:53 INFO - build_url:https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 11:17:53 INFO - Running post-action listener: _resource_record_post_action 11:17:53 INFO - Running post-action listener: set_extra_try_arguments 11:17:53 INFO - ##### 11:17:53 INFO - ##### Finished download-and-extract step (success) 11:17:53 INFO - ##### 11:17:53 INFO - ##### 11:17:53 INFO - ##### Running populate-webroot step. 11:17:53 INFO - ##### 11:17:53 INFO - Running pre-action listener: _resource_record_pre_action 11:17:53 INFO - Running main action method: populate_webroot 11:17:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:17:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:17:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:17:53 INFO - '--tppagecycles', 11:17:53 INFO - '7'], 11:17:53 INFO - 'tests': ['tsvgm']}}, 11:17:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['damp', 'tps']}, 11:17:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'tests': ['damp', 'tps']}, 11:17:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['dromaeo_dom']}, 11:17:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['a11yr', 11:17:53 INFO - 'ts_paint', 11:17:53 INFO - 'tpaint', 11:17:53 INFO - 'sessionrestore', 11:17:53 INFO - 'sessionrestore_no_auto_restore', 11:17:53 INFO - 'tabpaint']}, 11:17:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['tsvgx', 11:17:53 INFO - 'tsvgr_opacity', 11:17:53 INFO - 'tart', 11:17:53 INFO - 'tscrollx', 11:17:53 INFO - 'cart']}, 11:17:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:53 INFO - 'tsvgr_opacity', 11:17:53 INFO - 'tart', 11:17:53 INFO - 'tscrollx', 11:17:53 INFO - 'cart']}, 11:17:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'talos_options': ['--disable-e10s'], 11:17:53 INFO - 'tests': ['tp5o']}, 11:17:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'tests': ['tp5o']}, 11:17:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'talos_options': ['--disable-e10s', 11:17:53 INFO - '--xperf_path', 11:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:53 INFO - 'tests': ['tp5n']}, 11:17:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:17:53 INFO - 'talos_options': ['--xperf_path', 11:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:53 INFO - 'tests': ['tp5n']}}, 11:17:53 INFO - 'talos.zip': {'path': '', 11:17:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:17:53 INFO - Running post-action listener: _resource_record_post_action 11:17:53 INFO - ##### 11:17:53 INFO - ##### Finished populate-webroot step (success) 11:17:53 INFO - ##### 11:17:53 INFO - ##### 11:17:53 INFO - ##### Running create-virtualenv step. 11:17:53 INFO - ##### 11:17:53 INFO - Running pre-action listener: _resource_record_pre_action 11:17:53 INFO - Running main action method: create_virtualenv 11:17:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:53 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 11:17:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:53 INFO - Using real prefix '/usr' 11:17:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:56 INFO - Installing pip.................done. 11:17:56 INFO - Return code: 0 11:17:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:17: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', 'pip>=1.5'] in /builds/slave/test/build 11:17: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 pip>=1.5 11:17:56 INFO - Using env: {'DISPLAY': ':0', 11:17:56 INFO - 'HOME': '/home/cltbld', 11:17:56 INFO - 'LANG': 'en_US.UTF-8', 11:17:56 INFO - 'LANGUAGE': 'en_US:en', 11:17:56 INFO - 'LOGNAME': 'cltbld', 11:17:56 INFO - 'MAIL': '/var/mail/cltbld', 11:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:56 INFO - 'MOZ_NO_REMOTE': '1', 11:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:56 INFO - 'NO_EM_RESTART': '1', 11:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:56 INFO - 'PWD': '/builds/slave/test', 11:17:56 INFO - 'SHELL': '/bin/bash', 11:17:56 INFO - 'SHLVL': '1', 11:17:56 INFO - 'TERM': 'linux', 11:17:56 INFO - 'TMOUT': '86400', 11:17:56 INFO - 'USER': 'cltbld', 11:17:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:56 INFO - '_': '/tools/buildbot/bin/python'} 11:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:56 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 11:17:56 INFO - Cleaning up... 11:17:56 INFO - Return code: 0 11:17:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', '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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:17: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 psutil>=3.1.1 11:17:56 INFO - Using env: {'DISPLAY': ':0', 11:17:56 INFO - 'HOME': '/home/cltbld', 11:17:56 INFO - 'LANG': 'en_US.UTF-8', 11:17:56 INFO - 'LANGUAGE': 'en_US:en', 11:17:56 INFO - 'LOGNAME': 'cltbld', 11:17:56 INFO - 'MAIL': '/var/mail/cltbld', 11:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:56 INFO - 'MOZ_NO_REMOTE': '1', 11:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:56 INFO - 'NO_EM_RESTART': '1', 11:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:56 INFO - 'PWD': '/builds/slave/test', 11:17:56 INFO - 'SHELL': '/bin/bash', 11:17:56 INFO - 'SHLVL': '1', 11:17:56 INFO - 'TERM': 'linux', 11:17:56 INFO - 'TMOUT': '86400', 11:17:56 INFO - 'USER': 'cltbld', 11:17:56 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:56 INFO - '_': '/tools/buildbot/bin/python'} 11:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:56 INFO - Downloading/unpacking psutil>=3.1.1 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:58 INFO - Installing collected packages: psutil 11:17:58 INFO - Running setup.py install for psutil 11:17:58 INFO - building 'psutil._psutil_linux' extension 11:17:58 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 11:17:59 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 11:17:59 INFO - building 'psutil._psutil_posix' extension 11:17:59 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 11:17:59 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 11:17:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:59 INFO - Successfully installed psutil 11:17:59 INFO - Cleaning up... 11:17:59 INFO - Return code: 0 11:17:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:17: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:17: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 mozsystemmonitor==0.3 11:17:59 INFO - Using env: {'DISPLAY': ':0', 11:17:59 INFO - 'HOME': '/home/cltbld', 11:17:59 INFO - 'LANG': 'en_US.UTF-8', 11:17:59 INFO - 'LANGUAGE': 'en_US:en', 11:17:59 INFO - 'LOGNAME': 'cltbld', 11:17:59 INFO - 'MAIL': '/var/mail/cltbld', 11:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:59 INFO - 'MOZ_NO_REMOTE': '1', 11:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:59 INFO - 'NO_EM_RESTART': '1', 11:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:59 INFO - 'PWD': '/builds/slave/test', 11:17:59 INFO - 'SHELL': '/bin/bash', 11:17:59 INFO - 'SHLVL': '1', 11:17:59 INFO - 'TERM': 'linux', 11:17:59 INFO - 'TMOUT': '86400', 11:17:59 INFO - 'USER': 'cltbld', 11:17:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:59 INFO - '_': '/tools/buildbot/bin/python'} 11:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:18:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:01 INFO - Installing collected packages: mozsystemmonitor 11:18:01 INFO - Running setup.py install for mozsystemmonitor 11:18:01 INFO - Successfully installed mozsystemmonitor 11:18:01 INFO - Cleaning up... 11:18:01 INFO - Return code: 0 11:18:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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', '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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:18: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 jsonschema==2.5.1 11:18:01 INFO - Using env: {'DISPLAY': ':0', 11:18:01 INFO - 'HOME': '/home/cltbld', 11:18:01 INFO - 'LANG': 'en_US.UTF-8', 11:18:01 INFO - 'LANGUAGE': 'en_US:en', 11:18:01 INFO - 'LOGNAME': 'cltbld', 11:18:01 INFO - 'MAIL': '/var/mail/cltbld', 11:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:01 INFO - 'MOZ_NO_REMOTE': '1', 11:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:01 INFO - 'NO_EM_RESTART': '1', 11:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:01 INFO - 'PWD': '/builds/slave/test', 11:18:01 INFO - 'SHELL': '/bin/bash', 11:18:01 INFO - 'SHLVL': '1', 11:18:01 INFO - 'TERM': 'linux', 11:18:01 INFO - 'TMOUT': '86400', 11:18:01 INFO - 'USER': 'cltbld', 11:18:01 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:01 INFO - '_': '/tools/buildbot/bin/python'} 11:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:04 INFO - warning: no files found matching '*.txt' 11:18:04 INFO - no previously-included directories found matching 'build' 11:18:04 INFO - no previously-included directories found matching 'dist' 11:18:04 INFO - no previously-included directories found matching '.git*' 11:18:04 INFO - Installing collected packages: jsonschema, functools32 11:18:04 INFO - Running setup.py install for functools32 11:18:04 INFO - warning: no files found matching '*.txt' 11:18:04 INFO - no previously-included directories found matching 'build' 11:18:04 INFO - no previously-included directories found matching 'dist' 11:18:04 INFO - no previously-included directories found matching '.git*' 11:18:04 INFO - Successfully installed jsonschema functools32 11:18:04 INFO - Cleaning up... 11:18:04 INFO - Return code: 0 11:18:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:04 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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:04 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 11:18:04 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 11:18:04 INFO - Using env: {'DISPLAY': ':0', 11:18:04 INFO - 'HOME': '/home/cltbld', 11:18:04 INFO - 'LANG': 'en_US.UTF-8', 11:18:04 INFO - 'LANGUAGE': 'en_US:en', 11:18:04 INFO - 'LOGNAME': 'cltbld', 11:18:04 INFO - 'MAIL': '/var/mail/cltbld', 11:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:04 INFO - 'MOZ_NO_REMOTE': '1', 11:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:04 INFO - 'NO_EM_RESTART': '1', 11:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:04 INFO - 'PWD': '/builds/slave/test', 11:18:04 INFO - 'SHELL': '/bin/bash', 11:18:04 INFO - 'SHLVL': '1', 11:18:04 INFO - 'TERM': 'linux', 11:18:04 INFO - 'TMOUT': '86400', 11:18:04 INFO - 'USER': 'cltbld', 11:18:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:04 INFO - '_': '/tools/buildbot/bin/python'} 11:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:06 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 11:18:07 INFO - Downloading docopt-0.6.1.tar.gz 11:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:07 INFO - Running setup.py install for blobuploader 11:18:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:07 INFO - Running setup.py install for requests 11:18:07 INFO - Running setup.py install for docopt 11:18:07 INFO - Successfully installed blobuploader requests docopt 11:18:07 INFO - Cleaning up... 11:18:07 INFO - Return code: 0 11:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:07 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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:07 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 11:18:07 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 11:18:07 INFO - Using env: {'DISPLAY': ':0', 11:18:07 INFO - 'HOME': '/home/cltbld', 11:18:07 INFO - 'LANG': 'en_US.UTF-8', 11:18:07 INFO - 'LANGUAGE': 'en_US:en', 11:18:07 INFO - 'LOGNAME': 'cltbld', 11:18:07 INFO - 'MAIL': '/var/mail/cltbld', 11:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:07 INFO - 'MOZ_NO_REMOTE': '1', 11:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:07 INFO - 'NO_EM_RESTART': '1', 11:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:07 INFO - 'PWD': '/builds/slave/test', 11:18:07 INFO - 'SHELL': '/bin/bash', 11:18:07 INFO - 'SHLVL': '1', 11:18:07 INFO - 'TERM': 'linux', 11:18:07 INFO - 'TMOUT': '86400', 11:18:07 INFO - 'USER': 'cltbld', 11:18:07 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:07 INFO - '_': '/tools/buildbot/bin/python'} 11:18:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:08 INFO - Running setup.py (path:/tmp/pip-O9JVnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:08 INFO - Running setup.py (path:/tmp/pip-sG1nYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:08 INFO - Running setup.py (path:/tmp/pip-B8mt47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:08 INFO - Running setup.py (path:/tmp/pip-YGDXjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:08 INFO - Running setup.py (path:/tmp/pip-ZFCEEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:08 INFO - Running setup.py (path:/tmp/pip-howksq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:08 INFO - Running setup.py (path:/tmp/pip-kiTzuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:08 INFO - Running setup.py (path:/tmp/pip-1Z1kYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:08 INFO - Running setup.py (path:/tmp/pip-qCevDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:08 INFO - Running setup.py (path:/tmp/pip-7M5qt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:08 INFO - Running setup.py (path:/tmp/pip-gH91x4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:08 INFO - Running setup.py (path:/tmp/pip-uJRLmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:08 INFO - Running setup.py (path:/tmp/pip-KAGIa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:09 INFO - Running setup.py (path:/tmp/pip-yNDbYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:09 INFO - Running setup.py (path:/tmp/pip-CyoL_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:09 INFO - Running setup.py (path:/tmp/pip-1g15ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:09 INFO - Running setup.py (path:/tmp/pip-aPY1lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:09 INFO - Running setup.py install for manifestparser 11:18:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:09 INFO - Running setup.py install for mozcrash 11:18:09 INFO - Running setup.py install for mozdebug 11:18:09 INFO - Running setup.py install for mozdevice 11:18:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:09 INFO - Running setup.py install for mozfile 11:18:09 INFO - Running setup.py install for mozhttpd 11:18:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:09 INFO - Running setup.py install for mozinfo 11:18:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:09 INFO - Running setup.py install for mozInstall 11:18:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Running setup.py install for mozleak 11:18:10 INFO - Running setup.py install for mozlog 11:18:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Running setup.py install for moznetwork 11:18:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Running setup.py install for mozprocess 11:18:10 INFO - Running setup.py install for mozprofile 11:18:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Running setup.py install for mozrunner 11:18:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:10 INFO - Running setup.py install for mozscreenshot 11:18:10 INFO - Running setup.py install for moztest 11:18:10 INFO - Running setup.py install for mozversion 11:18:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:11 INFO - Cleaning up... 11:18:11 INFO - Return code: 0 11:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:11 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')]} 11:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:11 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')]} 11:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:11 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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:11 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 11:18:11 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 11:18:11 INFO - Using env: {'DISPLAY': ':0', 11:18:11 INFO - 'HOME': '/home/cltbld', 11:18:11 INFO - 'LANG': 'en_US.UTF-8', 11:18:11 INFO - 'LANGUAGE': 'en_US:en', 11:18:11 INFO - 'LOGNAME': 'cltbld', 11:18:11 INFO - 'MAIL': '/var/mail/cltbld', 11:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:11 INFO - 'MOZ_NO_REMOTE': '1', 11:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:11 INFO - 'NO_EM_RESTART': '1', 11:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:11 INFO - 'PWD': '/builds/slave/test', 11:18:11 INFO - 'SHELL': '/bin/bash', 11:18:11 INFO - 'SHLVL': '1', 11:18:11 INFO - 'TERM': 'linux', 11:18:11 INFO - 'TMOUT': '86400', 11:18:11 INFO - 'USER': 'cltbld', 11:18:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:11 INFO - '_': '/tools/buildbot/bin/python'} 11:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:11 INFO - Running setup.py (path:/tmp/pip-vKyEcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:11 INFO - Running setup.py (path:/tmp/pip-_kaaiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:11 INFO - Running setup.py (path:/tmp/pip-iwTXTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:11 INFO - Running setup.py (path:/tmp/pip-ab8RYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:11 INFO - Running setup.py (path:/tmp/pip-hUxLrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:11 INFO - Running setup.py (path:/tmp/pip-GUeYRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:11 INFO - Running setup.py (path:/tmp/pip-yU5glp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:11 INFO - Running setup.py (path:/tmp/pip-lPWhTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:11 INFO - Running setup.py (path:/tmp/pip-xYX1ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:11 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)) 11:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:11 INFO - Running setup.py (path:/tmp/pip-ZRJK9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:12 INFO - Running setup.py (path:/tmp/pip-_Rhi2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:12 INFO - Running setup.py (path:/tmp/pip-oAFXNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:12 INFO - Running setup.py (path:/tmp/pip-eZHLEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:12 INFO - Running setup.py (path:/tmp/pip-T2kH55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:12 INFO - Running setup.py (path:/tmp/pip-c3cR8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:12 INFO - Running setup.py (path:/tmp/pip-cFEMct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:12 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)) 11:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:12 INFO - Running setup.py (path:/tmp/pip-P38e8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:12 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)) 11:18:12 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)) 11:18:12 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)) 11:18:12 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)) 11:18:12 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)) 11:18:12 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)) 11:18:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:14 INFO - Downloading blessings-1.6.tar.gz 11:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:14 INFO - Installing collected packages: blessings 11:18:14 INFO - Running setup.py install for blessings 11:18:14 INFO - Successfully installed blessings 11:18:14 INFO - Cleaning up... 11:18:14 INFO - Return code: 0 11:18:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:14 INFO - Reading from file tmpfile_stdout 11:18:14 INFO - Current package versions: 11:18:14 INFO - argparse == 1.2.1 11:18:14 INFO - blessings == 1.6 11:18:14 INFO - blobuploader == 1.2.4 11:18:14 INFO - docopt == 0.6.1 11:18:14 INFO - functools32 == 3.2.3-2 11:18:14 INFO - jsonschema == 2.5.1 11:18:14 INFO - manifestparser == 1.1 11:18:14 INFO - mozInstall == 1.12 11:18:14 INFO - mozcrash == 0.17 11:18:14 INFO - mozdebug == 0.1 11:18:14 INFO - mozdevice == 0.48 11:18:14 INFO - mozfile == 1.2 11:18:14 INFO - mozhttpd == 0.7 11:18:14 INFO - mozinfo == 0.9 11:18:14 INFO - mozleak == 0.1 11:18:14 INFO - mozlog == 3.2 11:18:14 INFO - moznetwork == 0.27 11:18:14 INFO - mozprocess == 0.23 11:18:14 INFO - mozprofile == 0.28 11:18:14 INFO - mozrunner == 6.12 11:18:14 INFO - mozscreenshot == 0.1 11:18:14 INFO - mozsystemmonitor == 0.3 11:18:14 INFO - moztest == 0.7 11:18:14 INFO - mozversion == 1.4 11:18:14 INFO - psutil == 3.1.1 11:18:14 INFO - requests == 1.2.3 11:18:14 INFO - wsgiref == 0.1.2 11:18:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:14 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 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:14 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 11:18:14 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 11:18:14 INFO - Using env: {'DISPLAY': ':0', 11:18:14 INFO - 'HOME': '/home/cltbld', 11:18:14 INFO - 'LANG': 'en_US.UTF-8', 11:18:14 INFO - 'LANGUAGE': 'en_US:en', 11:18:14 INFO - 'LOGNAME': 'cltbld', 11:18:14 INFO - 'MAIL': '/var/mail/cltbld', 11:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:14 INFO - 'MOZ_NO_REMOTE': '1', 11:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:14 INFO - 'NO_EM_RESTART': '1', 11:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:14 INFO - 'PWD': '/builds/slave/test', 11:18:14 INFO - 'SHELL': '/bin/bash', 11:18:14 INFO - 'SHLVL': '1', 11:18:14 INFO - 'TERM': 'linux', 11:18:14 INFO - 'TMOUT': '86400', 11:18:14 INFO - 'USER': 'cltbld', 11:18:14 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:14 INFO - '_': '/tools/buildbot/bin/python'} 11:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 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)) 11:18:15 INFO - Cleaning up... 11:18:15 INFO - Return code: 0 11:18:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:15 INFO - Using env: {'DISPLAY': ':0', 11:18:15 INFO - 'HOME': '/home/cltbld', 11:18:15 INFO - 'LANG': 'en_US.UTF-8', 11:18:15 INFO - 'LANGUAGE': 'en_US:en', 11:18:15 INFO - 'LOGNAME': 'cltbld', 11:18:15 INFO - 'MAIL': '/var/mail/cltbld', 11:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:15 INFO - 'MOZ_NO_REMOTE': '1', 11:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:15 INFO - 'NO_EM_RESTART': '1', 11:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:15 INFO - 'PWD': '/builds/slave/test', 11:18:15 INFO - 'SHELL': '/bin/bash', 11:18:15 INFO - 'SHLVL': '1', 11:18:15 INFO - 'TERM': 'linux', 11:18:15 INFO - 'TMOUT': '86400', 11:18:15 INFO - 'USER': 'cltbld', 11:18:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:15 INFO - '_': '/tools/buildbot/bin/python'} 11:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:15 INFO - Cleaning up... 11:18:15 INFO - Return code: 0 11:18:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdcd1d95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1367350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, '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': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', '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 11:18:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:18:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:18:15 INFO - Using env: {'DISPLAY': ':0', 11:18:15 INFO - 'HOME': '/home/cltbld', 11:18:15 INFO - 'LANG': 'en_US.UTF-8', 11:18:15 INFO - 'LANGUAGE': 'en_US:en', 11:18:15 INFO - 'LOGNAME': 'cltbld', 11:18:15 INFO - 'MAIL': '/var/mail/cltbld', 11:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:15 INFO - 'MOZ_NO_REMOTE': '1', 11:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:15 INFO - 'NO_EM_RESTART': '1', 11:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:15 INFO - 'PWD': '/builds/slave/test', 11:18:15 INFO - 'SHELL': '/bin/bash', 11:18:15 INFO - 'SHLVL': '1', 11:18:15 INFO - 'TERM': 'linux', 11:18:15 INFO - 'TMOUT': '86400', 11:18:15 INFO - 'USER': 'cltbld', 11:18:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:15 INFO - '_': '/tools/buildbot/bin/python'} 11:18:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:15 INFO - Downloading/unpacking flake8 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:18 INFO - no previously-included directories found matching 'docs/_build' 11:18:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:18 INFO - Running setup.py install for pep8 11:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:18 INFO - no previously-included directories found matching 'docs/_build' 11:18:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:18 INFO - Cleaning up... 11:18:18 INFO - Return code: 0 11:18:18 INFO - Running post-action listener: _resource_record_post_action 11:18:18 INFO - Running post-action listener: _start_resource_monitoring 11:18:18 INFO - Starting resource monitoring. 11:18:18 INFO - ##### 11:18:18 INFO - ##### Finished create-virtualenv step (success) 11:18:18 INFO - ##### 11:18:18 INFO - ##### 11:18:18 INFO - ##### Running install step. 11:18:18 INFO - ##### 11:18:18 INFO - Running pre-action listener: _resource_record_pre_action 11:18:18 INFO - Running main action method: install 11:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:18 INFO - Reading from file tmpfile_stdout 11:18:18 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:18 INFO - Reading from file tmpfile_stdout 11:18:18 INFO - Output received: 11:18:18 INFO - Usage: mozinstall [options] installer 11:18:18 INFO - Options: 11:18:18 INFO - -h, --help show this help message and exit 11:18:18 INFO - -d DEST, --destination=DEST 11:18:18 INFO - Directory to install application into. [default: 11:18:18 INFO - "/builds/slave/test"] 11:18:18 INFO - --app=APP Application being installed. [default: firefox] 11:18:18 INFO - mkdir: /builds/slave/test/build/application 11:18:18 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'] 11:18:18 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 11:18:34 INFO - Reading from file tmpfile_stdout 11:18:34 INFO - Output received: 11:18:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:18:34 INFO - Running post-action listener: _resource_record_post_action 11:18:34 INFO - ##### 11:18:34 INFO - ##### Finished install step (success) 11:18:34 INFO - ##### 11:18:34 INFO - ##### 11:18:34 INFO - ##### Running run-tests step. 11:18:34 INFO - ##### 11:18:34 INFO - Running pre-action listener: _resource_record_pre_action 11:18:34 INFO - Running main action method: run_tests 11:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:34 INFO - Python 2.7.3 11:18:34 INFO - Return code: 0 11:18:34 INFO - grabbing minidump binary from tooltool 11:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:34 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 0x13f61c0>, '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 0x13f70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13f7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18:34 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 11:18:34 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 11:18:34 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 11:18:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:34 INFO - Return code: 0 11:18:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:18:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:18:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:18:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:18:35 INFO - Return code: 0 11:18:35 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/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:18:35 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/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 11:18:35 INFO - Using env: {'DISPLAY': ':0', 11:18:35 INFO - 'HOME': '/home/cltbld', 11:18:35 INFO - 'LANG': 'en_US.UTF-8', 11:18:35 INFO - 'LANGUAGE': 'en_US:en', 11:18:35 INFO - 'LOGNAME': 'cltbld', 11:18:35 INFO - 'MAIL': '/var/mail/cltbld', 11:18:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:35 INFO - 'MOZ_NO_REMOTE': '1', 11:18:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:35 INFO - 'NO_EM_RESTART': '1', 11:18:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:35 INFO - 'PWD': '/builds/slave/test', 11:18:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:35 INFO - 'SHELL': '/bin/bash', 11:18:35 INFO - 'SHLVL': '1', 11:18:35 INFO - 'TERM': 'linux', 11:18:35 INFO - 'TMOUT': '86400', 11:18:35 INFO - 'USER': 'cltbld', 11:18:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681', 11:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:35 INFO - '_': '/tools/buildbot/bin/python'} 11:18:35 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/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 11:18:35 INFO - mozversion application_buildid: 20160720071222 11:18:35 INFO - mozversion application_changeset: aa3cda908cd8e68ee429a293e9683629543af7f1 11:18:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:18:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:35 INFO - mozversion application_name: Firefox 11:18:35 INFO - mozversion application_remotingname: firefox-dev 11:18:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:18:35 INFO - mozversion application_vendor: Mozilla 11:18:35 INFO - mozversion application_version: 49.0a2 11:18:35 INFO - mozversion platform_buildid: 20160720071222 11:18:35 INFO - mozversion platform_changeset: aa3cda908cd8e68ee429a293e9683629543af7f1 11:18:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:18:35 INFO - mozversion platform_version: 49.0a2 11:18:35 INFO - using testdate: 1469038715 11:18:35 INFO - actual date: 1469038715 11:18:35 INFO - starting webserver on 'localhost:58151' 11:18:35 INFO - SUITE-START | Running 2 tests 11:18:35 INFO - TEST-START | dromaeo_css 11:18:35 INFO - operating with platform_type : linux_ 11:18:35 INFO - Initialising browser for dromaeo_css test... 11:18:35 INFO - TEST-INFO | started process 29321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1lz_Cf/profile http://localhost:58151/getInfo.html) 11:18:40 INFO - PROCESS | 29321 | __metrics Screen width/height:1600/1200 11:18:40 INFO - PROCESS | 29321 | colorDepth:24 11:18:40 INFO - PROCESS | 29321 | Browser inner width/height: 1024/697 11:18:40 INFO - PROCESS | 29321 | __metrics 11:18:41 ERROR - PROCESS | 29321 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:18:41 INFO - TEST-INFO | 29321: exit 0 11:18:41 INFO - Browser initialized. 11:18:41 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:41 INFO - TEST-INFO | started process 29450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1lz_Cf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:53 INFO - PROCESS | 29450 | RSS: Main: 156110848 11:18:53 INFO - PROCESS | 29450 | 11:19:43 INFO - PROCESS | 29450 | 1469038783418 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] 11:21:51 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58151/tests/dromaeo/cssquery-ext.html) 11:21:52 INFO - PROCESS | 29450 | RSS: Main: 159588352 11:21:52 INFO - PROCESS | 29450 | 11:24:54 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-ext.html (next: http://localhost:58151/tests/dromaeo/cssquery-jquery.html) 11:24:54 INFO - PROCESS | 29450 | RSS: Main: 157396992 11:24:54 INFO - PROCESS | 29450 | 11:27:56 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58151/tests/dromaeo/cssquery-mootools.html) 11:27:57 INFO - PROCESS | 29450 | RSS: Main: 157564928 11:27:57 INFO - PROCESS | 29450 | 11:30:58 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58151/tests/dromaeo/cssquery-prototype.html) 11:30:59 INFO - PROCESS | 29450 | RSS: Main: 156729344 11:30:59 INFO - PROCESS | 29450 | 11:34:02 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58151/tests/dromaeo/cssquery-yui.html) 11:34:02 INFO - PROCESS | 29450 | RSS: Main: 158314496 11:34:02 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | Cycle 1(1): loaded http://localhost:58151/tests/dromaeo/cssquery-yui.html (next: http://localhost:58151/tests/dromaeo/cssquery-dojo.html) 11:37:05 INFO - PROCESS | 29450 | RSS: Main: 159232000 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | __start_tp_report 11:37:05 INFO - PROCESS | 29450 | _x_x_mozilla_page_load 11:37:05 INFO - PROCESS | 29450 | _x_x_mozilla_page_load_details 11:37:05 INFO - PROCESS | 29450 | |i|pagename|runs| 11:37:05 INFO - PROCESS | 29450 | |0;dojo.html;3315.5358249845017;3359.6976272135503;3393.457046872501;3394.575678040245;3414.6926776590103;5588.636738611993;5603.355614104379;5662.631928924617;5695.515881150107;5703.087505999041;5654.151877218419;5657.3494048184475;5671.6880571568545;5683.403242659523;5735.369109397963;5128.333316668837;5162.936494884406;5165.04446677364;5205.349331333583;5255.421903590602;5082.949170508285;5148.099082660538;5218.112920803473;5267.736613169345;5277.340332458442;5148.742562871841;5150.7424628768595;5188.740562971855;5205.635605507616;5312.07038768216;5216.739163041832;5239.056969745444;5240.371155461369;5245.554127899133;5279.6832190068335;4956.033573453178;5076.416212135578;5148.764296568834;5165.070287348276;5227.137522308814;5528.391876893538;5562.721863906789;5594.021046316879;5609.859753506154;5651.7739290428335;6043.365446628129;6088.543359248074;6092.847678808021;6096.268447786294;6102.908456373158;5935.258092738408;5944.10838374243;6006.888725585781;6122.173506576644;6136.20229370179;5680.11958146488;5684.573656975702;5691.943080569183;5692.487676109128;5715.199872017921;6136.447719705158;6139.907901381483;6148.9692551536955;6188.907166392508;6200.751969921243;5818.4763371296785;5838.620489668158;5847.1229315603;5916.645001299936;5923.289205295306;6028.246469191351;6059.969700151471;6060.484858786965;6072.7570897164505;6085.361037091042;6001.609895356788;6011.759529618854;6046.606970546901;6059.091136329498;6079.787207447718;5834.591578589458;5957.046872500466;5992.520598352121;6002.669853158118;6077.392260773887;4664.090502352009;4665.2535594304745;4668;4682.719036857799;4688.742119183409;4077.1641813428178;4133.648639865645;4174.039970806732;4180.874573762792;4211.473565804275;5580.832575022756;5724.4561766632105;5789.044807606698;5836.562257830679;5850.678212698257;6008.66952317618;6029.155918171459;6050.394960503914;6102.8169154924535;6106.511479081662;5730.914036289459;5859.941400586024;5865.237519122486;5876.706164691748;5896.410358964069;5223.2948551945;5262.105442074857;5276.314079169761;5310.230016647564;5314.096603577401;6422.261439934374;6429.453496452854;6446.645434501053;6455.870882582416;6457.935420645827;5921.526277897672;6009.759609615567;6178.073289006685;6189.876202476015;6195.411435913671;6254.999200127958;6390.648514331757;6392.296847346695;6396.9125248706905;6406.167198264196;5947.256592925884;5996.5502587307;6014.609050411709;6020.157177994996;6022.126791615279;5837.153612726046;6050.878982420415;6108.4807791338235;6116.3272040076445;6129.172561704113;5886.117082437669;5933.821985340447;5940.732667030081;5945.702714864326;5952.494038006818;5874.383189765013;5914.615549989237;5915.201447804491;5918.437748413894;5923.348431672599;5668.433156684298;5708.115242137475;5718.656880587178;5756.568257380797;5792.304923409218;5917.497012753965;5933.614315069507;5939.376365481562;5967.8209653710455;6006.189164462917;5786;5822.679752613478;5829.562782791392;5839.532837373085;5839.678817664899 11:37:05 INFO - PROCESS | 29450 | |1;ext.html;599.1671576508651;648.0829626079098;662.7713438863593;667.0860920538862;680.9250982391933;41448.17103657929;45847;46059.539404605945;46112.76943615281;46160;46720;46927.53072469274;47201.527984720145;47287.763561182146;47300.52699473004;8896.777580560472;8941.105889411072;8943.150400711922;8949.060348663394;8994.190522852941;8908.24279936203;8976.23701985332;8978.640854365818;8980.775480613005;8986.146316099992;9026.187643112118;9046.276297896185;9060.139286767746;9064.546772661373;9085.591148398305;8932.285417166611;8961.103889611051;8977.596008179647;8982.820343593092;8988.146126118008;8930.508822014786;8939.68711095115;8947.910520894839;8985.955070224672;9005.684801031932;42576.78711606453;42672.35991460131;42682.57317426848;43030;43171.568284317385;3905.9609403906165;3917.5494818095713;4006.599340065999;4174.853880114181;4287.699861009731;34586;34762.30475390503;34885.476717849255;35065.649343506746;35771.82114089413;4721.291806229059;4748.5251474852585;4761;4787.234042553175;4899.142650036265;373881;374645;374651;374720;375087;64637.676811616584;64733.35266647367;65074.698506029614;65096.34903650998;65126.67436662881;35541;35938.460923086175;36117.819410902775;36222.8188859054;36365.27269454596;18422.35521756759;18534;18567;18689.90655046716;18763.530911727317;12557.686057848445;12611.810822837664;12618.87381126177;12630.242185468902;12678.936605316914;21514.78485215159;21590.568188636138;21701.45746356322;21707.674384883925;21857.562848742935;7608.505447146029;7863.174366691529;7869.449138560246;7869.527828330319;7939;1026.5944951744168;1143.9199256052163;1151;1185.7450648110698;1210.9273443593413;33109.337813244085;33130;33433.83283083569;33816.83091584526;34141.829290853384;1179.5753528729651;1190.3155685480883;1212.2908098762323;1270.6632742323293;1303.6284658872175;17402.303907843543;17570.736438953427;17592.736108958376;17625.030623315582;17720.822791772174;607977;609136;610229;612090;640428;62386;62931;63047;63091.684541577;63317.68341158265;1486.301438323986;1515.371120984779;1516.052467207995;1519.323900864127;1527.5646440764328;32361.676383235867;32796.508052378755;32865.67134328626;32935.34129317352;33602.66397336093;53081.46918530765;53599;53680.463195369106;53731.462685372644;53911.92176156533;403200;404412;407641;408171;408626;29629.703702963558;29899.252518687208;30009.549856751728;30585.54121688132;30628.84685576558;48854.26718599153;48945.51054489552;48981.75509122432;49679.75160124176;50390;41124.79437602793;41422.79288603538;41452.79273603613;42579.0839412221;42646.36030459483;40690.38964415477;41022.79488602538;41036.1792764149;42123;42186.36720449134;42133.78933105437;42800.78599606982;42881.35677964895;43395.349069763346;43666.34500482559;35288.58845646145;35437.29125417529;35746;36293.63706362902;36585.634143659285;30351.696483034888;31997.680023200403;32174.678253218106;32416.83791581027;32577 11:37:05 INFO - PROCESS | 29450 | |2;jquery.html;419.17841031578104;422.176755327112;431.67839959230366;432.52206312025214;433.0753840550424;18789.436316910498;19651.213951441925;20685.896570517125;20687.896560517194;20766.89616551919;19407.12667929943;19717.605647887034;20100.296489622866;20791;21020.369388918356;5696.08862581987;5863.1791549182935;5889.705514724268;5890.204822348992;5898.439648233411;5559.249501317311;5823;5874.73563689635;5886.676232807194;5887.88224235515;5685.147227915804;5841.269841269841;5865.794697185599;5897.705114744245;5906.734196961147;6076.665783381913;6127.234095738033;6148;6154.230721159833;6162.722677479479;5785.392533783935;5815.244018277639;5890.175375447441;5971.462568368867;5981.192539007222;14587;14620.926895365561;14902.776458353024;16090.597735056717;24463.26610201697;2248.4940888300166;2410.3371572817614;2413.54142712884;2452.2275483222907;2528.494301139761;10468.94765526175;10666.946665266702;10885.401302928336;11122.721931951684;11583.768324633544;1971.6648169811167;2026.1490174126902;2047.5904819036252;2052.374025922093;2104.905279262437;90057.54971225167;92858.53570732103;93201;93565;94032.52983735106;11450.484728187252;11689.532418703327;11818.704532386588;11876.218567214813;11939.164258501994;16585.50243492697;16637.251323690463;16639.916800415922;16643.41748038813;16688.165591720364;8623.267022303175;8627.6980305689;8738.475691458532;8870.42342247752;8882.111788821067;8425.95787021061;8469.153084691605;8492.363072769567;8514.57427128641;8541.786455338543;4902.3872015998;5007.073691367109;5028.421731500851;5069.555176774602;5078.415982162025;2096.9266075687583;2101.317071951622;2130.9041093150845;2136;2165.317924853666;1019.2966852871494;1038.314712289885;1051.2483574244452;1083.225493771941;1123.342844436014;19953.60092798136;19954.30159944395;20079.196832126552;20210.595788084156;20510;1037.0977249792577;1038.8909164537765;1048.5491238767404;1084.1814430105378;1086.7446150154708;10406.635767748092;11454.828177577343;11482.94258528702;11583.478743456397;11601.419929003516;487250;492386;528256;533392;533762;100114;100514.49742751385;102582.48708756408;102739;103237.48381258045;1030.0729343590679;1054.651964851597;1077.154433769503;1078.2560033576806;1082.4263140535686;17003.319867205173;18006.90996545009;18219.90890045541;18264.295686824116;18316.633667326314;42431.3635295477;42583.36124958066;44834.775826121964;45183;45315.773421134;61214;62834.37165628285;63198.36801632109;63814;64536.35463645491;8820.426672266281;8977.147171018743;9034.14175653312;9040;9376.062393760569;13026.218426894417;13336.19982801035;13358.998075144209;13386.866131338562;13450.394732236877;11061.336319820515;11851.466683999413;11951.521939122338;12099.032077433609;12249.571265005681;11660.12549058807;12032;12224.205426647239;12380.071494638118;12435.502579896704;12287.1399002069;12409.813852792035;12470;12516.624501264976;12549.121561490609;7673.117591477052;8194.959025204837;8310.750677479686;8448.535330556633;9125.133112354315;9311.487868167316;11988.220765650205;12237.388130593257;12352.62942111738;12480 11:37:05 INFO - PROCESS | 29450 | |3;mootools.html;1593.8087429508462;1631.1110444807578;1858.739776431299;1929.3247363422795;1944.5819148882988;8475.364347673918;9294.535273236337;9312.208462280714;9982.151517121045;9983.450910199945;9520.095590918869;9791.951040244789;9867.75330616735;9874.753131171725;9889.604415823358;2502.2618327593405;2540.491901619674;2541.8474891506476;2544.8218624696187;2545.0964907457865;2439.9878000609974;2524.255344673317;2525.7726804587583;2527.241827451757;2531.4177739120014;2424.5514579802707;2430.7933825624755;2433.707955045388;2434;2434.75652434756;2408.6989126359204;2419.358869899469;2420.1287536486852;2455.938601534976;2461.5569197544437;2393.940151496209;2399.2442380650214;2440.0849681369486;2452.4849781545895;2456.8894399751875;9746.756331091708;9835.803283934352;9863.112319891172;9864.556094975671;9891.604335826558;5669.603127781057;5771.855703607402;5776.913346299809;5784.248047753807;5804.738786754606;3700.703943684499;3832.9808350958065;3840.577536470986;3876.879112314614;3897.142628621699;1212.5782668664428;1227.674666213445;1250.1936251117977;1294.954676586315;1328.9136206146666;13731.725365492734;13771.724565508734;13794.448222071205;13809.447622095104;13847.169169849842;4897.559219670246;4941.703497790144;5105.183170692671;5105.310783044316;5105.387353517527;11772.470238839272;11779.764404711857;11832.822507662391;11832.822507662391;11840.763184736257;5839.328477225088;5914.231149950565;5914.497267732291;5917.585768996215;5921.940780592225;4612.262038073892;5084.898302033938;5235.319408476874;5262.631615786935;5410.729463526808;4365.847195348148;4373.431453910971;4430.379746835446;4447.555244475591;4552.430946131733;1367.7416776565583;1371.6570857285678;1382.523029554802;1393.4565519447424;1406.7186562687502;955.9187469065068;1060.9787804243872;1072.3137192197;1074.3070719385953;1082.6751974407803;6407.167068281094;6579.671016449254;6613.437857782143;6618.536702430783;6668.766593169313;496.5605439186346;500.7646406189085;1094.7372630568766;1138.4649214868998;1178.3342411537626;4490.313054929247;4522.208613492691;4686.086213188463;4697.318888761179;4766.285057241442;12291.938540307241;12550.623481295575;12553.435095420728;12558.560450384193;12598.81101783474;11747.588834390755;12156.574519891938;12172.513099476098;12498.500059997497;12506.3121528315;9149;9294.349395542382;9322.766930826649;9334;9398.20115290208;6461.256955450183;6647.966760166169;6716.1604799400075;6809.148856392951;6819.352161544645;11257.774844502901;11294;11335.376554289593;11426.82859757121;11494.482748276181;11341.26281791681;11585;11618.593349232737;11688.357140357022;11745.823812642646;7716.7684969451;8419.95790021046;8669.6965606206;8844.380893337662;9008.41445306053;9610.855837162588;9628.951855240679;9641.903580964381;9650.469224192737;9674.274429417681;8453.408261421642;8743;8763.518006509703;8861.91138088611;8970.192682658591;8315.875261870955;8354;8405.201505856934;8450.154984501502;8732.738017859474;7803.492772969739;7879.881801773093;7889.566073865993;7970.322522585645;7973.242541958504;5719.742611582572;5805.581450701173;5814.30228372598;5838.416158384128;6000.939990600038;5850.5027072699295;5873.3832947541605;5886.470217680429;5933.199018132669;5976 11:37:05 INFO - PROCESS | 29450 | |4;prototype.html;353.87614334982743;354.28788135846946;354.36568542309266;362.93467175908324;369.8428168028587;5593.860153496154;5625.465580769831;5790.363060063395;5821.941780582193;5831.795887143956;5631.099024156136;5637.943620563793;5674.574406919487;5674.687892165929;5686.31764188298;4488.775561221926;4489.753063581502;4502.932456013163;4520.97739511302;4525.570070843265;4413.514513403523;4453.465584129909;4465;4495.9325610115875;4524.773761311938;4424.269995450747;4430.800613972379;4433.512313645497;4440.622547083502;4465.88352911772;4443.533428989958;4467.865964021068;4494.68537202396;4497.437820272466;4531.592156705912;3700.3154416433044;3906.921861562753;4046.988252936766;4050.6354428101317;4056.0468289951837;5477.890442191134;5508.3114610673665;5511.366192887789;5525.281713377275;5535.086710692731;5090.49095090488;5094.1594636884865;5130.486951304877;5133.255677926717;5163.122269214243;5692.345380281279;5978.671173085479;6006.369331220247;6020.4581587656885;6069.241344831896;4298.527162012176;4328.523862375137;4340.500842403132;4342.283523218665;4354.804033818486;6191.59754615953;6272.341404152544;6280.717367718464;6285.622862628211;6290.716917738667;4359.956400436018;4444.155610434072;4445.5776701213335;4460.241758900995;4466.196084704784;4503.684742068024;4523.84166554169;4532.864014079583;4537.977310113494;4553.180427523078;5090;5107.642465027412;5127.333446651912;5163.97418012915;5217.921731174036;5808.680522571299;6037.45662890342;6045.244344456943;6049.304330002018;6075.908861367083;1541.5067178502773;1554.4093244566993;1564.7716542514072;1565.9899364909797;1566.9138197399025;992.3549692699803;994.3288280410694;1006.864073350103;1007.7077647482295;1011.3577878047493;5263.6841789492755;5292.708901010405;5316.893662126813;5331.333583302087;5338.679679219182;5503.009458297545;5515.889682206333;5523.751431185607;5545.057340252167;5586.54749765064;5011.223260394645;5235.502627250406;5292.115796890704;5342.626016178908;5395.541378982831;2957.491679243601;2986.283292009902;3007.7142671446177;3012.623422072241;3017.366353065837;5637.605367624227;5656.975321282821;5762.769489220468;5768.625039372428;5795.391483894215;5541.972290138524;5566.443355664401;5626.634268772598;5639.661620302795;5653.858653533694;5714.857028594298;5744.339400968942;5803.506701930383;5818.5636077294375;5896.9115463268945;5300;5477.890442191214;5521.806736764194;5575.972120139373;5640.266765320482;5421.512063914267;5429.945700543102;5522.3649280333275;5532.529734972572;5534.335879694462;5660.037793575185;5677.403872593318;5703.486686198262;5744.597878148489;5768.1636162757;3900.1419687668667;4004.6596039336982;4018.4374187614344;4048.3117869962766;4116.547179810159;5507.504324610804;5523.944760552504;5575.275214222125;6022.126791615104;6199.939039928854;6016;6039.033754599419;6042.848928776816;6068.969655151696;6146.416090471398;6053.727582258721;6056.697165141637;6073.514118870568;6092.745684096913;6107.725152368065;5794.62334948227;5833.82498525045;5878.647281163144;5879.382664820132;5900.347902587282;6060.39396060408;6095.664738439251;6124.335913877478;6169.352218017223;6192.606663500676;5724.742386592697;5962.940370596239;6011.669358185167;6032.517398608188;6061.454469097803 11:37:05 INFO - PROCESS | 29450 | |5;yui.html;769.4037121231049;781.6990458673409;804.7545498622919;808.1595141053305;917.348682435471;16366.672666546661;16379.508614741577;16394.426195083175;16551.586210344747;17559.736603950936;16003.759943600855;16147.596310092253;16172.191390430491;16178.514644560653;16217.351305947777;716.1549371741343;829.5147338806805;853.0531110467407;857.3141486810526;865.3682811547574;860.6729442811722;864.312871267344;864.5849992003842;865.7748985263845;866.8049688820028;909.8635204719279;913.0869130869131;916.138829500271;921.8617207418907;922.3174850610567;912.3522299167599;912.8311262416441;915.729859691386;916.2898753466051;918.0268914950141;668.238208442376;671.5701950751522;673.1148539670367;675.490005046187;676.736072931557;16192.75710864338;16213.189340532927;16246.675066498721;16299.674006519921;16305.91847040769;13570;14302.785458218135;14426.495072672406;14440.350184241734;14733.631659208499;13937.233452160128;14302.92848535761;14358.282085895664;14368.353424095942;14395.928020359832;4788.9521104788855;4798.5201479852085;4860.708357498562;4878.853634390974;4991.725455100004;81264.59367703182;81346;85839;85958.57020714918;86274.56862715709;11638.6508404748;11771.52913883435;12039.458224379923;12347.135700501058;12673.239605623508;22093.447663808533;22186.334409967727;22202.66695999561;22222.222222222466;22246.332610021724;8554.315654747605;8610.526421046778;8738.432001919982;8767.693130740394;8834.337424693174;4904.5340692634145;4925.187344088257;5054.292399064134;5079.4412614612365;5091.516305950929;3623.691986181204;3700.4634328022285;3716.108134047809;3726.2174943261675;3729.9440508392395;643.0386572074684;644.0628884972353;645.9418652321314;648.7567162314132;649.8505343770864;707.7487491940287;713.165596252386;761.1475147834461;761.219749756504;785.7917651822272;10130.645427410005;10735.248532602798;11113.666590002313;11147.037706419651;11395.658130256106;671;731.1664702239451;816.1593558634497;829.9004119505698;844.2528362399198;5243.947560524422;5395.109806881899;5512.39363669996;5645.745941432645;5688.82933511987;101858.49070754748;104421;105472;113643.4317828422;116450.41774791242;70214.2978570218;85862;87752;102378;105107;62291.688541557;65340.67329663321;92111.53944230235;94121;97918;11026.669199924016;11108.611198608332;11256.887431125584;11472.598459053894;11518;54624.45375546194;55000;55208.17187742107;55473.72263138658;57576.1363579555;78412;80289.59855200686;82596.58701706454;82867.5856620713;83280;13980;14368.784468232776;14889.284046769846;14892.255387230813;15115.093094414371;16242.51272461828;16699.749503757695;16797.74803377926;17090.74363884518;17240.827591724425;15123.924380378028;15428;15715.371385144466;16141.112238826978;16512.834871651612;15392.769108463606;15603.921980390025;15930;15946.122963237134;15955.760663589823;15321.923390382977;15525.922370388076;15526.689466210839;15911.204439778196;15917.920410398337;11428;11841.763164736829;12157.331346776013;12489.37553122322;13301.733965320833;12820.589735128942;13106.541271055466;13261.33693315311;13288.867111328764;13299.335033248106 11:37:05 INFO - PROCESS | 29450 | __end_tp_report 11:37:05 INFO - PROCESS | 29450 | __start_cc_report 11:37:05 INFO - PROCESS | 29450 | _x_x_mozilla_cycle_collect,346 11:37:05 INFO - PROCESS | 29450 | __end_cc_report 11:37:05 INFO - PROCESS | 29450 | __startTimestamp1469039825363__endTimestamp 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | ------- Summary: start ------- 11:37:05 INFO - PROCESS | 29450 | Number of tests: 6 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#0] dojo.html Cycles:165 Average:5643.13 Median:5839.53 stddev:626.15 (10.7%) stddev-sans-first:600.86 11:37:05 INFO - PROCESS | 29450 | Values: 3315.5 3359.7 3393.5 3394.6 3414.7 5588.6 5603.4 5662.6 5695.5 5703.1 5654.2 5657.3 5671.7 5683.4 5735.4 5128.3 5162.9 5165.0 5205.3 5255.4 5082.9 5148.1 5218.1 5267.7 5277.3 5148.7 5150.7 5188.7 5205.6 5312.1 5216.7 5239.1 5240.4 5245.6 5279.7 4956.0 5076.4 5148.8 5165.1 5227.1 5528.4 5562.7 5594.0 5609.9 5651.8 6043.4 6088.5 6092.8 6096.3 6102.9 5935.3 5944.1 6006.9 6122.2 6136.2 5680.1 5684.6 5691.9 5692.5 5715.2 6136.4 6139.9 6149.0 6188.9 6200.8 5818.5 5838.6 5847.1 5916.6 5923.3 6028.2 6060.0 6060.5 6072.8 6085.4 6001.6 6011.8 6046.6 6059.1 6079.8 5834.6 5957.0 5992.5 6002.7 6077.4 4664.1 4665.3 4668.0 4682.7 4688.7 4077.2 4133.6 4174.0 4180.9 4211.5 5580.8 5724.5 5789.0 5836.6 5850.7 6008.7 6029.2 6050.4 6102.8 6106.5 5730.9 5859.9 5865.2 5876.7 5896.4 5223.3 5262.1 5276.3 5310.2 5314.1 6422.3 6429.5 6446.6 6455.9 6457.9 5921.5 6009.8 6178.1 6189.9 6195.4 6255.0 6390.6 6392.3 6396.9 6406.2 5947.3 5996.6 6014.6 6020.2 6022.1 5837.2 6050.9 6108.5 6116.3 6129.2 5886.1 5933.8 5940.7 5945.7 5952.5 5874.4 5914.6 5915.2 5918.4 5923.3 5668.4 5708.1 5718.7 5756.6 5792.3 5917.5 5933.6 5939.4 5967.8 6006.2 5786.0 5822.7 5829.6 5839.5 5839.7 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#1] ext.html Cycles:180 Average:62808.49 Median:23148.93 stddev:127029.81 (548.8%) stddev-sans-first:127300.29 11:37:05 INFO - PROCESS | 29450 | Values: 599.2 648.1 662.8 667.1 680.9 41448.2 45847.0 46059.5 46112.8 46160.0 46720.0 46927.5 47201.5 47287.8 47300.5 8896.8 8941.1 8943.2 8949.1 8994.2 8908.2 8976.2 8978.6 8980.8 8986.1 9026.2 9046.3 9060.1 9064.5 9085.6 8932.3 8961.1 8977.6 8982.8 8988.1 8930.5 8939.7 8947.9 8986.0 9005.7 42576.8 42672.4 42682.6 43030.0 43171.6 3906.0 3917.5 4006.6 4174.9 4287.7 34586.0 34762.3 34885.5 35065.6 35771.8 4721.3 4748.5 4761.0 4787.2 4899.1 373881.0 374645.0 374651.0 374720.0 375087.0 64637.7 64733.4 65074.7 65096.3 65126.7 35541.0 35938.5 36117.8 36222.8 36365.3 18422.4 18534.0 18567.0 18689.9 18763.5 12557.7 12611.8 12618.9 12630.2 12678.9 21514.8 21590.6 21701.5 21707.7 21857.6 7608.5 7863.2 7869.4 7869.5 7939.0 1026.6 1143.9 1151.0 1185.7 1210.9 33109.3 33130.0 33433.8 33816.8 34141.8 1179.6 1190.3 1212.3 1270.7 1303.6 17402.3 17570.7 17592.7 17625.0 17720.8 607977.0 609136.0 610229.0 612090.0 640428.0 62386.0 62931.0 63047.0 63091.7 63317.7 1486.3 1515.4 1516.1 1519.3 1527.6 32361.7 32796.5 32865.7 32935.3 33602.7 53081.5 53599.0 53680.5 53731.5 53911.9 403200.0 404412.0 407641.0 408171.0 408626.0 29629.7 29899.3 30009.5 30585.5 30628.8 48854.3 48945.5 48981.8 49679.8 50390.0 41124.8 41422.8 41452.8 42579.1 42646.4 40690.4 41022.8 41036.2 42123.0 42186.4 42133.8 42800.8 42881.4 43395.3 43666.3 35288.6 35437.3 35746.0 36293.6 36585.6 30351.7 31997.7 32174.7 32416.8 32577.0 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#2] jquery.html Cycles:180 Average:30654.64 Median:11443.96 stddev:85306.23 (745.4%) stddev-sans-first:85515.33 11:37:05 INFO - PROCESS | 29450 | Values: 419.2 422.2 431.7 432.5 433.1 18789.4 19651.2 20685.9 20687.9 20766.9 19407.1 19717.6 20100.3 20791.0 21020.4 5696.1 5863.2 5889.7 5890.2 5898.4 5559.2 5823.0 5874.7 5886.7 5887.9 5685.1 5841.3 5865.8 5897.7 5906.7 6076.7 6127.2 6148.0 6154.2 6162.7 5785.4 5815.2 5890.2 5971.5 5981.2 14587.0 14620.9 14902.8 16090.6 24463.3 2248.5 2410.3 2413.5 2452.2 2528.5 10468.9 10666.9 10885.4 11122.7 11583.8 1971.7 2026.1 2047.6 2052.4 2104.9 90057.5 92858.5 93201.0 93565.0 94032.5 11450.5 11689.5 11818.7 11876.2 11939.2 16585.5 16637.3 16639.9 16643.4 16688.2 8623.3 8627.7 8738.5 8870.4 8882.1 8426.0 8469.2 8492.4 8514.6 8541.8 4902.4 5007.1 5028.4 5069.6 5078.4 2096.9 2101.3 2130.9 2136.0 2165.3 1019.3 1038.3 1051.2 1083.2 1123.3 19953.6 19954.3 20079.2 20210.6 20510.0 1037.1 1038.9 1048.5 1084.2 1086.7 10406.6 11454.8 11482.9 11583.5 11601.4 487250.0 492386.0 528256.0 533392.0 533762.0 100114.0 100514.5 102582.5 102739.0 103237.5 1030.1 1054.7 1077.2 1078.3 1082.4 17003.3 18006.9 18219.9 18264.3 18316.6 42431.4 42583.4 44834.8 45183.0 45315.8 61214.0 62834.4 63198.4 63814.0 64536.4 8820.4 8977.1 9034.1 9040.0 9376.1 13026.2 13336.2 13359.0 13386.9 13450.4 11061.3 11851.5 11951.5 12099.0 12249.6 11660.1 12032.0 12224.2 12380.1 12435.5 12287.1 12409.8 12470.0 12516.6 12549.1 7673.1 8195.0 8310.8 8448.5 9125.1 9311.5 11988.2 12237.4 12352.6 12480.0 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#3] mootools.html Cycles:180 Average:6481.63 Median:4691.70 stddev:3748.19 (79.9%) stddev-sans-first:3740.71 11:37:05 INFO - PROCESS | 29450 | Values: 1593.8 1631.1 1858.7 1929.3 1944.6 8475.4 9294.5 9312.2 9982.2 9983.5 9520.1 9792.0 9867.8 9874.8 9889.6 2502.3 2540.5 2541.8 2544.8 2545.1 2440.0 2524.3 2525.8 2527.2 2531.4 2424.6 2430.8 2433.7 2434.0 2434.8 2408.7 2419.4 2420.1 2455.9 2461.6 2393.9 2399.2 2440.1 2452.5 2456.9 9746.8 9835.8 9863.1 9864.6 9891.6 5669.6 5771.9 5776.9 5784.2 5804.7 3700.7 3833.0 3840.6 3876.9 3897.1 1212.6 1227.7 1250.2 1295.0 1328.9 13731.7 13771.7 13794.4 13809.4 13847.2 4897.6 4941.7 5105.2 5105.3 5105.4 11772.5 11779.8 11832.8 11832.8 11840.8 5839.3 5914.2 5914.5 5917.6 5921.9 4612.3 5084.9 5235.3 5262.6 5410.7 4365.8 4373.4 4430.4 4447.6 4552.4 1367.7 1371.7 1382.5 1393.5 1406.7 955.9 1061.0 1072.3 1074.3 1082.7 6407.2 6579.7 6613.4 6618.5 6668.8 496.6 500.8 1094.7 1138.5 1178.3 4490.3 4522.2 4686.1 4697.3 4766.3 12291.9 12550.6 12553.4 12558.6 12598.8 11747.6 12156.6 12172.5 12498.5 12506.3 9149.0 9294.3 9322.8 9334.0 9398.2 6461.3 6648.0 6716.2 6809.1 6819.4 11257.8 11294.0 11335.4 11426.8 11494.5 11341.3 11585.0 11618.6 11688.4 11745.8 7716.8 8420.0 8669.7 8844.4 9008.4 9610.9 9629.0 9641.9 9650.5 9674.3 8453.4 8743.0 8763.5 8861.9 8970.2 8315.9 8354.0 8405.2 8450.2 8732.7 7803.5 7879.9 7889.6 7970.3 7973.2 5719.7 5805.6 5814.3 5838.4 6000.9 5850.5 5873.4 5886.5 5933.2 5976.0 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#4] prototype.html Cycles:180 Average:4895.92 Median:5509.84 stddev:1407.42 (25.5%) stddev-sans-first:1369.46 11:37:05 INFO - PROCESS | 29450 | Values: 353.9 354.3 354.4 362.9 369.8 5593.9 5625.5 5790.4 5821.9 5831.8 5631.1 5637.9 5674.6 5674.7 5686.3 4488.8 4489.8 4502.9 4521.0 4525.6 4413.5 4453.5 4465.0 4495.9 4524.8 4424.3 4430.8 4433.5 4440.6 4465.9 4443.5 4467.9 4494.7 4497.4 4531.6 3700.3 3906.9 4047.0 4050.6 4056.0 5477.9 5508.3 5511.4 5525.3 5535.1 5090.5 5094.2 5130.5 5133.3 5163.1 5692.3 5978.7 6006.4 6020.5 6069.2 4298.5 4328.5 4340.5 4342.3 4354.8 6191.6 6272.3 6280.7 6285.6 6290.7 4360.0 4444.2 4445.6 4460.2 4466.2 4503.7 4523.8 4532.9 4538.0 4553.2 5090.0 5107.6 5127.3 5164.0 5217.9 5808.7 6037.5 6045.2 6049.3 6075.9 1541.5 1554.4 1564.8 1566.0 1566.9 992.4 994.3 1006.9 1007.7 1011.4 5263.7 5292.7 5316.9 5331.3 5338.7 5503.0 5515.9 5523.8 5545.1 5586.5 5011.2 5235.5 5292.1 5342.6 5395.5 2957.5 2986.3 3007.7 3012.6 3017.4 5637.6 5657.0 5762.8 5768.6 5795.4 5542.0 5566.4 5626.6 5639.7 5653.9 5714.9 5744.3 5803.5 5818.6 5896.9 5300.0 5477.9 5521.8 5576.0 5640.3 5421.5 5429.9 5522.4 5532.5 5534.3 5660.0 5677.4 5703.5 5744.6 5768.2 3900.1 4004.7 4018.4 4048.3 4116.5 5507.5 5523.9 5575.3 6022.1 6199.9 6016.0 6039.0 6042.8 6069.0 6146.4 6053.7 6056.7 6073.5 6092.7 6107.7 5794.6 5833.8 5878.6 5879.4 5900.3 6060.4 6095.7 6124.3 6169.4 6192.6 5724.7 5962.9 6011.7 6032.5 6061.5 11:37:05 INFO - PROCESS | 29450 | 11:37:05 INFO - PROCESS | 29450 | [#5] yui.html Cycles:180 Average:21535.40 Median:3728.08 stddev:29452.14 (790.0%) stddev-sans-first:29493.48 11:37:05 INFO - PROCESS | 29450 | Values: 769.4 781.7 804.8 808.2 917.3 16366.7 16379.5 16394.4 16551.6 17559.7 16003.8 16147.6 16172.2 16178.5 16217.4 716.2 829.5 853.1 857.3 865.4 860.7 864.3 864.6 865.8 866.8 909.9 913.1 916.1 921.9 922.3 912.4 912.8 915.7 916.3 918.0 668.2 671.6 673.1 675.5 676.7 16192.8 16213.2 16246.7 16299.7 16305.9 13570.0 14302.8 14426.5 14440.4 14733.6 13937.2 14302.9 14358.3 14368.4 14395.9 4789.0 4798.5 4860.7 4878.9 4991.7 81264.6 81346.0 85839.0 85958.6 86274.6 11638.7 11771.5 12039.5 12347.1 12673.2 22093.4 22186.3 22202.7 22222.2 22246.3 8554.3 8610.5 8738.4 8767.7 8834.3 4904.5 4925.2 5054.3 5079.4 5091.5 3623.7 3700.5 3716.1 3726.2 3729.9 643.0 644.1 645.9 648.8 649.9 707.7 713.2 761.1 761.2 785.8 10130.6 10735.2 11113.7 11147.0 11395.7 671.0 731.2 816.2 829.9 844.3 5243.9 5395.1 5512.4 5645.7 5688.8 101858.5 104421.0 105472.0 113643.4 116450.4 70214.3 85862.0 87752.0 102378.0 105107.0 62291.7 65340.7 92111.5 94121.0 97918.0 11026.7 11108.6 11256.9 11472.6 11518.0 54624.5 55000.0 55208.2 55473.7 57576.1 78412.0 80289.6 82596.6 82867.6 83280.0 13980.0 14368.8 14889.3 14892.3 15115.1 16242.5 16699.7 16797.7 17090.7 17240.8 15123.9 15428.0 15715.4 16141.1 16512.8 15392.8 15603.9 15930.0 15946.1 15955.8 15321.9 15525.9 15526.7 15911.2 15917.9 11428.0 11841.8 12157.3 12489.4 13301.7 12820.6 13106.5 13261.3 13288.9 13299.3 11:37:05 INFO - PROCESS | 29450 | -------- Summary: end -------- 11:37:05 INFO - PROCESS | 29450 | 11:37:06 INFO - TEST-INFO | 29450: exit 0 11:37:06 INFO - TEST-OK | dromaeo_css | took 1110200ms 11:37:06 INFO - TEST-START | kraken 11:37:06 INFO - operating with platform_type : linux_ 11:37:06 INFO - Initialising browser for kraken test... 11:37:06 INFO - TEST-INFO | started process 29697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8r5oT/profile http://localhost:58151/getInfo.html) 11:37:10 INFO - PROCESS | 29697 | __metrics Screen width/height:1600/1200 11:37:10 INFO - PROCESS | 29697 | colorDepth:24 11:37:10 INFO - PROCESS | 29697 | Browser inner width/height: 1024/697 11:37:10 INFO - PROCESS | 29697 | __metrics 11:37:11 ERROR - PROCESS | 29697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 11:37:12 INFO - TEST-INFO | 29697: exit 0 11:37:12 INFO - Browser initialized. 11:37:12 INFO - Running cycle 1/1 for kraken test... 11:37:12 INFO - TEST-INFO | started process 29830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8r5oT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:24 INFO - PROCESS | 29830 | RSS: Main: 156073984 11:37:24 INFO - PROCESS | 29830 | 11:37:26 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58151/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:27 INFO - PROCESS | 29830 | RSS: Main: 160972800 11:37:27 INFO - PROCESS | 29830 | 11:37:30 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58151/tests/kraken/driver.html?testName=audio-dft) 11:37:30 INFO - PROCESS | 29830 | RSS: Main: 160493568 11:37:30 INFO - PROCESS | 29830 | 11:37:33 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58151/tests/kraken/driver.html?testName=audio-fft) 11:37:34 INFO - PROCESS | 29830 | RSS: Main: 161075200 11:37:34 INFO - PROCESS | 29830 | 11:37:36 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58151/tests/kraken/driver.html?testName=audio-oscillator) 11:37:37 INFO - PROCESS | 29830 | RSS: Main: 160960512 11:37:37 INFO - PROCESS | 29830 | 11:37:39 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58151/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:39 INFO - PROCESS | 29830 | RSS: Main: 160813056 11:37:39 INFO - PROCESS | 29830 | 11:37:42 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58151/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:43 INFO - PROCESS | 29830 | RSS: Main: 160526336 11:37:43 INFO - PROCESS | 29830 | 11:37:46 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58151/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:47 INFO - PROCESS | 29830 | RSS: Main: 161263616 11:37:47 INFO - PROCESS | 29830 | 11:37:50 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58151/tests/kraken/driver.html?testName=json-parse-financial) 11:37:51 INFO - PROCESS | 29830 | RSS: Main: 160944128 11:37:51 INFO - PROCESS | 29830 | 11:37:52 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58151/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:53 INFO - PROCESS | 29830 | RSS: Main: 160669696 11:37:53 INFO - PROCESS | 29830 | 11:37:54 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:55 INFO - PROCESS | 29830 | RSS: Main: 160632832 11:37:55 INFO - PROCESS | 29830 | 11:37:57 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:58 INFO - PROCESS | 29830 | RSS: Main: 161009664 11:37:58 INFO - PROCESS | 29830 | 11:38:00 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:01 INFO - PROCESS | 29830 | RSS: Main: 161411072 11:38:01 INFO - PROCESS | 29830 | 11:38:04 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:04 INFO - PROCESS | 29830 | RSS: Main: 161230848 11:38:04 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | Cycle 1(1): loaded http://localhost:58151/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58151/tests/kraken/driver.html?testName=ai-astar) 11:38:06 INFO - PROCESS | 29830 | RSS: Main: 161140736 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | __start_tp_report 11:38:06 INFO - PROCESS | 29830 | _x_x_mozilla_page_load 11:38:06 INFO - PROCESS | 29830 | _x_x_mozilla_page_load_details 11:38:06 INFO - PROCESS | 29830 | |i|pagename|runs| 11:38:06 INFO - PROCESS | 29830 | |0;ai-astar;112;105;111;112;111;110;111;111;110;110 11:38:06 INFO - PROCESS | 29830 | |1;audio-beat-detection;153;125;150;184;128;155;159;127;185;125 11:38:06 INFO - PROCESS | 29830 | |2;audio-dft;162;162;163;164;162;163;163;165;162;163 11:38:06 INFO - PROCESS | 29830 | |3;audio-fft;77;82;74;186;76;77;75;75;182;76 11:38:06 INFO - PROCESS | 29830 | |4;audio-oscillator;85;85;144;84;86;86;147;85;89;144 11:38:06 INFO - PROCESS | 29830 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;117;117;117 11:38:06 INFO - PROCESS | 29830 | |6;imaging-darkroom;146;147;146;147;147;147;147;146;147;146 11:38:06 INFO - PROCESS | 29830 | |7;imaging-desaturate;96;96;97;96;95;95;96;96;96;95 11:38:06 INFO - PROCESS | 29830 | |8;json-parse-financial;53;52;53;51;51;52;51;51;52;52 11:38:06 INFO - PROCESS | 29830 | |9;json-stringify-tinderbox;59;60;59;58;63;59;59;58;62;60 11:38:06 INFO - PROCESS | 29830 | |10;stanford-crypto-aes;77;77;77;77;76;77;77;76;101;77 11:38:06 INFO - PROCESS | 29830 | |11;stanford-crypto-ccm;126;123;118;125;126;126;126;128;125;119 11:38:06 INFO - PROCESS | 29830 | |12;stanford-crypto-pbkdf2;158;157;156;151;158;154;162;160;155;154 11:38:06 INFO - PROCESS | 29830 | |13;stanford-crypto-sha256-iterative;66;63;62;61;64;64;61;61;60;61 11:38:06 INFO - PROCESS | 29830 | __end_tp_report 11:38:06 INFO - PROCESS | 29830 | __start_cc_report 11:38:06 INFO - PROCESS | 29830 | _x_x_mozilla_cycle_collect,874 11:38:06 INFO - PROCESS | 29830 | __end_cc_report 11:38:06 INFO - PROCESS | 29830 | __startTimestamp1469039886525__endTimestamp 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | ------- Summary: start ------- 11:38:06 INFO - PROCESS | 29830 | Number of tests: 14 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.03 11:38:06 INFO - PROCESS | 29830 | Values: 112.0 105.0 111.0 112.0 111.0 110.0 111.0 111.0 110.0 110.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.00 stddev:22.98 (14.9%) stddev-sans-first:24.33 11:38:06 INFO - PROCESS | 29830 | Values: 153.0 125.0 150.0 184.0 128.0 155.0 159.0 127.0 185.0 125.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 11:38:06 INFO - PROCESS | 29830 | Values: 162.0 162.0 163.0 164.0 162.0 163.0 163.0 165.0 162.0 163.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#3] audio-fft Cycles:10 Average:98.00 Median:76.00 stddev:45.39 (59.7%) stddev-sans-first:47.50 11:38:06 INFO - PROCESS | 29830 | Values: 77.0 82.0 74.0 186.0 76.0 77.0 75.0 75.0 182.0 76.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:85.00 stddev:28.68 (33.7%) stddev-sans-first:29.63 11:38:06 INFO - PROCESS | 29830 | Values: 85.0 85.0 144.0 84.0 86.0 86.0 147.0 85.0 89.0 144.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:38:06 INFO - PROCESS | 29830 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 11:38:06 INFO - PROCESS | 29830 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:38:06 INFO - PROCESS | 29830 | Values: 96.0 96.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.79 (1.5%) stddev-sans-first:0.71 11:38:06 INFO - PROCESS | 29830 | Values: 53.0 52.0 53.0 51.0 51.0 52.0 51.0 51.0 52.0 52.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:59.50 stddev:1.64 (2.8%) stddev-sans-first:1.72 11:38:06 INFO - PROCESS | 29830 | Values: 59.0 60.0 59.0 58.0 63.0 59.0 59.0 58.0 62.0 60.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:77.00 stddev:7.67 (10.0%) stddev-sans-first:8.09 11:38:06 INFO - PROCESS | 29830 | Values: 77.0 77.0 77.0 77.0 76.0 77.0 77.0 76.0 101.0 77.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:3.26 (2.6%) stddev-sans-first:3.39 11:38:06 INFO - PROCESS | 29830 | Values: 126.0 123.0 118.0 125.0 126.0 126.0 126.0 128.0 125.0 119.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:157.50 stddev:3.21 (2.0%) stddev-sans-first:3.35 11:38:06 INFO - PROCESS | 29830 | Values: 158.0 157.0 156.0 151.0 158.0 154.0 162.0 160.0 155.0 154.0 11:38:06 INFO - PROCESS | 29830 | 11:38:06 INFO - PROCESS | 29830 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:1.89 (3.0%) stddev-sans-first:1.45 11:38:06 INFO - PROCESS | 29830 | Values: 66.0 63.0 62.0 61.0 64.0 64.0 61.0 61.0 60.0 61.0 11:38:06 INFO - PROCESS | 29830 | -------- Summary: end -------- 11:38:06 INFO - PROCESS | 29830 | 11:38:07 INFO - TEST-INFO | 29830: exit 0 11:38:07 INFO - TEST-OK | kraken | took 61472ms 11:38:07 INFO - SUITE-END | took 1171s 11:38:07 INFO - Completed test suite (00:19:31) 11:38:07 INFO - javascript benchmark 11:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7716.645522053477, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3315.5358249845017, 3359.6976272135503, 3393.457046872501, 3394.575678040245, 3414.6926776590103, 5588.636738611993, 5603.355614104379, 5662.631928924617, 5695.515881150107, 5703.087505999041, 5654.151877218419, 5657.3494048184475, 5671.6880571568545, 5683.403242659523, 5735.369109397963, 5128.333316668837, 5162.936494884406, 5165.04446677364, 5205.349331333583, 5255.421903590602, 5082.949170508285, 5148.099082660538, 5218.112920803473, 5267.736613169345, 5277.340332458442, 5148.742562871841, 5150.7424628768595, 5188.740562971855, 5205.635605507616, 5312.07038768216, 5216.739163041832, 5239.056969745444, 5240.371155461369, 5245.554127899133, 5279.6832190068335, 4956.033573453178, 5076.416212135578, 5148.764296568834, 5165.070287348276, 5227.137522308814, 5528.391876893538, 5562.721863906789, 5594.021046316879, 5609.859753506154, 5651.7739290428335, 6043.365446628129, 6088.543359248074, 6092.847678808021, 6096.268447786294, 6102.908456373158, 5935.258092738408, 5944.10838374243, 6006.888725585781, 6122.173506576644, 6136.20229370179, 5680.11958146488, 5684.573656975702, 5691.943080569183, 5692.487676109128, 5715.199872017921, 6136.447719705158, 6139.907901381483, 6148.9692551536955, 6188.907166392508, 6200.751969921243, 5818.4763371296785, 5838.620489668158, 5847.1229315603, 5916.645001299936, 5923.289205295306, 6028.246469191351, 6059.969700151471, 6060.484858786965, 6072.7570897164505, 6085.361037091042, 6001.609895356788, 6011.759529618854, 6046.606970546901, 6059.091136329498, 6079.787207447718, 5834.591578589458, 5957.046872500466, 5992.520598352121, 6002.669853158118, 6077.392260773887, 4664.090502352009, 4665.2535594304745, 4668.0, 4682.719036857799, 4688.742119183409, 4077.1641813428178, 4133.648639865645, 4174.039970806732, 4180.874573762792, 4211.473565804275, 5580.832575022756, 5724.4561766632105, 5789.044807606698, 5836.562257830679, 5850.678212698257, 6008.66952317618, 6029.155918171459, 6050.394960503914, 6102.8169154924535, 6106.511479081662, 5730.914036289459, 5859.941400586024, 5865.237519122486, 5876.706164691748, 5896.410358964069, 5223.2948551945, 5262.105442074857, 5276.314079169761, 5310.230016647564, 5314.096603577401, 6422.261439934374, 6429.453496452854, 6446.645434501053, 6455.870882582416, 6457.935420645827, 5921.526277897672, 6009.759609615567, 6178.073289006685, 6189.876202476015, 6195.411435913671, 6254.999200127958, 6390.648514331757, 6392.296847346695, 6396.9125248706905, 6406.167198264196, 5947.256592925884, 5996.5502587307, 6014.609050411709, 6020.157177994996, 6022.126791615279, 5837.153612726046, 6050.878982420415, 6108.4807791338235, 6116.3272040076445, 6129.172561704113, 5886.117082437669, 5933.821985340447, 5940.732667030081, 5945.702714864326, 5952.494038006818, 5874.383189765013, 5914.615549989237, 5915.201447804491, 5918.437748413894, 5923.348431672599, 5668.433156684298, 5708.115242137475, 5718.656880587178, 5756.568257380797, 5792.304923409218, 5917.497012753965, 5933.614315069507, 5939.376365481562, 5967.8209653710455, 6006.189164462917, 5786.0, 5822.679752613478, 5829.562782791392, 5839.532837373085, 5839.678817664899], "value": 5602.3438559018105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.1671576508651, 648.0829626079098, 662.7713438863593, 667.0860920538862, 680.9250982391933, 41448.17103657929, 45847.0, 46059.539404605945, 46112.76943615281, 46160.0, 46720.0, 46927.53072469274, 47201.527984720145, 47287.763561182146, 47300.52699473004, 8896.777580560472, 8941.105889411072, 8943.150400711922, 8949.060348663394, 8994.190522852941, 8908.24279936203, 8976.23701985332, 8978.640854365818, 8980.775480613005, 8986.146316099992, 9026.187643112118, 9046.276297896185, 9060.139286767746, 9064.546772661373, 9085.591148398305, 8932.285417166611, 8961.103889611051, 8977.596008179647, 8982.820343593092, 8988.146126118008, 8930.508822014786, 8939.68711095115, 8947.910520894839, 8985.955070224672, 9005.684801031932, 42576.78711606453, 42672.35991460131, 42682.57317426848, 43030.0, 43171.568284317385, 3905.9609403906165, 3917.5494818095713, 4006.599340065999, 4174.853880114181, 4287.699861009731, 34586.0, 34762.30475390503, 34885.476717849255, 35065.649343506746, 35771.82114089413, 4721.291806229059, 4748.5251474852585, 4761.0, 4787.234042553175, 4899.142650036265, 373881.0, 374645.0, 374651.0, 374720.0, 375087.0, 64637.676811616584, 64733.35266647367, 65074.698506029614, 65096.34903650998, 65126.67436662881, 35541.0, 35938.460923086175, 36117.819410902775, 36222.8188859054, 36365.27269454596, 18422.35521756759, 18534.0, 18567.0, 18689.90655046716, 18763.530911727317, 12557.686057848445, 12611.810822837664, 12618.87381126177, 12630.242185468902, 12678.936605316914, 21514.78485215159, 21590.568188636138, 21701.45746356322, 21707.674384883925, 21857.562848742935, 7608.505447146029, 7863.174366691529, 7869.449138560246, 7869.527828330319, 7939.0, 1026.5944951744168, 1143.9199256052163, 1151.0, 1185.7450648110698, 1210.9273443593413, 33109.337813244085, 33130.0, 33433.83283083569, 33816.83091584526, 34141.829290853384, 1179.5753528729651, 1190.3155685480883, 1212.2908098762323, 1270.6632742323293, 1303.6284658872175, 17402.303907843543, 17570.736438953427, 17592.736108958376, 17625.030623315582, 17720.822791772174, 607977.0, 609136.0, 610229.0, 612090.0, 640428.0, 62386.0, 62931.0, 63047.0, 63091.684541577, 63317.68341158265, 1486.301438323986, 1515.371120984779, 1516.052467207995, 1519.323900864127, 1527.5646440764328, 32361.676383235867, 32796.508052378755, 32865.67134328626, 32935.34129317352, 33602.66397336093, 53081.46918530765, 53599.0, 53680.463195369106, 53731.462685372644, 53911.92176156533, 403200.0, 404412.0, 407641.0, 408171.0, 408626.0, 29629.703702963558, 29899.252518687208, 30009.549856751728, 30585.54121688132, 30628.84685576558, 48854.26718599153, 48945.51054489552, 48981.75509122432, 49679.75160124176, 50390.0, 41124.79437602793, 41422.79288603538, 41452.79273603613, 42579.0839412221, 42646.36030459483, 40690.38964415477, 41022.79488602538, 41036.1792764149, 42123.0, 42186.36720449134, 42133.78933105437, 42800.78599606982, 42881.35677964895, 43395.349069763346, 43666.34500482559, 35288.58845646145, 35437.29125417529, 35746.0, 36293.63706362902, 36585.634143659285, 30351.696483034888, 31997.680023200403, 32174.678253218106, 32416.83791581027, 32577.0], "value": 20950.005336154856, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.17841031578104, 422.176755327112, 431.67839959230366, 432.52206312025214, 433.0753840550424, 18789.436316910498, 19651.213951441925, 20685.896570517125, 20687.896560517194, 20766.89616551919, 19407.12667929943, 19717.605647887034, 20100.296489622866, 20791.0, 21020.369388918356, 5696.08862581987, 5863.1791549182935, 5889.705514724268, 5890.204822348992, 5898.439648233411, 5559.249501317311, 5823.0, 5874.73563689635, 5886.676232807194, 5887.88224235515, 5685.147227915804, 5841.269841269841, 5865.794697185599, 5897.705114744245, 5906.734196961147, 6076.665783381913, 6127.234095738033, 6148.0, 6154.230721159833, 6162.722677479479, 5785.392533783935, 5815.244018277639, 5890.175375447441, 5971.462568368867, 5981.192539007222, 14587.0, 14620.926895365561, 14902.776458353024, 16090.597735056717, 24463.26610201697, 2248.4940888300166, 2410.3371572817614, 2413.54142712884, 2452.2275483222907, 2528.494301139761, 10468.94765526175, 10666.946665266702, 10885.401302928336, 11122.721931951684, 11583.768324633544, 1971.6648169811167, 2026.1490174126902, 2047.5904819036252, 2052.374025922093, 2104.905279262437, 90057.54971225167, 92858.53570732103, 93201.0, 93565.0, 94032.52983735106, 11450.484728187252, 11689.532418703327, 11818.704532386588, 11876.218567214813, 11939.164258501994, 16585.50243492697, 16637.251323690463, 16639.916800415922, 16643.41748038813, 16688.165591720364, 8623.267022303175, 8627.6980305689, 8738.475691458532, 8870.42342247752, 8882.111788821067, 8425.95787021061, 8469.153084691605, 8492.363072769567, 8514.57427128641, 8541.786455338543, 4902.3872015998, 5007.073691367109, 5028.421731500851, 5069.555176774602, 5078.415982162025, 2096.9266075687583, 2101.317071951622, 2130.9041093150845, 2136.0, 2165.317924853666, 1019.2966852871494, 1038.314712289885, 1051.2483574244452, 1083.225493771941, 1123.342844436014, 19953.60092798136, 19954.30159944395, 20079.196832126552, 20210.595788084156, 20510.0, 1037.0977249792577, 1038.8909164537765, 1048.5491238767404, 1084.1814430105378, 1086.7446150154708, 10406.635767748092, 11454.828177577343, 11482.94258528702, 11583.478743456397, 11601.419929003516, 487250.0, 492386.0, 528256.0, 533392.0, 533762.0, 100114.0, 100514.49742751385, 102582.48708756408, 102739.0, 103237.48381258045, 1030.0729343590679, 1054.651964851597, 1077.154433769503, 1078.2560033576806, 1082.4263140535686, 17003.319867205173, 18006.90996545009, 18219.90890045541, 18264.295686824116, 18316.633667326314, 42431.3635295477, 42583.36124958066, 44834.775826121964, 45183.0, 45315.773421134, 61214.0, 62834.37165628285, 63198.36801632109, 63814.0, 64536.35463645491, 8820.426672266281, 8977.147171018743, 9034.14175653312, 9040.0, 9376.062393760569, 13026.218426894417, 13336.19982801035, 13358.998075144209, 13386.866131338562, 13450.394732236877, 11061.336319820515, 11851.466683999413, 11951.521939122338, 12099.032077433609, 12249.571265005681, 11660.12549058807, 12032.0, 12224.205426647239, 12380.071494638118, 12435.502579896704, 12287.1399002069, 12409.813852792035, 12470.0, 12516.624501264976, 12549.121561490609, 7673.117591477052, 8194.959025204837, 8310.750677479686, 8448.535330556633, 9125.133112354315, 9311.487868167316, 11988.220765650205, 12237.388130593257, 12352.62942111738, 12480.0], "value": 9618.567658581129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1593.8087429508462, 1631.1110444807578, 1858.739776431299, 1929.3247363422795, 1944.5819148882988, 8475.364347673918, 9294.535273236337, 9312.208462280714, 9982.151517121045, 9983.450910199945, 9520.095590918869, 9791.951040244789, 9867.75330616735, 9874.753131171725, 9889.604415823358, 2502.2618327593405, 2540.491901619674, 2541.8474891506476, 2544.8218624696187, 2545.0964907457865, 2439.9878000609974, 2524.255344673317, 2525.7726804587583, 2527.241827451757, 2531.4177739120014, 2424.5514579802707, 2430.7933825624755, 2433.707955045388, 2434.0, 2434.75652434756, 2408.6989126359204, 2419.358869899469, 2420.1287536486852, 2455.938601534976, 2461.5569197544437, 2393.940151496209, 2399.2442380650214, 2440.0849681369486, 2452.4849781545895, 2456.8894399751875, 9746.756331091708, 9835.803283934352, 9863.112319891172, 9864.556094975671, 9891.604335826558, 5669.603127781057, 5771.855703607402, 5776.913346299809, 5784.248047753807, 5804.738786754606, 3700.703943684499, 3832.9808350958065, 3840.577536470986, 3876.879112314614, 3897.142628621699, 1212.5782668664428, 1227.674666213445, 1250.1936251117977, 1294.954676586315, 1328.9136206146666, 13731.725365492734, 13771.724565508734, 13794.448222071205, 13809.447622095104, 13847.169169849842, 4897.559219670246, 4941.703497790144, 5105.183170692671, 5105.310783044316, 5105.387353517527, 11772.470238839272, 11779.764404711857, 11832.822507662391, 11832.822507662391, 11840.763184736257, 5839.328477225088, 5914.231149950565, 5914.497267732291, 5917.585768996215, 5921.940780592225, 4612.262038073892, 5084.898302033938, 5235.319408476874, 5262.631615786935, 5410.729463526808, 4365.847195348148, 4373.431453910971, 4430.379746835446, 4447.555244475591, 4552.430946131733, 1367.7416776565583, 1371.6570857285678, 1382.523029554802, 1393.4565519447424, 1406.7186562687502, 955.9187469065068, 1060.9787804243872, 1072.3137192197, 1074.3070719385953, 1082.6751974407803, 6407.167068281094, 6579.671016449254, 6613.437857782143, 6618.536702430783, 6668.766593169313, 496.5605439186346, 500.7646406189085, 1094.7372630568766, 1138.4649214868998, 1178.3342411537626, 4490.313054929247, 4522.208613492691, 4686.086213188463, 4697.318888761179, 4766.285057241442, 12291.938540307241, 12550.623481295575, 12553.435095420728, 12558.560450384193, 12598.81101783474, 11747.588834390755, 12156.574519891938, 12172.513099476098, 12498.500059997497, 12506.3121528315, 9149.0, 9294.349395542382, 9322.766930826649, 9334.0, 9398.20115290208, 6461.256955450183, 6647.966760166169, 6716.1604799400075, 6809.148856392951, 6819.352161544645, 11257.774844502901, 11294.0, 11335.376554289593, 11426.82859757121, 11494.482748276181, 11341.26281791681, 11585.0, 11618.593349232737, 11688.357140357022, 11745.823812642646, 7716.7684969451, 8419.95790021046, 8669.6965606206, 8844.380893337662, 9008.41445306053, 9610.855837162588, 9628.951855240679, 9641.903580964381, 9650.469224192737, 9674.274429417681, 8453.408261421642, 8743.0, 8763.518006509703, 8861.91138088611, 8970.192682658591, 8315.875261870955, 8354.0, 8405.201505856934, 8450.154984501502, 8732.738017859474, 7803.492772969739, 7879.881801773093, 7889.566073865993, 7970.322522585645, 7973.242541958504, 5719.742611582572, 5805.581450701173, 5814.30228372598, 5838.416158384128, 6000.939990600038, 5850.5027072699295, 5873.3832947541605, 5886.470217680429, 5933.199018132669, 5976.0], "value": 5131.011680238025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.87614334982743, 354.28788135846946, 354.36568542309266, 362.93467175908324, 369.8428168028587, 5593.860153496154, 5625.465580769831, 5790.363060063395, 5821.941780582193, 5831.795887143956, 5631.099024156136, 5637.943620563793, 5674.574406919487, 5674.687892165929, 5686.31764188298, 4488.775561221926, 4489.753063581502, 4502.932456013163, 4520.97739511302, 4525.570070843265, 4413.514513403523, 4453.465584129909, 4465.0, 4495.9325610115875, 4524.773761311938, 4424.269995450747, 4430.800613972379, 4433.512313645497, 4440.622547083502, 4465.88352911772, 4443.533428989958, 4467.865964021068, 4494.68537202396, 4497.437820272466, 4531.592156705912, 3700.3154416433044, 3906.921861562753, 4046.988252936766, 4050.6354428101317, 4056.0468289951837, 5477.890442191134, 5508.3114610673665, 5511.366192887789, 5525.281713377275, 5535.086710692731, 5090.49095090488, 5094.1594636884865, 5130.486951304877, 5133.255677926717, 5163.122269214243, 5692.345380281279, 5978.671173085479, 6006.369331220247, 6020.4581587656885, 6069.241344831896, 4298.527162012176, 4328.523862375137, 4340.500842403132, 4342.283523218665, 4354.804033818486, 6191.59754615953, 6272.341404152544, 6280.717367718464, 6285.622862628211, 6290.716917738667, 4359.956400436018, 4444.155610434072, 4445.5776701213335, 4460.241758900995, 4466.196084704784, 4503.684742068024, 4523.84166554169, 4532.864014079583, 4537.977310113494, 4553.180427523078, 5090.0, 5107.642465027412, 5127.333446651912, 5163.97418012915, 5217.921731174036, 5808.680522571299, 6037.45662890342, 6045.244344456943, 6049.304330002018, 6075.908861367083, 1541.5067178502773, 1554.4093244566993, 1564.7716542514072, 1565.9899364909797, 1566.9138197399025, 992.3549692699803, 994.3288280410694, 1006.864073350103, 1007.7077647482295, 1011.3577878047493, 5263.6841789492755, 5292.708901010405, 5316.893662126813, 5331.333583302087, 5338.679679219182, 5503.009458297545, 5515.889682206333, 5523.751431185607, 5545.057340252167, 5586.54749765064, 5011.223260394645, 5235.502627250406, 5292.115796890704, 5342.626016178908, 5395.541378982831, 2957.491679243601, 2986.283292009902, 3007.7142671446177, 3012.623422072241, 3017.366353065837, 5637.605367624227, 5656.975321282821, 5762.769489220468, 5768.625039372428, 5795.391483894215, 5541.972290138524, 5566.443355664401, 5626.634268772598, 5639.661620302795, 5653.858653533694, 5714.857028594298, 5744.339400968942, 5803.506701930383, 5818.5636077294375, 5896.9115463268945, 5300.0, 5477.890442191214, 5521.806736764194, 5575.972120139373, 5640.266765320482, 5421.512063914267, 5429.945700543102, 5522.3649280333275, 5532.529734972572, 5534.335879694462, 5660.037793575185, 5677.403872593318, 5703.486686198262, 5744.597878148489, 5768.1636162757, 3900.1419687668667, 4004.6596039336982, 4018.4374187614344, 4048.3117869962766, 4116.547179810159, 5507.504324610804, 5523.944760552504, 5575.275214222125, 6022.126791615104, 6199.939039928854, 6016.0, 6039.033754599419, 6042.848928776816, 6068.969655151696, 6146.416090471398, 6053.727582258721, 6056.697165141637, 6073.514118870568, 6092.745684096913, 6107.725152368065, 5794.62334948227, 5833.82498525045, 5878.647281163144, 5879.382664820132, 5900.347902587282, 6060.39396060408, 6095.664738439251, 6124.335913877478, 6169.352218017223, 6192.606663500676, 5724.742386592697, 5962.940370596239, 6011.669358185167, 6032.517398608188, 6061.454469097803], "value": 4451.487820913151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.4037121231049, 781.6990458673409, 804.7545498622919, 808.1595141053305, 917.348682435471, 16366.672666546661, 16379.508614741577, 16394.426195083175, 16551.586210344747, 17559.736603950936, 16003.759943600855, 16147.596310092253, 16172.191390430491, 16178.514644560653, 16217.351305947777, 716.1549371741343, 829.5147338806805, 853.0531110467407, 857.3141486810526, 865.3682811547574, 860.6729442811722, 864.312871267344, 864.5849992003842, 865.7748985263845, 866.8049688820028, 909.8635204719279, 913.0869130869131, 916.138829500271, 921.8617207418907, 922.3174850610567, 912.3522299167599, 912.8311262416441, 915.729859691386, 916.2898753466051, 918.0268914950141, 668.238208442376, 671.5701950751522, 673.1148539670367, 675.490005046187, 676.736072931557, 16192.75710864338, 16213.189340532927, 16246.675066498721, 16299.674006519921, 16305.91847040769, 13570.0, 14302.785458218135, 14426.495072672406, 14440.350184241734, 14733.631659208499, 13937.233452160128, 14302.92848535761, 14358.282085895664, 14368.353424095942, 14395.928020359832, 4788.9521104788855, 4798.5201479852085, 4860.708357498562, 4878.853634390974, 4991.725455100004, 81264.59367703182, 81346.0, 85839.0, 85958.57020714918, 86274.56862715709, 11638.6508404748, 11771.52913883435, 12039.458224379923, 12347.135700501058, 12673.239605623508, 22093.447663808533, 22186.334409967727, 22202.66695999561, 22222.222222222466, 22246.332610021724, 8554.315654747605, 8610.526421046778, 8738.432001919982, 8767.693130740394, 8834.337424693174, 4904.5340692634145, 4925.187344088257, 5054.292399064134, 5079.4412614612365, 5091.516305950929, 3623.691986181204, 3700.4634328022285, 3716.108134047809, 3726.2174943261675, 3729.9440508392395, 643.0386572074684, 644.0628884972353, 645.9418652321314, 648.7567162314132, 649.8505343770864, 707.7487491940287, 713.165596252386, 761.1475147834461, 761.219749756504, 785.7917651822272, 10130.645427410005, 10735.248532602798, 11113.666590002313, 11147.037706419651, 11395.658130256106, 671.0, 731.1664702239451, 816.1593558634497, 829.9004119505698, 844.2528362399198, 5243.947560524422, 5395.109806881899, 5512.39363669996, 5645.745941432645, 5688.82933511987, 101858.49070754748, 104421.0, 105472.0, 113643.4317828422, 116450.41774791242, 70214.2978570218, 85862.0, 87752.0, 102378.0, 105107.0, 62291.688541557, 65340.67329663321, 92111.53944230235, 94121.0, 97918.0, 11026.669199924016, 11108.611198608332, 11256.887431125584, 11472.598459053894, 11518.0, 54624.45375546194, 55000.0, 55208.17187742107, 55473.72263138658, 57576.1363579555, 78412.0, 80289.59855200686, 82596.58701706454, 82867.5856620713, 83280.0, 13980.0, 14368.784468232776, 14889.284046769846, 14892.255387230813, 15115.093094414371, 16242.51272461828, 16699.749503757695, 16797.74803377926, 17090.74363884518, 17240.827591724425, 15123.924380378028, 15428.0, 15715.371385144466, 16141.112238826978, 16512.834871651612, 15392.769108463606, 15603.921980390025, 15930.0, 15946.122963237134, 15955.760663589823, 15321.923390382977, 15525.922370388076, 15526.689466210839, 15911.204439778196, 15917.920410398337, 11428.0, 11841.763164736829, 12157.331346776013, 12489.37553122322, 13301.733965320833, 12820.589735128942, 13106.541271055466, 13261.33693315311, 13288.867111328764, 13299.335033248106], "value": 8187.623274681315, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 112.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 150.0, 184.0, 128.0, 155.0, 159.0, 127.0, 185.0, 125.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 162.0, 163.0, 163.0, 165.0, 162.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 74.0, 186.0, 76.0, 77.0, 75.0, 75.0, 182.0, 76.0], "value": 98.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 144.0, 84.0, 86.0, 86.0, 147.0, 85.0, 89.0, 144.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 51.0, 51.0, 52.0, 51.0, 51.0, 52.0, 52.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 63.0, 59.0, 59.0, 58.0, 62.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 76.0, 77.0, 77.0, 76.0, 101.0, 77.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 118.0, 125.0, 126.0, 126.0, 126.0, 128.0, 125.0, 119.0], "value": 124.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 156.0, 151.0, 158.0, 154.0, 162.0, 160.0, 155.0, 154.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 62.0, 61.0, 64.0, 64.0, 61.0, 61.0, 60.0, 61.0], "value": 62.3, "unit": "score"}]}]} 11:38:07 INFO - Return code: 0 11:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:07 ERROR - # TBPL SUCCESS # 11:38:07 INFO - Running post-action listener: _resource_record_post_action 11:38:07 INFO - ##### 11:38:07 INFO - ##### Finished run-tests step (success) 11:38:07 INFO - ##### 11:38:07 INFO - Running post-run listener: _resource_record_post_run 11:38:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504266752; Read time: 16; Write time: 432332 11:38:07 INFO - TinderboxPrint: CPU usage
13.5% 11:38:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:38:07 INFO - TinderboxPrint: I/O write bytes / time
504,266,752 / 432,332 11:38:07 INFO - TinderboxPrint: CPU idle
8,208.8 (86.5%) 11:38:07 INFO - TinderboxPrint: CPU user
1,219.2 (12.9%) 11:38:07 INFO - TinderboxPrint: Swap in / out
0 / 0 11:38:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258920448; Read time: 0; Write time: 275196 11:38:07 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 245346304; Read time: 16; Write time: 157136 11:38:08 INFO - Running post-run listener: _upload_blobber_files 11:38:08 INFO - Blob upload gear active. 11:38:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:08 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 11:38:08 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'] 11:38:08 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 11:38:08 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:38:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:38:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:09 INFO - (blobuploader) - INFO - Done attempting. 11:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:37 INFO - (blobuploader) - INFO - Done attempting. 11:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:38:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:38 INFO - (blobuploader) - INFO - Done attempting. 11:38:38 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:38 INFO - Return code: 0 11:38:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c7833714e329efcbb172d3f2493c97030254168875cd6d5c5516e87bdc590fa315a4bf32b6ba55c696ebf02ae8c53980f398864d4f8c489415f6f71a2c004e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ac6489a5c2e7abcc672f94d53683104c472585e09aa117202c2b67a74322ddb05fd641d4d6da5e7cd8d00bd89f752fd6c0f3e648d6dd0dd66eebf409728c7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0afe5b43a5aa8747164823aac38a54e77ddd406ecf2c08c40a720f88d5840284471b41d9184f8fed6bb1be346f094c0109e4e750167676c56362bafae1cb0d"} 11:38:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:38 INFO - Contents: 11:38:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5c7833714e329efcbb172d3f2493c97030254168875cd6d5c5516e87bdc590fa315a4bf32b6ba55c696ebf02ae8c53980f398864d4f8c489415f6f71a2c004e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ac6489a5c2e7abcc672f94d53683104c472585e09aa117202c2b67a74322ddb05fd641d4d6da5e7cd8d00bd89f752fd6c0f3e648d6dd0dd66eebf409728c7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0afe5b43a5aa8747164823aac38a54e77ddd406ecf2c08c40a720f88d5840284471b41d9184f8fed6bb1be346f094c0109e4e750167676c56362bafae1cb0d"} 11:38:38 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:38 INFO - Copying logs to upload dir... 11:38:38 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.508491 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-20 11:38:38.357633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 11:38:38.361787) ========= 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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 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/5c7833714e329efcbb172d3f2493c97030254168875cd6d5c5516e87bdc590fa315a4bf32b6ba55c696ebf02ae8c53980f398864d4f8c489415f6f71a2c004e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ac6489a5c2e7abcc672f94d53683104c472585e09aa117202c2b67a74322ddb05fd641d4d6da5e7cd8d00bd89f752fd6c0f3e648d6dd0dd66eebf409728c7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0afe5b43a5aa8747164823aac38a54e77ddd406ecf2c08c40a720f88d5840284471b41d9184f8fed6bb1be346f094c0109e4e750167676c56362bafae1cb0d"} build_url:https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/IyLF0G-CRBysJH6fxwCGRw/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/5c7833714e329efcbb172d3f2493c97030254168875cd6d5c5516e87bdc590fa315a4bf32b6ba55c696ebf02ae8c53980f398864d4f8c489415f6f71a2c004e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ac6489a5c2e7abcc672f94d53683104c472585e09aa117202c2b67a74322ddb05fd641d4d6da5e7cd8d00bd89f752fd6c0f3e648d6dd0dd66eebf409728c7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa0afe5b43a5aa8747164823aac38a54e77ddd406ecf2c08c40a720f88d5840284471b41d9184f8fed6bb1be346f094c0109e4e750167676c56362bafae1cb0d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 11:38:38.387646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:38:38.388039) ========= 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=d2a8c569965ab8367867b893000001a1-1469038661.758831-1766767681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 11:38:38.473506) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 11:38:38.473843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 11:38:38.474170) ========= ========= Total master_lag: 0.17 =========