builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1470333054.19 results: success (0) buildid: 20160804080440 builduid: d556f7e28eba44a1b558f1303d642fc8 revision: 6106148d2caa25c93134c88d20f00c4a62e91715 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.186235) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.186611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.186881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.205059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.205314) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:50:54-- 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% 224M=0s 2016-08-04 10:50:54 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.294174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.294467) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015384 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.344254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.344569) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6106148d2caa25c93134c88d20f00c4a62e91715 --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-beta --rev 6106148d2caa25c93134c88d20f00c4a62e91715 --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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:50:54,550 truncating revision to first 12 chars 2016-08-04 10:50:54,550 Setting DEBUG logging. 2016-08-04 10:50:54,550 attempt 1/10 2016-08-04 10:50:54,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6106148d2caa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:50:54,873 unpacking tar archive at: mozilla-beta-6106148d2caa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636861 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.995741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.996090) ========= script_repo_revision: 6106148d2caa25c93134c88d20f00c4a62e91715 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.996644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:54.996918) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:55.007240) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-04 10:50:55.007679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:55 INFO - MultiFileLogger online at 20160804 10:50:55 in /builds/slave/test 10:50:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:50:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:55 INFO - {'append_to_log': False, 10:50:55 INFO - 'base_work_dir': '/builds/slave/test', 10:50:55 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:50:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:55 INFO - 'branch': 'Mozilla-Beta', 10:50:55 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:55 INFO - 'config_files': ('talos/linux_config.py',), 10:50:55 INFO - 'default_actions': ('clobber', 10:50:55 INFO - 'read-buildbot-config', 10:50:55 INFO - 'download-and-extract', 10:50:55 INFO - 'populate-webroot', 10:50:55 INFO - 'create-virtualenv', 10:50:55 INFO - 'install', 10:50:55 INFO - 'run-tests'), 10:50:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:55 INFO - 'download_minidump_stackwalk': True, 10:50:55 INFO - 'download_symbols': 'ondemand', 10:50:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:55 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:55 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:55 INFO - 'installer_path': 'installer.exe', 10:50:55 INFO - 'log_level': 'info', 10:50:55 INFO - 'log_name': 'talos', 10:50:55 INFO - 'log_to_console': True, 10:50:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:55 INFO - 'opt_config_files': (), 10:50:55 INFO - 'pip_index': False, 10:50:55 INFO - 'sps_profile': False, 10:50:55 INFO - 'sps_profile_interval': 0, 10:50:55 INFO - 'suite': 'dromaeojs-e10s', 10:50:55 INFO - 'system_bits': '32', 10:50:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:55 INFO - 'title': 'talos-linux64-ix-067', 10:50:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:55 INFO - 'use_talos_json': True, 10:50:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:55 INFO - 'work_dir': 'build'} 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running clobber step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: clobber 10:50:55 INFO - rmtree: /builds/slave/test/build 10:50:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - ##### 10:50:55 INFO - ##### Finished clobber step (success) 10:50:55 INFO - ##### 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running read-buildbot-config step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: read_buildbot_config 10:50:55 INFO - Using buildbot properties: 10:50:55 INFO - { 10:50:55 INFO - "project": "", 10:50:55 INFO - "product": "firefox", 10:50:55 INFO - "script_repo_revision": "production", 10:50:55 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:50:55 INFO - "repository": "", 10:50:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 10:50:55 INFO - "buildid": "20160804080440", 10:50:55 INFO - "pgo_build": "True", 10:50:55 INFO - "basedir": "/builds/slave/test", 10:50:55 INFO - "buildnumber": 198, 10:50:55 INFO - "slavename": "talos-linux64-ix-067", 10:50:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:50:55 INFO - "platform": "ubuntu64_hw", 10:50:55 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 10:50:55 INFO - "branch": "mozilla-beta", 10:50:55 INFO - "repo_path": "releases/mozilla-beta", 10:50:55 INFO - "revision": "6106148d2caa25c93134c88d20f00c4a62e91715", 10:50:55 INFO - "stage_platform": "linux64-pgo", 10:50:55 INFO - "builduid": "d556f7e28eba44a1b558f1303d642fc8", 10:50:55 INFO - "slavebuilddir": "test" 10:50:55 INFO - } 10:50:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - ##### 10:50:55 INFO - ##### Finished read-buildbot-config step (success) 10:50:55 INFO - ##### 10:50:55 INFO - ##### 10:50:55 INFO - ##### Running download-and-extract step. 10:50:55 INFO - ##### 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: download_and_extract 10:50:55 INFO - mkdir: /builds/slave/test/build/tests 10:50:55 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')]} 10:50:55 INFO - https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:50:56 INFO - Downloaded 1327 bytes. 10:50:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 10:50:56 INFO - Using the following test package requirements: 10:50:56 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:56 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:56 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 10:50:56 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'jsshell-linux-x86_64.zip'], 10:50:56 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:56 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 10:50:56 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 10:50:56 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 10:50:56 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:56 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:56 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50: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')]} 10:50:56 INFO - https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:58 INFO - Downloaded 21968359 bytes. 10:50:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:59 INFO - Return code: 0 10:50:59 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:50: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')]} 10:50:59 INFO - https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:50:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 10:50:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:00 INFO - Downloaded 21968359 bytes. 10:51:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:51:02 INFO - Return code: 0 10:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:02 INFO - https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 10:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:51:03 INFO - Downloaded 10833369 bytes. 10:51:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:51:03 INFO - Return code: 0 10:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:03 INFO - https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:51:08 INFO - Downloaded 55289469 bytes. 10:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:51:08 INFO - mkdir: /builds/slave/test/properties 10:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:08 INFO - Contents: 10:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 10:51:08 INFO - Running post-action listener: _resource_record_post_action 10:51:08 INFO - Running post-action listener: set_extra_try_arguments 10:51:08 INFO - ##### 10:51:08 INFO - ##### Finished download-and-extract step (success) 10:51:08 INFO - ##### 10:51:08 INFO - ##### 10:51:08 INFO - ##### Running populate-webroot step. 10:51:08 INFO - ##### 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: populate_webroot 10:51:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:08 INFO - '--tppagecycles', 10:51:08 INFO - '7'], 10:51:08 INFO - 'tests': ['tsvgm']}}, 10:51:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['damp', 'tps']}, 10:51:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'tests': ['damp', 'tps']}, 10:51:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['dromaeo_dom']}, 10:51:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['a11yr', 10:51:08 INFO - 'ts_paint', 10:51:08 INFO - 'tpaint', 10:51:08 INFO - 'sessionrestore', 10:51:08 INFO - 'sessionrestore_no_auto_restore', 10:51:08 INFO - 'tabpaint']}, 10:51:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['tsvgx', 10:51:08 INFO - 'tsvgr_opacity', 10:51:08 INFO - 'tart', 10:51:08 INFO - 'tscrollx', 10:51:08 INFO - 'cart']}, 10:51:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:08 INFO - 'tsvgr_opacity', 10:51:08 INFO - 'tart', 10:51:08 INFO - 'tscrollx', 10:51:08 INFO - 'cart']}, 10:51:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'talos_options': ['--disable-e10s'], 10:51:08 INFO - 'tests': ['tp5o']}, 10:51:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'tests': ['tp5o']}, 10:51:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'talos_options': ['--disable-e10s', 10:51:08 INFO - '--xperf_path', 10:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:08 INFO - 'tests': ['tp5n']}, 10:51:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:08 INFO - 'talos_options': ['--xperf_path', 10:51:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:08 INFO - 'tests': ['tp5n']}}, 10:51:08 INFO - 'talos.zip': {'path': '', 10:51:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:08 INFO - Running post-action listener: _resource_record_post_action 10:51:08 INFO - ##### 10:51:08 INFO - ##### Finished populate-webroot step (success) 10:51:08 INFO - ##### 10:51:08 INFO - ##### 10:51:08 INFO - ##### Running create-virtualenv step. 10:51:08 INFO - ##### 10:51:08 INFO - Running pre-action listener: _resource_record_pre_action 10:51:08 INFO - Running main action method: create_virtualenv 10:51:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:08 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 10:51:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:08 INFO - Using real prefix '/usr' 10:51:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:11 INFO - Installing pip.................done. 10:51:11 INFO - Return code: 0 10:51:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:11 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 10:51:11 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 10:51:11 INFO - Using env: {'DISPLAY': ':0', 10:51:11 INFO - 'HOME': '/home/cltbld', 10:51:11 INFO - 'LANG': 'en_US.UTF-8', 10:51:11 INFO - 'LANGUAGE': 'en_US:en', 10:51:11 INFO - 'LOGNAME': 'cltbld', 10:51:11 INFO - 'MAIL': '/var/mail/cltbld', 10:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:11 INFO - 'MOZ_NO_REMOTE': '1', 10:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:11 INFO - 'NO_EM_RESTART': '1', 10:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:11 INFO - 'PWD': '/builds/slave/test', 10:51:11 INFO - 'SHELL': '/bin/bash', 10:51:11 INFO - 'SHLVL': '1', 10:51:11 INFO - 'TERM': 'linux', 10:51:11 INFO - 'TMOUT': '86400', 10:51:11 INFO - 'USER': 'cltbld', 10:51:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:11 INFO - '_': '/tools/buildbot/bin/python'} 10:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:11 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 10:51:11 INFO - Cleaning up... 10:51:11 INFO - Return code: 0 10:51:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:11 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:11 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 10:51:11 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 10:51:11 INFO - Using env: {'DISPLAY': ':0', 10:51:11 INFO - 'HOME': '/home/cltbld', 10:51:11 INFO - 'LANG': 'en_US.UTF-8', 10:51:11 INFO - 'LANGUAGE': 'en_US:en', 10:51:11 INFO - 'LOGNAME': 'cltbld', 10:51:11 INFO - 'MAIL': '/var/mail/cltbld', 10:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:11 INFO - 'MOZ_NO_REMOTE': '1', 10:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:11 INFO - 'NO_EM_RESTART': '1', 10:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:11 INFO - 'PWD': '/builds/slave/test', 10:51:11 INFO - 'SHELL': '/bin/bash', 10:51:11 INFO - 'SHLVL': '1', 10:51:11 INFO - 'TERM': 'linux', 10:51:11 INFO - 'TMOUT': '86400', 10:51:11 INFO - 'USER': 'cltbld', 10:51:11 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:11 INFO - '_': '/tools/buildbot/bin/python'} 10:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:11 INFO - Downloading/unpacking psutil>=3.1.1 10:51:11 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 10:51:11 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 10:51:11 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 10:51:11 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 10:51:11 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 10:51:11 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 10:51:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:13 INFO - Installing collected packages: psutil 10:51:13 INFO - Running setup.py install for psutil 10:51:13 INFO - building 'psutil._psutil_linux' extension 10:51:13 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 10:51:14 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 10:51:14 INFO - building 'psutil._psutil_posix' extension 10:51:14 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 10:51:14 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 10:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:14 INFO - Successfully installed psutil 10:51:14 INFO - Cleaning up... 10:51:14 INFO - Return code: 0 10:51:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:51:14 INFO - Using env: {'DISPLAY': ':0', 10:51:14 INFO - 'HOME': '/home/cltbld', 10:51:14 INFO - 'LANG': 'en_US.UTF-8', 10:51:14 INFO - 'LANGUAGE': 'en_US:en', 10:51:14 INFO - 'LOGNAME': 'cltbld', 10:51:14 INFO - 'MAIL': '/var/mail/cltbld', 10:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:14 INFO - 'MOZ_NO_REMOTE': '1', 10:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:14 INFO - 'NO_EM_RESTART': '1', 10:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:14 INFO - 'PWD': '/builds/slave/test', 10:51:14 INFO - 'SHELL': '/bin/bash', 10:51:14 INFO - 'SHLVL': '1', 10:51:14 INFO - 'TERM': 'linux', 10:51:14 INFO - 'TMOUT': '86400', 10:51:14 INFO - 'USER': 'cltbld', 10:51:14 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:14 INFO - '_': '/tools/buildbot/bin/python'} 10:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:16 INFO - Installing collected packages: mozsystemmonitor 10:51:16 INFO - Running setup.py install for mozsystemmonitor 10:51:16 INFO - Successfully installed mozsystemmonitor 10:51:16 INFO - Cleaning up... 10:51:16 INFO - Return code: 0 10:51:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:16 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')]} 10:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 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')]} 10:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:16 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:16 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 10:51:16 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 10:51:16 INFO - Using env: {'DISPLAY': ':0', 10:51:16 INFO - 'HOME': '/home/cltbld', 10:51:16 INFO - 'LANG': 'en_US.UTF-8', 10:51:16 INFO - 'LANGUAGE': 'en_US:en', 10:51:16 INFO - 'LOGNAME': 'cltbld', 10:51:16 INFO - 'MAIL': '/var/mail/cltbld', 10:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:16 INFO - 'MOZ_NO_REMOTE': '1', 10:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:16 INFO - 'NO_EM_RESTART': '1', 10:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:16 INFO - 'PWD': '/builds/slave/test', 10:51:16 INFO - 'SHELL': '/bin/bash', 10:51:16 INFO - 'SHLVL': '1', 10:51:16 INFO - 'TERM': 'linux', 10:51:16 INFO - 'TMOUT': '86400', 10:51:16 INFO - 'USER': 'cltbld', 10:51:16 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:16 INFO - '_': '/tools/buildbot/bin/python'} 10:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:16 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 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 10:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:19 INFO - warning: no files found matching '*.txt' 10:51:19 INFO - no previously-included directories found matching 'build' 10:51:19 INFO - no previously-included directories found matching 'dist' 10:51:19 INFO - no previously-included directories found matching '.git*' 10:51:19 INFO - Installing collected packages: jsonschema, functools32 10:51:19 INFO - Running setup.py install for functools32 10:51:19 INFO - warning: no files found matching '*.txt' 10:51:19 INFO - no previously-included directories found matching 'build' 10:51:19 INFO - no previously-included directories found matching 'dist' 10:51:19 INFO - no previously-included directories found matching '.git*' 10:51:19 INFO - Successfully installed jsonschema functools32 10:51:19 INFO - Cleaning up... 10:51:19 INFO - Return code: 0 10:51:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:51:19 INFO - Using env: {'DISPLAY': ':0', 10:51:19 INFO - 'HOME': '/home/cltbld', 10:51:19 INFO - 'LANG': 'en_US.UTF-8', 10:51:19 INFO - 'LANGUAGE': 'en_US:en', 10:51:19 INFO - 'LOGNAME': 'cltbld', 10:51:19 INFO - 'MAIL': '/var/mail/cltbld', 10:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:19 INFO - 'MOZ_NO_REMOTE': '1', 10:51:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:19 INFO - 'NO_EM_RESTART': '1', 10:51:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:19 INFO - 'PWD': '/builds/slave/test', 10:51:19 INFO - 'SHELL': '/bin/bash', 10:51:19 INFO - 'SHLVL': '1', 10:51:19 INFO - 'TERM': 'linux', 10:51:19 INFO - 'TMOUT': '86400', 10:51:19 INFO - 'USER': 'cltbld', 10:51:19 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:19 INFO - '_': '/tools/buildbot/bin/python'} 10:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:21 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 10:51:22 INFO - Downloading docopt-0.6.1.tar.gz 10:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:22 INFO - Running setup.py install for blobuploader 10:51:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:22 INFO - Running setup.py install for requests 10:51:22 INFO - Running setup.py install for docopt 10:51:22 INFO - Successfully installed blobuploader requests docopt 10:51:22 INFO - Cleaning up... 10:51:22 INFO - Return code: 0 10:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:22 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:22 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 10:51:22 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 10:51:22 INFO - Using env: {'DISPLAY': ':0', 10:51:22 INFO - 'HOME': '/home/cltbld', 10:51:22 INFO - 'LANG': 'en_US.UTF-8', 10:51:22 INFO - 'LANGUAGE': 'en_US:en', 10:51:22 INFO - 'LOGNAME': 'cltbld', 10:51:22 INFO - 'MAIL': '/var/mail/cltbld', 10:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:22 INFO - 'MOZ_NO_REMOTE': '1', 10:51:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:22 INFO - 'NO_EM_RESTART': '1', 10:51:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:22 INFO - 'PWD': '/builds/slave/test', 10:51:22 INFO - 'SHELL': '/bin/bash', 10:51:22 INFO - 'SHLVL': '1', 10:51:22 INFO - 'TERM': 'linux', 10:51:22 INFO - 'TMOUT': '86400', 10:51:22 INFO - 'USER': 'cltbld', 10:51:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:22 INFO - '_': '/tools/buildbot/bin/python'} 10:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:22 INFO - Running setup.py (path:/tmp/pip-PMezSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:22 INFO - Running setup.py (path:/tmp/pip-bciZE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:23 INFO - Running setup.py (path:/tmp/pip-cYgJB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:23 INFO - Running setup.py (path:/tmp/pip-JGy8Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:23 INFO - Running setup.py (path:/tmp/pip-Gpfqat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:23 INFO - Running setup.py (path:/tmp/pip-WnAE0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:23 INFO - Running setup.py (path:/tmp/pip-9xQUtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:23 INFO - Running setup.py (path:/tmp/pip-RjGwIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:23 INFO - Running setup.py (path:/tmp/pip-C3C3xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:23 INFO - Running setup.py (path:/tmp/pip-32fMcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:23 INFO - Running setup.py (path:/tmp/pip-p5QZjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:23 INFO - Running setup.py (path:/tmp/pip-ix7753-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:23 INFO - Running setup.py (path:/tmp/pip-PO9I2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:23 INFO - Running setup.py (path:/tmp/pip-BYYBsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:23 INFO - Running setup.py (path:/tmp/pip-QYEQUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:24 INFO - Running setup.py (path:/tmp/pip-9Xz8Yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:24 INFO - Running setup.py (path:/tmp/pip-BoxWK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:24 INFO - Running setup.py install for manifestparser 10:51:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Running setup.py install for mozcrash 10:51:24 INFO - Running setup.py install for mozdebug 10:51:24 INFO - Running setup.py install for mozdevice 10:51:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Running setup.py install for mozfile 10:51:24 INFO - Running setup.py install for mozhttpd 10:51:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Running setup.py install for mozinfo 10:51:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Running setup.py install for mozInstall 10:51:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:24 INFO - Running setup.py install for mozleak 10:51:25 INFO - Running setup.py install for mozlog 10:51:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for moznetwork 10:51:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for mozprocess 10:51:25 INFO - Running setup.py install for mozprofile 10:51:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for mozrunner 10:51:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for mozscreenshot 10:51:25 INFO - Running setup.py install for moztest 10:51:25 INFO - Running setup.py install for mozversion 10:51:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:25 INFO - Cleaning up... 10:51:25 INFO - Return code: 0 10:51:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:25 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')]} 10:51:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 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')]} 10:51:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:25 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:25 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 10:51:25 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 10:51:25 INFO - Using env: {'DISPLAY': ':0', 10:51:25 INFO - 'HOME': '/home/cltbld', 10:51:25 INFO - 'LANG': 'en_US.UTF-8', 10:51:25 INFO - 'LANGUAGE': 'en_US:en', 10:51:25 INFO - 'LOGNAME': 'cltbld', 10:51:25 INFO - 'MAIL': '/var/mail/cltbld', 10:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:25 INFO - 'MOZ_NO_REMOTE': '1', 10:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:25 INFO - 'NO_EM_RESTART': '1', 10:51:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:25 INFO - 'PWD': '/builds/slave/test', 10:51:25 INFO - 'SHELL': '/bin/bash', 10:51:25 INFO - 'SHLVL': '1', 10:51:25 INFO - 'TERM': 'linux', 10:51:25 INFO - 'TMOUT': '86400', 10:51:25 INFO - 'USER': 'cltbld', 10:51:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:25 INFO - '_': '/tools/buildbot/bin/python'} 10:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:26 INFO - Running setup.py (path:/tmp/pip-wfEaFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:26 INFO - Running setup.py (path:/tmp/pip-mRN_Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:26 INFO - Running setup.py (path:/tmp/pip-Au8Ez1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:26 INFO - Running setup.py (path:/tmp/pip-nEZr9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:26 INFO - Running setup.py (path:/tmp/pip-cyf0V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:26 INFO - Running setup.py (path:/tmp/pip-2mzp9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:26 INFO - Running setup.py (path:/tmp/pip-3mUCGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:26 INFO - Running setup.py (path:/tmp/pip-VBQvRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:26 INFO - Running setup.py (path:/tmp/pip-E2Pso1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:26 INFO - Running setup.py (path:/tmp/pip-ARSAqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:26 INFO - Running setup.py (path:/tmp/pip-JlcBl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:26 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)) 10:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:26 INFO - Running setup.py (path:/tmp/pip-siJ0hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:27 INFO - Running setup.py (path:/tmp/pip-PMcMpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:27 INFO - Running setup.py (path:/tmp/pip-rk_X60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:27 INFO - Running setup.py (path:/tmp/pip-D504bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:27 INFO - Running setup.py (path:/tmp/pip-MK_OvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:27 INFO - Running setup.py (path:/tmp/pip-6PLBwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:27 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)) 10:51:27 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)) 10:51:27 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)) 10:51:27 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)) 10:51:27 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)) 10:51:27 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)) 10:51:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:27 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 10:51:27 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 10:51:27 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 10:51:27 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 10:51:27 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 10:51:27 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 10:51:29 INFO - Downloading blessings-1.6.tar.gz 10:51:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:29 INFO - Installing collected packages: blessings 10:51:29 INFO - Running setup.py install for blessings 10:51:29 INFO - Successfully installed blessings 10:51:29 INFO - Cleaning up... 10:51:29 INFO - Return code: 0 10:51:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:29 INFO - Reading from file tmpfile_stdout 10:51:29 INFO - Current package versions: 10:51:29 INFO - argparse == 1.2.1 10:51:29 INFO - blessings == 1.6 10:51:29 INFO - blobuploader == 1.2.4 10:51:29 INFO - docopt == 0.6.1 10:51:29 INFO - functools32 == 3.2.3-2 10:51:29 INFO - jsonschema == 2.5.1 10:51:29 INFO - manifestparser == 1.1 10:51:29 INFO - mozInstall == 1.12 10:51:29 INFO - mozcrash == 0.17 10:51:29 INFO - mozdebug == 0.1 10:51:29 INFO - mozdevice == 0.48 10:51:29 INFO - mozfile == 1.2 10:51:29 INFO - mozhttpd == 0.7 10:51:29 INFO - mozinfo == 0.9 10:51:29 INFO - mozleak == 0.1 10:51:29 INFO - mozlog == 3.2 10:51:29 INFO - moznetwork == 0.27 10:51:29 INFO - mozprocess == 0.23 10:51:29 INFO - mozprofile == 0.28 10:51:29 INFO - mozrunner == 6.12 10:51:29 INFO - mozscreenshot == 0.1 10:51:29 INFO - mozsystemmonitor == 0.3 10:51:29 INFO - moztest == 0.7 10:51:29 INFO - mozversion == 1.4 10:51:29 INFO - psutil == 3.1.1 10:51:29 INFO - requests == 1.2.3 10:51:29 INFO - wsgiref == 0.1.2 10:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:29 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 10:51:29 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 10:51:29 INFO - Using env: {'DISPLAY': ':0', 10:51:29 INFO - 'HOME': '/home/cltbld', 10:51:29 INFO - 'LANG': 'en_US.UTF-8', 10:51:29 INFO - 'LANGUAGE': 'en_US:en', 10:51:29 INFO - 'LOGNAME': 'cltbld', 10:51:29 INFO - 'MAIL': '/var/mail/cltbld', 10:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:29 INFO - 'MOZ_NO_REMOTE': '1', 10:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:29 INFO - 'NO_EM_RESTART': '1', 10:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:29 INFO - 'PWD': '/builds/slave/test', 10:51:29 INFO - 'SHELL': '/bin/bash', 10:51:29 INFO - 'SHLVL': '1', 10:51:29 INFO - 'TERM': 'linux', 10:51:29 INFO - 'TMOUT': '86400', 10:51:29 INFO - 'USER': 'cltbld', 10:51:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:29 INFO - '_': '/tools/buildbot/bin/python'} 10:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 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)) 10:51:29 INFO - Cleaning up... 10:51:29 INFO - Return code: 0 10:51:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:29 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:29 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 10:51:29 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 10:51:29 INFO - Using env: {'DISPLAY': ':0', 10:51:29 INFO - 'HOME': '/home/cltbld', 10:51:29 INFO - 'LANG': 'en_US.UTF-8', 10:51:29 INFO - 'LANGUAGE': 'en_US:en', 10:51:29 INFO - 'LOGNAME': 'cltbld', 10:51:29 INFO - 'MAIL': '/var/mail/cltbld', 10:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:29 INFO - 'MOZ_NO_REMOTE': '1', 10:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:29 INFO - 'NO_EM_RESTART': '1', 10:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:29 INFO - 'PWD': '/builds/slave/test', 10:51:29 INFO - 'SHELL': '/bin/bash', 10:51:29 INFO - 'SHLVL': '1', 10:51:29 INFO - 'TERM': 'linux', 10:51:29 INFO - 'TMOUT': '86400', 10:51:29 INFO - 'USER': 'cltbld', 10:51:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:29 INFO - '_': '/tools/buildbot/bin/python'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:30 INFO - Cleaning up... 10:51:30 INFO - Return code: 0 10:51:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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 0x7f533f30ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25598a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2624350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', '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 10:51:30 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 10:51:30 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 10:51:30 INFO - Using env: {'DISPLAY': ':0', 10:51:30 INFO - 'HOME': '/home/cltbld', 10:51:30 INFO - 'LANG': 'en_US.UTF-8', 10:51:30 INFO - 'LANGUAGE': 'en_US:en', 10:51:30 INFO - 'LOGNAME': 'cltbld', 10:51:30 INFO - 'MAIL': '/var/mail/cltbld', 10:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:30 INFO - 'MOZ_NO_REMOTE': '1', 10:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:30 INFO - 'NO_EM_RESTART': '1', 10:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:30 INFO - 'PWD': '/builds/slave/test', 10:51:30 INFO - 'SHELL': '/bin/bash', 10:51:30 INFO - 'SHLVL': '1', 10:51:30 INFO - 'TERM': 'linux', 10:51:30 INFO - 'TMOUT': '86400', 10:51:30 INFO - 'USER': 'cltbld', 10:51:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:30 INFO - '_': '/tools/buildbot/bin/python'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 INFO - Downloading/unpacking flake8 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:51:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:51:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 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 10:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:33 INFO - no previously-included directories found matching 'docs/_build' 10:51:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:51:33 INFO - Running setup.py install for pep8 10:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:51:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:51:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:51:33 INFO - no previously-included directories found matching 'docs/_build' 10:51:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:51:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:51:33 INFO - Cleaning up... 10:51:33 INFO - Return code: 0 10:51:33 INFO - Running post-action listener: _resource_record_post_action 10:51:33 INFO - Running post-action listener: _start_resource_monitoring 10:51:33 INFO - Starting resource monitoring. 10:51:33 INFO - ##### 10:51:33 INFO - ##### Finished create-virtualenv step (success) 10:51:33 INFO - ##### 10:51:33 INFO - ##### 10:51:33 INFO - ##### Running install step. 10:51:33 INFO - ##### 10:51:33 INFO - Running pre-action listener: _resource_record_pre_action 10:51:33 INFO - Running main action method: install 10:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:33 INFO - Reading from file tmpfile_stdout 10:51:33 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:33 INFO - Reading from file tmpfile_stdout 10:51:33 INFO - Output received: 10:51:33 INFO - Usage: mozinstall [options] installer 10:51:33 INFO - Options: 10:51:33 INFO - -h, --help show this help message and exit 10:51:33 INFO - -d DEST, --destination=DEST 10:51:33 INFO - Directory to install application into. [default: 10:51:33 INFO - "/builds/slave/test"] 10:51:33 INFO - --app=APP Application being installed. [default: firefox] 10:51:33 INFO - mkdir: /builds/slave/test/build/application 10:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:51:46 INFO - Reading from file tmpfile_stdout 10:51:46 INFO - Output received: 10:51:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:51:46 INFO - Running post-action listener: _resource_record_post_action 10:51:46 INFO - ##### 10:51:46 INFO - ##### Finished install step (success) 10:51:46 INFO - ##### 10:51:46 INFO - ##### 10:51:46 INFO - ##### Running run-tests step. 10:51:46 INFO - ##### 10:51:46 INFO - Running pre-action listener: _resource_record_pre_action 10:51:46 INFO - Running main action method: run_tests 10:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:46 INFO - Python 2.7.3 10:51:46 INFO - Return code: 0 10:51:46 INFO - grabbing minidump binary from tooltool 10:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:51:46 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 0x26b31c0>, '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 0x26b40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:46 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 10:51:46 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 10:51:46 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 10:51:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:46 INFO - Return code: 0 10:51:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:51:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:51:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:51:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:51:47 INFO - Return code: 0 10:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 10:51:47 INFO - Using env: {'DISPLAY': ':0', 10:51:47 INFO - 'HOME': '/home/cltbld', 10:51:47 INFO - 'LANG': 'en_US.UTF-8', 10:51:47 INFO - 'LANGUAGE': 'en_US:en', 10:51:47 INFO - 'LOGNAME': 'cltbld', 10:51:47 INFO - 'MAIL': '/var/mail/cltbld', 10:51:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:47 INFO - 'MOZ_NO_REMOTE': '1', 10:51:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:47 INFO - 'NO_EM_RESTART': '1', 10:51:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:47 INFO - 'PWD': '/builds/slave/test', 10:51:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:47 INFO - 'SHELL': '/bin/bash', 10:51:47 INFO - 'SHLVL': '1', 10:51:47 INFO - 'TERM': 'linux', 10:51:47 INFO - 'TMOUT': '86400', 10:51:47 INFO - 'USER': 'cltbld', 10:51:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953', 10:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:47 INFO - '_': '/tools/buildbot/bin/python'} 10:51:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:51:47 INFO - mozversion application_buildid: 20160804080440 10:51:47 INFO - mozversion application_changeset: 6106148d2caa25c93134c88d20f00c4a62e91715 10:51:47 INFO - mozversion application_display_name: Firefox 10:51:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:47 INFO - mozversion application_name: Firefox 10:51:47 INFO - mozversion application_remotingname: firefox 10:51:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:51:47 INFO - mozversion application_vendor: Mozilla 10:51:47 INFO - mozversion application_version: 49.0 10:51:47 INFO - mozversion platform_buildid: 20160804080440 10:51:47 INFO - mozversion platform_changeset: 6106148d2caa25c93134c88d20f00c4a62e91715 10:51:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:51:47 INFO - mozversion platform_version: 49.0 10:51:47 INFO - using testdate: 1470333107 10:51:47 INFO - actual date: 1470333107 10:51:47 INFO - starting webserver on 'localhost:35398' 10:51:47 INFO - SUITE-START | Running 2 tests 10:51:47 INFO - TEST-START | dromaeo_css 10:51:47 INFO - operating with platform_type : linux_ 10:51:47 INFO - Initialising browser for dromaeo_css test... 10:51:47 INFO - TEST-INFO | started process 28208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNj9icO/profile http://localhost:35398/getInfo.html) 10:51:52 INFO - PROCESS | 28208 | __metrics Screen width/height:1600/1200 10:51:52 INFO - PROCESS | 28208 | colorDepth:24 10:51:52 INFO - PROCESS | 28208 | Browser inner width/height: 1024/697 10:51:52 INFO - PROCESS | 28208 | __metrics 10:51:52 ERROR - PROCESS | 28208 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 10:51:53 INFO - TEST-INFO | 28208: exit 0 10:51:53 INFO - Browser initialized. 10:51:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:53 INFO - TEST-INFO | started process 28335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNj9icO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:05 INFO - PROCESS | 28335 | RSS: Main: 152899584 10:52:05 INFO - PROCESS | 28335 | 10:52:54 INFO - PROCESS | 28335 | 1470333174805 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] 10:55:02 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35398/tests/dromaeo/cssquery-ext.html) 10:55:03 INFO - PROCESS | 28335 | RSS: Main: 156852224 10:55:03 INFO - PROCESS | 28335 | 10:58:05 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-ext.html (next: http://localhost:35398/tests/dromaeo/cssquery-jquery.html) 10:58:06 INFO - PROCESS | 28335 | RSS: Main: 155344896 10:58:06 INFO - PROCESS | 28335 | 11:01:08 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35398/tests/dromaeo/cssquery-mootools.html) 11:01:08 INFO - PROCESS | 28335 | RSS: Main: 154435584 11:01:08 INFO - PROCESS | 28335 | 11:04:10 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35398/tests/dromaeo/cssquery-prototype.html) 11:04:10 INFO - PROCESS | 28335 | RSS: Main: 156409856 11:04:10 INFO - PROCESS | 28335 | 11:07:13 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35398/tests/dromaeo/cssquery-yui.html) 11:07:13 INFO - PROCESS | 28335 | RSS: Main: 154341376 11:07:13 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | Cycle 1(1): loaded http://localhost:35398/tests/dromaeo/cssquery-yui.html (next: http://localhost:35398/tests/dromaeo/cssquery-dojo.html) 11:10:16 INFO - PROCESS | 28335 | RSS: Main: 158543872 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | __start_tp_report 11:10:16 INFO - PROCESS | 28335 | _x_x_mozilla_page_load 11:10:16 INFO - PROCESS | 28335 | _x_x_mozilla_page_load_details 11:10:16 INFO - PROCESS | 28335 | |i|pagename|runs| 11:10:16 INFO - PROCESS | 28335 | |0;dojo.html;3333.5499707539484;3389.915252118695;3415.1803567143884;3419.162305235218;3421.2644281479493;5594.272744543208;5643.9435605643985;5684.431556844319;5695.601307908448;5713.514351280146;5662.150677398392;5690.174924635936;5698.287714035746;5704.3154821421485;5720.342160651527;5136.075506408845;5181.222816577506;5219.217117432378;5248.868778280555;5273.446288139748;5137.434882162959;5158.896822063556;5242.951409718053;5243.895122097556;5250.422453530108;5163.561097306733;5183.2743415921805;5184.429712731597;5193.974030129844;5196.246544251081;5183.403908550508;5252;5255.500727430888;5279.128943724281;5283.101872681654;4998.550130488274;5060.3927528696795;5147.948520514822;5172.922406163911;5220.738963051832;5506.752196151183;5548.140038294071;5584.078627026576;5593.272874526327;5626.634268772557;6081.847953801146;6117.051856962178;6125.5712100153005;6127.6017058891475;6130.570860039799;5915.142304365843;6074.696265186767;6102.542309326818;6208.844778880519;6211.285702144266;5724.771009159628;5727.971360143214;5731.36954934961;5731.541476681856;5759.856003599902;6286.968565157145;6291.591046581958;6298.1812364392335;6299.590526615755;6308.243010838637;5800.042992906123;5806.477417032403;5810.970945145247;5864.736086876101;5983.282006159288;5993.61041532299;6002.0996850472775;6004.789832355934;6014.609050411709;6014.729337179838;5926.851828704317;5932.377100404482;5956.702164891824;5982.73077711504;5984.162217289496;5903.527717782567;5977.79077732286;6039.033754599331;6057.182280392179;6091.299500557404;4639.489656137822;4647.6281897448125;4653.744044077608;4661.533846615312;4699.201135806921;4126.814293356806;4183.602557757008;4184.560621134737;4189.476315460567;4211.1998720243055;5759.712014399263;5773.191753154561;5779.190913272145;5795.82612521625;5808.767649293981;6049.697515124226;6076.726547305382;6128.846778830565;6148.1699970504305;6157.261128664589;5746.569007324468;5901.3508514063415;5904.793332233351;5906.438888305604;5909.763609455659;5188.325517682752;5194.168932970707;5215.452377500384;5244.396894357122;5257.08001099806;6411.487081033506;6423.068655044993;6436.645984470899;6443.226812782403;6450.516211284079;5974.761009559743;6051.667158306335;6146.354632763585;6163.537734669828;6169.537284703575;6297.874042519033;6337.746490140343;6351.2060992375955;6358.650274234961;6415.807525774234;5925.674087925206;5966.701664916824;5989.071693887455;5991.131285963598;5991.580589358878;6047.606905551301;6126.548209434937;6131.724072416663;6135.110408990582;6156;5984.13230081627;6013.128096426081;6016.849578760566;6022.8795424090395;6043.214382130471;6006.039033754579;6017.699115044143;6037.094435834484;6054.122152287981;6057.030875059969;5731.369549349652;5783.855403614775;5859.062549991981;5883.0293001654245;5912.260967379078;5979.701014949148;6030.7889223876955;6036.879262414639;6039.909401358896;6041.939580604314;5736.225609542658;5927.407259274038;5930.644161350333;5933.554983376178;5934.881302374015 11:10:16 INFO - PROCESS | 28335 | |1;ext.html;587.1398401342033;635.2789583822362;643.33093582674;653.5523166630857;670.8054664147397;41413.378799317994;46562.30156547655;46774.2983855242;46775.29837052447;46999;47058;47510.049799004;47631.52368476314;47636;47648.28527572089;8973.820523589524;9110.27117830572;9123.589438475252;9123.95438022809;9130.863037054416;8956.462612243253;9043.321750868678;9049.954750226272;9058.23005044572;9076.682316118937;9122.543872806333;9138.314626403013;9140.085991400872;9195.540222988824;9210.585523651453;9025.32310076747;9065.365424420293;9077.95461022694;9111.179993800557;9119.133682300171;9034.14175653312;9114.179723824887;9131.315151363675;9154.31342649304;9162.816743665157;43228.78385608083;43642.78178609118;43667.56332436667;43672.12655746867;43809.78095109536;3615.189974298182;3710.2950439416422;3745.4943582616543;3896.181801821621;3942.6845852331744;32899.50650740241;33820.323593528236;34009.82995085033;34087.318253635036;34444.6555534444;4734.384530011111;4741.359916411275;4754.0967216229155;4772.2125849234835;4783.306420568998;389902;391418;391953;392705;393213;35418.114547136014;63089;64120;64181.679091604245;64217.35782642114;37816;39908.20183596312;40058.799706001286;40139;40378.79810600928;17335.479935601954;17570.736438953427;17587;17591.472255832345;17611.735823962652;14586.41654333836;14628.926855365655;14746.852531474762;14777.556673299818;14779.63050923714;9418.858717119248;9420.764480887896;9425.811483770287;9509.5720692569;9559.474228917337;3502.562179727534;3581.2658405026905;3589.623089575557;3596.532450781434;3615.258871931248;1095.4084794211037;1096.7751610919743;1100.3287994323457;1126.52122847791;1177.770334784726;32656.510152347735;32758.18104547358;32898.83550582232;33347;33477.83261083728;1144.3877525523972;1212.5695378140633;1213.9984512776994;1252.655519732081;1262.9621111366673;16764.245608947625;16824.74762878558;16954.660906781795;17010.574735631708;17070.40253591143;607609;616549;637158;637305;641681;62110.37889621136;62456.375436245056;62687.6865615669;62775.058374124426;62933.68533157305;1471.2937789860712;1490.4261859184292;1494.155801971904;1517.0291013751207;1520.049968769519;32008.6799132015;32627;32972.340553188325;33042.504362434105;33441.33117337591;53474;54118;54370.7281463606;54385.72807135939;54421.45578544164;340431;341445;343764;345656;346646;30760;31040;31194.376112478076;31357.372852543278;31634;48411;48772.5122748768;49072.509274908225;49301.52095437142;49355.50644493509;41295.7935210322;41686.791566041975;42099.7895010523;43038.35442468428;43151.784241078596;33941.66058339385;34129.829350853084;34365.65634343625;34603.826980864935;35098.82450587731;40631.7968410156;40928.18143637051;41000;41766.37350439685;42434.57565424306;35035.29929401448;36067.81966090153;36195.27609447849;36476.63523364732;36888.07779805419;28589.142325730263;28673;28690.426191476472;28819.855900721202;29130.27174320659 11:10:16 INFO - PROCESS | 28335 | |2;jquery.html;425.06273666565244;427.9486461624605;430.36306266725245;431.7150680550837;438.163108462836;18310.176042078107;19330.323438679665;20280.391588252358;20281.797182028175;20455.693164602544;18985.715214271797;19003.809961900377;19832.826747720366;20096.497587560283;20179.29372471964;5522.530584900278;5739.684317362543;5752;5758;5770.538356931435;5562.110062390018;5654.462826031541;5681.204631351614;5709.115087161496;5717.8570535736735;5694.259746232984;5711.543076553866;5718.313802343704;5720.628159169641;5724.227229324029;5592.3009623797025;5644.322681278232;5696.430356964312;5712.971435142818;5730.36965933747;5106.285120083191;5132.0249152661245;5133.307003554547;5139.8458046258675;5167.689938603696;22140.88929555358;23678.763212368;23798.405039874142;24358.512829743308;24534.509309813882;2517.1819158773474;2518.4333524956924;2531;2561.4877024595157;2563.83335083219;14474.927625361912;14552.490662826856;15307.846921530754;15463.845361546353;15564.37742490299;2009.7588289405219;2051.651219292724;2066.4730493724005;2075.962018990505;2106.2943913788745;69730;74082.25917740808;75455;76811.61594192049;78542;11074.833877491845;11679.88320116805;11918.225315354648;11960.461779219955;11971.820422693667;16616.916915415346;16677.332906683598;16734.4142954996;16748.078855663054;16761;8789.296856251485;8822.955885220534;8827.823443531222;8843;8917.41394995457;8425.4944703318;8429.957850210832;8493.108223636553;8502.532360720095;8603.655853765778;5080.13637681595;5126.948730512721;5128.743562821844;5141.203113517411;5176.818811341585;2101.243552321163;2109.7890210979085;2176.4232478393237;2180.465785882469;2190.211523851412;1020.0921180149672;1021.3004092196869;1073.044989958937;1078.82199437092;1097.6981330134277;19091.140898659316;19173.424797256106;19378.515537111685;19380.612387752168;19964;1052.3422860712055;1085.9511321990528;1116.413882711583;1118.4910865556153;1135.1486385211092;10693.518791654395;10983.61557345489;11016.669499915015;11017.228793984505;11166.609168679057;468449;481539;482395;483228;484093;84907;89308.5534572336;91381.54309228412;92310;92509.53745231366;1060.6234786650627;1130.5421304371744;1135.0238794636605;1135.28477059452;1136.693092864922;17516;17604.119794010505;17611;17925;18120.456386308433;41304.58695413007;42009;42526.57473425226;43239.135217296105;44275.778621106685;51283.74358128185;54272.45727542832;55207.17189242245;60929;61414;8628.094050124646;8658.870116948377;8695.782605434915;8743.519106448952;8806.867896981423;9573.856392154263;13346.357717691633;13453.663658408617;13641.249731264876;13649.38577763983;11875.109366797698;12109.636710898687;12242.265464072185;12316.261024338568;12371.876281237432;10928.617498387519;11436.599719009795;11574.768504629692;11675.88324116748;12019;11874.881251187378;12146;12177;12248.020158387486;12536.561220357244;8634.56827158652;8671.4363566368;8730.301575874042;8765.167309105625;8837.646494140163;8365.62354694028;11491.942540287246;11567.76864462723;11605.709857253636;11695.590654327058 11:10:16 INFO - PROCESS | 28335 | |3;mootools.html;1527.129536164386;1595.6728870581528;1770.6547223291464;1812.8368446839781;1906.247032422194;8371.330293576515;9047.14052165045;9465.574049167786;9713.417194968299;9727.659531916384;9108.635654573825;9127.817443651124;9192.034836342187;9194.264458843294;9207.493587852665;2487.9626805597886;2529.051605647882;2529.3423709835392;2529.734377890323;2530.5192013517467;2480.962785558218;2514;2514.4845306712173;2518.4333524956924;2521;2461.3477428481465;2477.52926943881;2493.7880280176205;2504.111040580595;2504.6368276599883;2442.3894026493376;2458;2460.59400198967;2461.7661322174363;2493.2395619336185;2471.0980492120248;2475.084218839023;2497.675302210701;2497.8501289922665;2500.087468074158;9360.953195234048;9451.243900487945;9506.952465237699;9510.048995100504;9534.761630959212;5543.1408131739645;5726.169705392736;5728.770849166029;5729.255196824428;5735.340435849889;3571.089372210096;3645.434957581579;3717.3494638438438;3751.1184871555433;3767.962320376816;1148.5520646947698;1168.1881092640617;1174.0959461214902;1209.7217639942774;1210.2617403384018;13458.865411345958;13483.932580337134;13507.054506184571;13508.79736803939;13577.59267221985;4688.296755486705;4704.08270387278;4807.399075115611;4860.708357498562;4881.95118048822;11200;11271;11343.092552595772;11345.489452974636;11373.431328433546;5674.2339784129435;5739.339975902742;5745.511631511285;5747.885042299215;5783.566232532577;4545.863624091283;5050.520200580939;5215.217717342429;5231.973840130851;5287.154055351125;4289.742615443083;4302.505211900609;4319.049809042006;4384.912301753947;4400.295952647561;1334.3595074364166;1335.3189873164756;1344.8117263583106;1345.7173993461288;1354.4852955876902;924.9445033298024;1034.162328513891;1043.9791204175874;1056.2447849787438;1077.0521940692297;6209.627422354673;6410.391012853772;6557.934420655828;6574.474042076622;6687.598744075371;475.2704598441376;487.7219984608739;488.6896820518996;490.2694984473181;497.47267896030326;4554.544545545419;4579.679422440464;4605.815767369335;4611.884702882455;4645.9303110453375;11350.602728904449;11624.302541847515;12019.87980120205;12110.939445302716;12127;11929.343886086175;11946.10404219687;11955.16313858039;11992.280463172237;12015.939920300343;8650.91349086501;8859.778505537284;8884.111588841193;8889.066648001995;8891.777705557413;6541.803745887631;6693.497987650849;6724.49566282521;6734.191896972395;6819.522633415613;10543.894561054598;10662.466876656292;10811.405372704263;10902.18233632465;10902.236843420884;10665.573377064831;10842.349459032483;10852.348859068481;10896.346219226873;10964.890351096386;7399.519031262951;7972.760817175494;8137.6338064788415;8373.371997100363;8504.277136443225;9189.172974432066;9214.585343659417;9215.124563166488;9288.860667090134;9290.256779457492;7964.681412743657;8059.838803223785;8143.144969778088;8143.307818835466;8201.917980820115;7915;8101.230383113595;8210.220029097227;8249.133840946854;8488.490690558587;7490.325870671666;7606.885896711443;7718.035245594301;7726.845463090594;7736.497127686683;5901.645901245939;5902.2327097477055;5934.970325148347;5948.256467941507;5996.190514280691;5843.211166492469;5922.318933322723;5948.434898684618;5983.880322393441;5993.160957465871 11:10:16 INFO - PROCESS | 28335 | |4;prototype.html;351.68524170867073;367.68746565419394;367.96688298053186;369.67837980956574;373.34850685553715;5611.719414029302;5657.57568182387;5685.630434021786;5736.139579063142;5794.956907756602;5652.689102099383;5690.260266165403;5696.231008813809;5699.715014249292;5718.685472299022;4498.370228168051;4506.909861802762;4522.570355816192;4542;4542.682012259143;4439.866803995886;4490.7530085845265;4490.842820501283;4494.213587575691;4533.297338912457;4418.172369683389;4419.033530079116;4426.535213802553;4474.619657329131;4480.775961201944;4330.415393921811;4468.798904049309;4476.418065651477;4495.1459222747735;4505.301678239878;3925.9203718977224;3944.1717239379764;3947.703922205846;3952.920941581181;3957.8126562031275;5558.360788509332;5568.972155139239;5573;5576.052071147915;5596.244506991545;5029.667138208378;5064.670796398259;5114.43741188469;5133.768980395854;5180.834312279744;5925.377835327272;5948.512871782054;5970;5995.160677505153;5999.990003348883;4290.442242508454;4293.849715259951;4322.113966636832;4327.112941846945;4345.50026746925;6090.634561926298;6225.782097626561;6236.469900058501;6305.68471576424;6385.477736294184;4380.912381752347;4411.2941929291155;4411.691181617321;4414.3157810539415;4434.357018232338;4487.237169681162;4489.259272220047;4494.988627558773;4501.234790085693;4502.932456013163;5015.272785446163;5092.2361645753435;5124.256982737482;5129.9743501282255;5131.358580177478;5866.413358664185;5983.948186424955;5992.43071908168;6003.849903752353;6075;1513.6528489644224;1514.545636309103;1516.651170230853;1523.7638166084275;1527.4043123181968;977.6996594529259;985.7042887133831;992.5880759484733;993.7118235711563;1014.9441780702132;5193.143131383355;5294.391145018372;5329.760160792696;5400.864978375494;5412.458754124635;5577.609567330248;5616.326040875121;5618.91571626426;5624.240727501817;5633.69014704187;5282.049231138355;5369.926014797056;5510.504054635102;5899.115132730039;5976.193213916153;3269.836508174629;3289.881440310306;3290.769646124796;3315.9834200829323;3332.4670651500583;6205.906911396332;6456.3543645636;6456.935430645727;6481.675916204171;6495.577787443801;6300.495960323163;6324.557280990287;6326.367363263729;6342.270638876588;6345.90481142774;6387.265464471552;6423.743050277936;6444.677766111676;6469.288378278386;6469.385408386196;5925.259342582177;6230.190075290183;6245.219347581552;6256.687165641609;6259.812205633838;6158.614311779814;6163.876722465436;6170.290416601969;6171.9074213887725;6177.2587289525545;6282.3089460158435;6422.293547709842;6464.676766161767;6483.319251478527;6494.9025764612625;4363.650907927295;4376.649868010615;4378.343248512749;4392.506547773773;4402.801873915618;6050.788222412194;6236.438720515175;6244.875102498016;6249.312575616769;6269.429533891082;6014.518838492998;6019.849503762441;6029.758809647565;6039.849003774941;6048.7278072487725;6001.969990150196;6021.157038014769;6026.8548975694475;6050.6369617823075;6063.72713227897;5668.433156684298;5976.97011514957;5992.513107060521;6003.609765365237;6026;6080.841301337961;6083.448720576224;6107.694615269308;6107.755689772359;6129;5664.688442135722;5982.461578457785;5983.700814959322;5986.880262394815;5994.340622531605 11:10:16 INFO - PROCESS | 28335 | |5;yui.html;806.709584549562;807.2008711375738;814.3241109878797;834.6119054639591;847.1824689174945;15115;16331.428400006002;16356.34574617017;16358.182090895452;16398.18009099546;14784.482543110993;14911.030782999098;14921.253937303145;14927.40290388383;14934.925325373359;853.5433543054452;860.535310932096;871.5075982070142;873.8689196620526;880.1946219209416;864.7276108025983;868.1405408645427;871.5032431514039;871.5859966515918;871.7776966873438;923.6443969071922;924.0528458330198;924.3160061554469;926.1294383279729;926.1988380051274;913.0686699566438;914.2046419614944;916.9541522923894;917.7063339731322;920.0293690156882;674.5042393840523;675.1830285354727;676.0096458688046;676.3473248315399;676.8409423785406;15854.603634909105;15894;16006.519804405887;16007.27967241477;16028.439004634782;15113;15159.317830697644;15286.541403757905;15286.847131528653;15540.06759594428;12624.621261362174;12629.368531573384;12653.683657908534;12717.745645087047;12763.234205947672;4083.8774836754947;4084.5098588169312;4092.611201935841;4128.545859955402;4248.214080395106;79756.60121699412;80631.596842016;81237.59381203115;81281;82699;11814.645560633024;11955.581554645545;12047.939760301142;12092.576759813364;12192.268463892195;20647.69028464574;20672.896635517027;20834.374968750963;20928.16287348489;21206.893965530384;8536.74389768308;8613.22480976715;8704.260137888225;8791.428557143765;8950.060243674321;4999.875003124878;5142.331496905378;5191.922121168185;5216.58267338612;5253.973730131325;3856.537215534154;3973.384125460558;3980.8805735827973;3985.740926839746;3988.1824226033596;658.6278752504819;663.9070530125787;672.4284358295507;680.7481231944113;681.7341236917606;678.8163513123435;696.2202333386639;704.6018999265399;704.630069213667;719.6437763307197;10250.58997640101;10352.948235258775;10600.787984240273;10612.522436490377;10649;658.9011648252705;702.4205030849467;720.6396801599201;744.2260049548518;751.8721817291074;4774.474807771142;4840.467548569654;4864.805407783649;4881.877953051202;4939.975300123549;73382;92595;114234;120219.39890300493;123149.38425307815;64876.02685959714;89741.10258897458;97410;104547;105599;91576;93021.5348923251;93549.53225233694;97129;97175.51412243035;9155.725328240163;9276.768080798034;9475.620975160917;9562.760930976503;9612.903870961201;46106.30840537462;53841.73079134579;54075.72962135164;54135.729321353145;55488.72255638696;75661;75793;77308.2269177301;78528;79481;13694.794578081535;13874.23691696926;13961;14145.222012789396;14295.428182872569;14788.556343309718;14789.556313310617;14916.477923272634;14989;15592.986455880331;14041.648958776112;14062.156270623795;14125.081869678437;14152.363143658355;14398.85601144017;13837.930810345884;14198.858011419754;14235.074720143157;14454.494092706705;14561.635959101108;13237.205767653586;13494.460221591418;13651.726965460437;13852.72294554083;14230.35963381671;11220.326780393203;11336.716582085513;11424.885751142383;11580.826287605862;11585;11820;12270.75458490843;12387.75224495487;12388.442520086797;12459.439325230567 11:10:16 INFO - PROCESS | 28335 | __end_tp_report 11:10:16 INFO - PROCESS | 28335 | __start_cc_report 11:10:16 INFO - PROCESS | 28335 | _x_x_mozilla_cycle_collect,337 11:10:16 INFO - PROCESS | 28335 | __end_cc_report 11:10:16 INFO - PROCESS | 28335 | __startTimestamp1470334216329__endTimestamp 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | ------- Summary: start ------- 11:10:16 INFO - PROCESS | 28335 | Number of tests: 6 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#0] dojo.html Cycles:165 Average:5666.45 Median:5904.79 stddev:634.32 (10.7%) stddev-sans-first:609.29 11:10:16 INFO - PROCESS | 28335 | Values: 3333.5 3389.9 3415.2 3419.2 3421.3 5594.3 5643.9 5684.4 5695.6 5713.5 5662.2 5690.2 5698.3 5704.3 5720.3 5136.1 5181.2 5219.2 5248.9 5273.4 5137.4 5158.9 5243.0 5243.9 5250.4 5163.6 5183.3 5184.4 5194.0 5196.2 5183.4 5252.0 5255.5 5279.1 5283.1 4998.6 5060.4 5147.9 5172.9 5220.7 5506.8 5548.1 5584.1 5593.3 5626.6 6081.8 6117.1 6125.6 6127.6 6130.6 5915.1 6074.7 6102.5 6208.8 6211.3 5724.8 5728.0 5731.4 5731.5 5759.9 6287.0 6291.6 6298.2 6299.6 6308.2 5800.0 5806.5 5811.0 5864.7 5983.3 5993.6 6002.1 6004.8 6014.6 6014.7 5926.9 5932.4 5956.7 5982.7 5984.2 5903.5 5977.8 6039.0 6057.2 6091.3 4639.5 4647.6 4653.7 4661.5 4699.2 4126.8 4183.6 4184.6 4189.5 4211.2 5759.7 5773.2 5779.2 5795.8 5808.8 6049.7 6076.7 6128.8 6148.2 6157.3 5746.6 5901.4 5904.8 5906.4 5909.8 5188.3 5194.2 5215.5 5244.4 5257.1 6411.5 6423.1 6436.6 6443.2 6450.5 5974.8 6051.7 6146.4 6163.5 6169.5 6297.9 6337.7 6351.2 6358.7 6415.8 5925.7 5966.7 5989.1 5991.1 5991.6 6047.6 6126.5 6131.7 6135.1 6156.0 5984.1 6013.1 6016.8 6022.9 6043.2 6006.0 6017.7 6037.1 6054.1 6057.0 5731.4 5783.9 5859.1 5883.0 5912.3 5979.7 6030.8 6036.9 6039.9 6041.9 5736.2 5927.4 5930.6 5933.6 5934.9 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#1] ext.html Cycles:180 Average:61067.92 Median:40505.30 stddev:125632.37 (310.2%) stddev-sans-first:125902.74 11:10:16 INFO - PROCESS | 28335 | Values: 587.1 635.3 643.3 653.6 670.8 41413.4 46562.3 46774.3 46775.3 46999.0 47058.0 47510.0 47631.5 47636.0 47648.3 8973.8 9110.3 9123.6 9124.0 9130.9 8956.5 9043.3 9050.0 9058.2 9076.7 9122.5 9138.3 9140.1 9195.5 9210.6 9025.3 9065.4 9078.0 9111.2 9119.1 9034.1 9114.2 9131.3 9154.3 9162.8 43228.8 43642.8 43667.6 43672.1 43809.8 3615.2 3710.3 3745.5 3896.2 3942.7 32899.5 33820.3 34009.8 34087.3 34444.7 4734.4 4741.4 4754.1 4772.2 4783.3 389902.0 391418.0 391953.0 392705.0 393213.0 35418.1 63089.0 64120.0 64181.7 64217.4 37816.0 39908.2 40058.8 40139.0 40378.8 17335.5 17570.7 17587.0 17591.5 17611.7 14586.4 14628.9 14746.9 14777.6 14779.6 9418.9 9420.8 9425.8 9509.6 9559.5 3502.6 3581.3 3589.6 3596.5 3615.3 1095.4 1096.8 1100.3 1126.5 1177.8 32656.5 32758.2 32898.8 33347.0 33477.8 1144.4 1212.6 1214.0 1252.7 1263.0 16764.2 16824.7 16954.7 17010.6 17070.4 607609.0 616549.0 637158.0 637305.0 641681.0 62110.4 62456.4 62687.7 62775.1 62933.7 1471.3 1490.4 1494.2 1517.0 1520.0 32008.7 32627.0 32972.3 33042.5 33441.3 53474.0 54118.0 54370.7 54385.7 54421.5 340431.0 341445.0 343764.0 345656.0 346646.0 30760.0 31040.0 31194.4 31357.4 31634.0 48411.0 48772.5 49072.5 49301.5 49355.5 41295.8 41686.8 42099.8 43038.4 43151.8 33941.7 34129.8 34365.7 34603.8 35098.8 40631.8 40928.2 41000.0 41766.4 42434.6 35035.3 36067.8 36195.3 36476.6 36888.1 28589.1 28673.0 28690.4 28819.9 29130.3 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#2] jquery.html Cycles:180 Average:28799.04 Median:24078.46 stddev:78981.26 (328.0%) stddev-sans-first:79174.09 11:10:16 INFO - PROCESS | 28335 | Values: 425.1 427.9 430.4 431.7 438.2 18310.2 19330.3 20280.4 20281.8 20455.7 18985.7 19003.8 19832.8 20096.5 20179.3 5522.5 5739.7 5752.0 5758.0 5770.5 5562.1 5654.5 5681.2 5709.1 5717.9 5694.3 5711.5 5718.3 5720.6 5724.2 5592.3 5644.3 5696.4 5713.0 5730.4 5106.3 5132.0 5133.3 5139.8 5167.7 22140.9 23678.8 23798.4 24358.5 24534.5 2517.2 2518.4 2531.0 2561.5 2563.8 14474.9 14552.5 15307.8 15463.8 15564.4 2009.8 2051.7 2066.5 2076.0 2106.3 69730.0 74082.3 75455.0 76811.6 78542.0 11074.8 11679.9 11918.2 11960.5 11971.8 16616.9 16677.3 16734.4 16748.1 16761.0 8789.3 8823.0 8827.8 8843.0 8917.4 8425.5 8430.0 8493.1 8502.5 8603.7 5080.1 5126.9 5128.7 5141.2 5176.8 2101.2 2109.8 2176.4 2180.5 2190.2 1020.1 1021.3 1073.0 1078.8 1097.7 19091.1 19173.4 19378.5 19380.6 19964.0 1052.3 1086.0 1116.4 1118.5 1135.1 10693.5 10983.6 11016.7 11017.2 11166.6 468449.0 481539.0 482395.0 483228.0 484093.0 84907.0 89308.6 91381.5 92310.0 92509.5 1060.6 1130.5 1135.0 1135.3 1136.7 17516.0 17604.1 17611.0 17925.0 18120.5 41304.6 42009.0 42526.6 43239.1 44275.8 51283.7 54272.5 55207.2 60929.0 61414.0 8628.1 8658.9 8695.8 8743.5 8806.9 9573.9 13346.4 13453.7 13641.2 13649.4 11875.1 12109.6 12242.3 12316.3 12371.9 10928.6 11436.6 11574.8 11675.9 12019.0 11874.9 12146.0 12177.0 12248.0 12536.6 8634.6 8671.4 8730.3 8765.2 8837.6 8365.6 11491.9 11567.8 11605.7 11695.6 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#3] mootools.html Cycles:180 Average:6262.73 Median:4696.19 stddev:3582.18 (76.3%) stddev-sans-first:3574.55 11:10:16 INFO - PROCESS | 28335 | Values: 1527.1 1595.7 1770.7 1812.8 1906.2 8371.3 9047.1 9465.6 9713.4 9727.7 9108.6 9127.8 9192.0 9194.3 9207.5 2488.0 2529.1 2529.3 2529.7 2530.5 2481.0 2514.0 2514.5 2518.4 2521.0 2461.3 2477.5 2493.8 2504.1 2504.6 2442.4 2458.0 2460.6 2461.8 2493.2 2471.1 2475.1 2497.7 2497.9 2500.1 9361.0 9451.2 9507.0 9510.0 9534.8 5543.1 5726.2 5728.8 5729.3 5735.3 3571.1 3645.4 3717.3 3751.1 3768.0 1148.6 1168.2 1174.1 1209.7 1210.3 13458.9 13483.9 13507.1 13508.8 13577.6 4688.3 4704.1 4807.4 4860.7 4882.0 11200.0 11271.0 11343.1 11345.5 11373.4 5674.2 5739.3 5745.5 5747.9 5783.6 4545.9 5050.5 5215.2 5232.0 5287.2 4289.7 4302.5 4319.0 4384.9 4400.3 1334.4 1335.3 1344.8 1345.7 1354.5 924.9 1034.2 1044.0 1056.2 1077.1 6209.6 6410.4 6557.9 6574.5 6687.6 475.3 487.7 488.7 490.3 497.5 4554.5 4579.7 4605.8 4611.9 4645.9 11350.6 11624.3 12019.9 12110.9 12127.0 11929.3 11946.1 11955.2 11992.3 12015.9 8650.9 8859.8 8884.1 8889.1 8891.8 6541.8 6693.5 6724.5 6734.2 6819.5 10543.9 10662.5 10811.4 10902.2 10902.2 10665.6 10842.3 10852.3 10896.3 10964.9 7399.5 7972.8 8137.6 8373.4 8504.3 9189.2 9214.6 9215.1 9288.9 9290.3 7964.7 8059.8 8143.1 8143.3 8201.9 7915.0 8101.2 8210.2 8249.1 8488.5 7490.3 7606.9 7718.0 7726.8 7736.5 5901.6 5902.2 5935.0 5948.3 5996.2 5843.2 5922.3 5948.4 5983.9 5993.2 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#4] prototype.html Cycles:180 Average:5048.70 Median:5655.13 stddev:1486.65 (26.3%) stddev-sans-first:1448.42 11:10:16 INFO - PROCESS | 28335 | Values: 351.7 367.7 368.0 369.7 373.3 5611.7 5657.6 5685.6 5736.1 5795.0 5652.7 5690.3 5696.2 5699.7 5718.7 4498.4 4506.9 4522.6 4542.0 4542.7 4439.9 4490.8 4490.8 4494.2 4533.3 4418.2 4419.0 4426.5 4474.6 4480.8 4330.4 4468.8 4476.4 4495.1 4505.3 3925.9 3944.2 3947.7 3952.9 3957.8 5558.4 5569.0 5573.0 5576.1 5596.2 5029.7 5064.7 5114.4 5133.8 5180.8 5925.4 5948.5 5970.0 5995.2 6000.0 4290.4 4293.8 4322.1 4327.1 4345.5 6090.6 6225.8 6236.5 6305.7 6385.5 4380.9 4411.3 4411.7 4414.3 4434.4 4487.2 4489.3 4495.0 4501.2 4502.9 5015.3 5092.2 5124.3 5130.0 5131.4 5866.4 5983.9 5992.4 6003.8 6075.0 1513.7 1514.5 1516.7 1523.8 1527.4 977.7 985.7 992.6 993.7 1014.9 5193.1 5294.4 5329.8 5400.9 5412.5 5577.6 5616.3 5618.9 5624.2 5633.7 5282.0 5369.9 5510.5 5899.1 5976.2 3269.8 3289.9 3290.8 3316.0 3332.5 6205.9 6456.4 6456.9 6481.7 6495.6 6300.5 6324.6 6326.4 6342.3 6345.9 6387.3 6423.7 6444.7 6469.3 6469.4 5925.3 6230.2 6245.2 6256.7 6259.8 6158.6 6163.9 6170.3 6171.9 6177.3 6282.3 6422.3 6464.7 6483.3 6494.9 4363.7 4376.6 4378.3 4392.5 4402.8 6050.8 6236.4 6244.9 6249.3 6269.4 6014.5 6019.8 6029.8 6039.8 6048.7 6002.0 6021.2 6026.9 6050.6 6063.7 5668.4 5977.0 5992.5 6003.6 6026.0 6080.8 6083.4 6107.7 6107.8 6129.0 5664.7 5982.5 5983.7 5986.9 5994.3 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - PROCESS | 28335 | [#5] yui.html Cycles:180 Average:21093.21 Median:25440.39 stddev:29773.37 (117.0%) stddev-sans-first:29817.92 11:10:16 INFO - PROCESS | 28335 | Values: 806.7 807.2 814.3 834.6 847.2 15115.0 16331.4 16356.3 16358.2 16398.2 14784.5 14911.0 14921.3 14927.4 14934.9 853.5 860.5 871.5 873.9 880.2 864.7 868.1 871.5 871.6 871.8 923.6 924.1 924.3 926.1 926.2 913.1 914.2 917.0 917.7 920.0 674.5 675.2 676.0 676.3 676.8 15854.6 15894.0 16006.5 16007.3 16028.4 15113.0 15159.3 15286.5 15286.8 15540.1 12624.6 12629.4 12653.7 12717.7 12763.2 4083.9 4084.5 4092.6 4128.5 4248.2 79756.6 80631.6 81237.6 81281.0 82699.0 11814.6 11955.6 12047.9 12092.6 12192.3 20647.7 20672.9 20834.4 20928.2 21206.9 8536.7 8613.2 8704.3 8791.4 8950.1 4999.9 5142.3 5191.9 5216.6 5254.0 3856.5 3973.4 3980.9 3985.7 3988.2 658.6 663.9 672.4 680.7 681.7 678.8 696.2 704.6 704.6 719.6 10250.6 10352.9 10600.8 10612.5 10649.0 658.9 702.4 720.6 744.2 751.9 4774.5 4840.5 4864.8 4881.9 4940.0 73382.0 92595.0 114234.0 120219.4 123149.4 64876.0 89741.1 97410.0 104547.0 105599.0 91576.0 93021.5 93549.5 97129.0 97175.5 9155.7 9276.8 9475.6 9562.8 9612.9 46106.3 53841.7 54075.7 54135.7 55488.7 75661.0 75793.0 77308.2 78528.0 79481.0 13694.8 13874.2 13961.0 14145.2 14295.4 14788.6 14789.6 14916.5 14989.0 15593.0 14041.6 14062.2 14125.1 14152.4 14398.9 13837.9 14198.9 14235.1 14454.5 14561.6 13237.2 13494.5 13651.7 13852.7 14230.4 11220.3 11336.7 11424.9 11580.8 11585.0 11820.0 12270.8 12387.8 12388.4 12459.4 11:10:16 INFO - PROCESS | 28335 | -------- Summary: end -------- 11:10:16 INFO - PROCESS | 28335 | 11:10:16 INFO - TEST-INFO | 28335: exit 0 11:10:17 INFO - TEST-OK | dromaeo_css | took 1109088ms 11:10:17 INFO - TEST-START | kraken 11:10:17 INFO - operating with platform_type : linux_ 11:10:17 INFO - Initialising browser for kraken test... 11:10:17 INFO - TEST-INFO | started process 28577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM8DKhV/profile http://localhost:35398/getInfo.html) 11:10:20 INFO - PROCESS | 28577 | __metrics Screen width/height:1600/1200 11:10:20 INFO - PROCESS | 28577 | colorDepth:24 11:10:20 INFO - PROCESS | 28577 | Browser inner width/height: 1024/697 11:10:20 INFO - PROCESS | 28577 | __metrics 11:10:21 ERROR - PROCESS | 28577 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 11:10:22 INFO - TEST-INFO | 28577: exit 0 11:10:22 INFO - Browser initialized. 11:10:22 INFO - Running cycle 1/1 for kraken test... 11:10:22 INFO - TEST-INFO | started process 28704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM8DKhV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:33 INFO - PROCESS | 28704 | RSS: Main: 152424448 11:10:33 INFO - PROCESS | 28704 | 11:10:36 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35398/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:37 INFO - PROCESS | 28704 | RSS: Main: 158228480 11:10:37 INFO - PROCESS | 28704 | 11:10:39 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35398/tests/kraken/driver.html?testName=audio-dft) 11:10:40 INFO - PROCESS | 28704 | RSS: Main: 157270016 11:10:40 INFO - PROCESS | 28704 | 11:10:43 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35398/tests/kraken/driver.html?testName=audio-fft) 11:10:43 INFO - PROCESS | 28704 | RSS: Main: 157630464 11:10:43 INFO - PROCESS | 28704 | 11:10:46 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35398/tests/kraken/driver.html?testName=audio-oscillator) 11:10:46 INFO - PROCESS | 28704 | RSS: Main: 158109696 11:10:46 INFO - PROCESS | 28704 | 11:10:48 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35398/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:49 INFO - PROCESS | 28704 | RSS: Main: 157650944 11:10:49 INFO - PROCESS | 28704 | 11:10:52 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35398/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:53 INFO - PROCESS | 28704 | RSS: Main: 157048832 11:10:53 INFO - PROCESS | 28704 | 11:10:56 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35398/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:57 INFO - PROCESS | 28704 | RSS: Main: 158154752 11:10:57 INFO - PROCESS | 28704 | 11:10:59 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35398/tests/kraken/driver.html?testName=json-parse-financial) 11:11:00 INFO - PROCESS | 28704 | RSS: Main: 157638656 11:11:00 INFO - PROCESS | 28704 | 11:11:02 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35398/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:02 INFO - PROCESS | 28704 | RSS: Main: 157880320 11:11:02 INFO - PROCESS | 28704 | 11:11:04 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:05 INFO - PROCESS | 28704 | RSS: Main: 157667328 11:11:05 INFO - PROCESS | 28704 | 11:11:07 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:07 INFO - PROCESS | 28704 | RSS: Main: 157949952 11:11:07 INFO - PROCESS | 28704 | 11:11:10 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:10 INFO - PROCESS | 28704 | RSS: Main: 158367744 11:11:10 INFO - PROCESS | 28704 | 11:11:13 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:14 INFO - PROCESS | 28704 | RSS: Main: 158142464 11:11:14 INFO - PROCESS | 28704 | 11:11:15 INFO - PROCESS | 28704 | Cycle 1(1): loaded http://localhost:35398/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35398/tests/kraken/driver.html?testName=ai-astar) 11:11:16 INFO - PROCESS | 28704 | RSS: Main: 159002624 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | __start_tp_report 11:11:16 INFO - PROCESS | 28704 | _x_x_mozilla_page_load 11:11:16 INFO - PROCESS | 28704 | _x_x_mozilla_page_load_details 11:11:16 INFO - PROCESS | 28704 | |i|pagename|runs| 11:11:16 INFO - PROCESS | 28704 | |0;ai-astar;112;105;111;110;112;111;111;112;110;111 11:11:16 INFO - PROCESS | 28704 | |1;audio-beat-detection;159;126;150;172;129;163;162;133;189;129 11:11:16 INFO - PROCESS | 28704 | |2;audio-dft;161;162;162;162;162;166;162;164;160;163 11:11:16 INFO - PROCESS | 28704 | |3;audio-fft;75;76;76;177;78;82;76;75;168;76 11:11:16 INFO - PROCESS | 28704 | |4;audio-oscillator;87;85;160;84;84;84;145;84;86;141 11:11:16 INFO - PROCESS | 28704 | |5;imaging-gaussian-blur;117;118;117;117;118;118;117;117;119;117 11:11:16 INFO - PROCESS | 28704 | |6;imaging-darkroom;147;148;148;148;147;149;146;147;148;147 11:11:16 INFO - PROCESS | 28704 | |7;imaging-desaturate;95;95;97;95;96;96;96;95;95;95 11:11:16 INFO - PROCESS | 28704 | |8;json-parse-financial;51;55;53;53;53;53;52;53;52;63 11:11:16 INFO - PROCESS | 28704 | |9;json-stringify-tinderbox;60;60;59;59;61;60;59;59;59;59 11:11:16 INFO - PROCESS | 28704 | |10;stanford-crypto-aes;76;77;76;82;81;79;77;79;103;77 11:11:16 INFO - PROCESS | 28704 | |11;stanford-crypto-ccm;122;130;119;127;120;125;117;124;132;133 11:11:16 INFO - PROCESS | 28704 | |12;stanford-crypto-pbkdf2;159;156;159;157;159;158;158;160;160;157 11:11:16 INFO - PROCESS | 28704 | |13;stanford-crypto-sha256-iterative;62;64;66;62;65;62;62;61;62;61 11:11:16 INFO - PROCESS | 28704 | __end_tp_report 11:11:16 INFO - PROCESS | 28704 | __start_cc_report 11:11:16 INFO - PROCESS | 28704 | _x_x_mozilla_cycle_collect,841 11:11:16 INFO - PROCESS | 28704 | __end_cc_report 11:11:16 INFO - PROCESS | 28704 | __startTimestamp1470334276064__endTimestamp 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | ------- Summary: start ------- 11:11:16 INFO - PROCESS | 28704 | Number of tests: 14 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.12 11:11:16 INFO - PROCESS | 28704 | Values: 112.0 105.0 111.0 110.0 112.0 111.0 111.0 112.0 110.0 111.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:160.50 stddev:21.43 (13.3%) stddev-sans-first:22.54 11:11:16 INFO - PROCESS | 28704 | Values: 159.0 126.0 150.0 172.0 129.0 163.0 162.0 133.0 189.0 129.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.65 (1.0%) stddev-sans-first:1.67 11:11:16 INFO - PROCESS | 28704 | Values: 161.0 162.0 162.0 162.0 162.0 166.0 162.0 164.0 160.0 163.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:40.48 (53.3%) stddev-sans-first:42.22 11:11:16 INFO - PROCESS | 28704 | Values: 75.0 76.0 76.0 177.0 78.0 82.0 76.0 75.0 168.0 76.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:84.00 stddev:31.20 (37.1%) stddev-sans-first:32.48 11:11:16 INFO - PROCESS | 28704 | Values: 87.0 85.0 160.0 84.0 84.0 84.0 145.0 84.0 86.0 141.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 11:11:16 INFO - PROCESS | 28704 | Values: 117.0 118.0 117.0 117.0 118.0 118.0 117.0 117.0 119.0 117.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 11:11:16 INFO - PROCESS | 28704 | Values: 147.0 148.0 148.0 148.0 147.0 149.0 146.0 147.0 148.0 147.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 11:11:16 INFO - PROCESS | 28704 | Values: 95.0 95.0 97.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:3.39 (6.4%) stddev-sans-first:3.44 11:11:16 INFO - PROCESS | 28704 | Values: 51.0 55.0 53.0 53.0 53.0 53.0 52.0 53.0 52.0 63.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 11:11:16 INFO - PROCESS | 28704 | Values: 60.0 60.0 59.0 59.0 61.0 60.0 59.0 59.0 59.0 59.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:78.00 stddev:8.10 (10.4%) stddev-sans-first:8.41 11:11:16 INFO - PROCESS | 28704 | Values: 76.0 77.0 76.0 82.0 81.0 79.0 77.0 79.0 103.0 77.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.55 (4.4%) stddev-sans-first:5.78 11:11:16 INFO - PROCESS | 28704 | Values: 122.0 130.0 119.0 127.0 120.0 125.0 117.0 124.0 132.0 133.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.00 stddev:1.34 (0.8%) stddev-sans-first:1.39 11:11:16 INFO - PROCESS | 28704 | Values: 159.0 156.0 159.0 157.0 159.0 158.0 158.0 160.0 160.0 157.0 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - PROCESS | 28704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.00 stddev:1.70 (2.7%) stddev-sans-first:1.79 11:11:16 INFO - PROCESS | 28704 | Values: 62.0 64.0 66.0 62.0 65.0 62.0 62.0 61.0 62.0 61.0 11:11:16 INFO - PROCESS | 28704 | -------- Summary: end -------- 11:11:16 INFO - PROCESS | 28704 | 11:11:16 INFO - TEST-INFO | 28704: exit 0 11:11:16 INFO - TEST-OK | kraken | took 59959ms 11:11:16 INFO - SUITE-END | took 1169s 11:11:17 INFO - Completed test suite (00:19:29) 11:11:17 INFO - javascript benchmark 11:11:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7574.405324186525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.5499707539484, 3389.915252118695, 3415.1803567143884, 3419.162305235218, 3421.2644281479493, 5594.272744543208, 5643.9435605643985, 5684.431556844319, 5695.601307908448, 5713.514351280146, 5662.150677398392, 5690.174924635936, 5698.287714035746, 5704.3154821421485, 5720.342160651527, 5136.075506408845, 5181.222816577506, 5219.217117432378, 5248.868778280555, 5273.446288139748, 5137.434882162959, 5158.896822063556, 5242.951409718053, 5243.895122097556, 5250.422453530108, 5163.561097306733, 5183.2743415921805, 5184.429712731597, 5193.974030129844, 5196.246544251081, 5183.403908550508, 5252.0, 5255.500727430888, 5279.128943724281, 5283.101872681654, 4998.550130488274, 5060.3927528696795, 5147.948520514822, 5172.922406163911, 5220.738963051832, 5506.752196151183, 5548.140038294071, 5584.078627026576, 5593.272874526327, 5626.634268772557, 6081.847953801146, 6117.051856962178, 6125.5712100153005, 6127.6017058891475, 6130.570860039799, 5915.142304365843, 6074.696265186767, 6102.542309326818, 6208.844778880519, 6211.285702144266, 5724.771009159628, 5727.971360143214, 5731.36954934961, 5731.541476681856, 5759.856003599902, 6286.968565157145, 6291.591046581958, 6298.1812364392335, 6299.590526615755, 6308.243010838637, 5800.042992906123, 5806.477417032403, 5810.970945145247, 5864.736086876101, 5983.282006159288, 5993.61041532299, 6002.0996850472775, 6004.789832355934, 6014.609050411709, 6014.729337179838, 5926.851828704317, 5932.377100404482, 5956.702164891824, 5982.73077711504, 5984.162217289496, 5903.527717782567, 5977.79077732286, 6039.033754599331, 6057.182280392179, 6091.299500557404, 4639.489656137822, 4647.6281897448125, 4653.744044077608, 4661.533846615312, 4699.201135806921, 4126.814293356806, 4183.602557757008, 4184.560621134737, 4189.476315460567, 4211.1998720243055, 5759.712014399263, 5773.191753154561, 5779.190913272145, 5795.82612521625, 5808.767649293981, 6049.697515124226, 6076.726547305382, 6128.846778830565, 6148.1699970504305, 6157.261128664589, 5746.569007324468, 5901.3508514063415, 5904.793332233351, 5906.438888305604, 5909.763609455659, 5188.325517682752, 5194.168932970707, 5215.452377500384, 5244.396894357122, 5257.08001099806, 6411.487081033506, 6423.068655044993, 6436.645984470899, 6443.226812782403, 6450.516211284079, 5974.761009559743, 6051.667158306335, 6146.354632763585, 6163.537734669828, 6169.537284703575, 6297.874042519033, 6337.746490140343, 6351.2060992375955, 6358.650274234961, 6415.807525774234, 5925.674087925206, 5966.701664916824, 5989.071693887455, 5991.131285963598, 5991.580589358878, 6047.606905551301, 6126.548209434937, 6131.724072416663, 6135.110408990582, 6156.0, 5984.13230081627, 6013.128096426081, 6016.849578760566, 6022.8795424090395, 6043.214382130471, 6006.039033754579, 6017.699115044143, 6037.094435834484, 6054.122152287981, 6057.030875059969, 5731.369549349652, 5783.855403614775, 5859.062549991981, 5883.0293001654245, 5912.260967379078, 5979.701014949148, 6030.7889223876955, 6036.879262414639, 6039.909401358896, 6041.939580604314, 5736.225609542658, 5927.407259274038, 5930.644161350333, 5933.554983376178, 5934.881302374015], "value": 5624.8282183530755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.1398401342033, 635.2789583822362, 643.33093582674, 653.5523166630857, 670.8054664147397, 41413.378799317994, 46562.30156547655, 46774.2983855242, 46775.29837052447, 46999.0, 47058.0, 47510.049799004, 47631.52368476314, 47636.0, 47648.28527572089, 8973.820523589524, 9110.27117830572, 9123.589438475252, 9123.95438022809, 9130.863037054416, 8956.462612243253, 9043.321750868678, 9049.954750226272, 9058.23005044572, 9076.682316118937, 9122.543872806333, 9138.314626403013, 9140.085991400872, 9195.540222988824, 9210.585523651453, 9025.32310076747, 9065.365424420293, 9077.95461022694, 9111.179993800557, 9119.133682300171, 9034.14175653312, 9114.179723824887, 9131.315151363675, 9154.31342649304, 9162.816743665157, 43228.78385608083, 43642.78178609118, 43667.56332436667, 43672.12655746867, 43809.78095109536, 3615.189974298182, 3710.2950439416422, 3745.4943582616543, 3896.181801821621, 3942.6845852331744, 32899.50650740241, 33820.323593528236, 34009.82995085033, 34087.318253635036, 34444.6555534444, 4734.384530011111, 4741.359916411275, 4754.0967216229155, 4772.2125849234835, 4783.306420568998, 389902.0, 391418.0, 391953.0, 392705.0, 393213.0, 35418.114547136014, 63089.0, 64120.0, 64181.679091604245, 64217.35782642114, 37816.0, 39908.20183596312, 40058.799706001286, 40139.0, 40378.79810600928, 17335.479935601954, 17570.736438953427, 17587.0, 17591.472255832345, 17611.735823962652, 14586.41654333836, 14628.926855365655, 14746.852531474762, 14777.556673299818, 14779.63050923714, 9418.858717119248, 9420.764480887896, 9425.811483770287, 9509.5720692569, 9559.474228917337, 3502.562179727534, 3581.2658405026905, 3589.623089575557, 3596.532450781434, 3615.258871931248, 1095.4084794211037, 1096.7751610919743, 1100.3287994323457, 1126.52122847791, 1177.770334784726, 32656.510152347735, 32758.18104547358, 32898.83550582232, 33347.0, 33477.83261083728, 1144.3877525523972, 1212.5695378140633, 1213.9984512776994, 1252.655519732081, 1262.9621111366673, 16764.245608947625, 16824.74762878558, 16954.660906781795, 17010.574735631708, 17070.40253591143, 607609.0, 616549.0, 637158.0, 637305.0, 641681.0, 62110.37889621136, 62456.375436245056, 62687.6865615669, 62775.058374124426, 62933.68533157305, 1471.2937789860712, 1490.4261859184292, 1494.155801971904, 1517.0291013751207, 1520.049968769519, 32008.6799132015, 32627.0, 32972.340553188325, 33042.504362434105, 33441.33117337591, 53474.0, 54118.0, 54370.7281463606, 54385.72807135939, 54421.45578544164, 340431.0, 341445.0, 343764.0, 345656.0, 346646.0, 30760.0, 31040.0, 31194.376112478076, 31357.372852543278, 31634.0, 48411.0, 48772.5122748768, 49072.509274908225, 49301.52095437142, 49355.50644493509, 41295.7935210322, 41686.791566041975, 42099.7895010523, 43038.35442468428, 43151.784241078596, 33941.66058339385, 34129.829350853084, 34365.65634343625, 34603.826980864935, 35098.82450587731, 40631.7968410156, 40928.18143637051, 41000.0, 41766.37350439685, 42434.57565424306, 35035.29929401448, 36067.81966090153, 36195.27609447849, 36476.63523364732, 36888.07779805419, 28589.142325730263, 28673.0, 28690.426191476472, 28819.855900721202, 29130.27174320659], "value": 19797.47882511864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.06273666565244, 427.9486461624605, 430.36306266725245, 431.7150680550837, 438.163108462836, 18310.176042078107, 19330.323438679665, 20280.391588252358, 20281.797182028175, 20455.693164602544, 18985.715214271797, 19003.809961900377, 19832.826747720366, 20096.497587560283, 20179.29372471964, 5522.530584900278, 5739.684317362543, 5752.0, 5758.0, 5770.538356931435, 5562.110062390018, 5654.462826031541, 5681.204631351614, 5709.115087161496, 5717.8570535736735, 5694.259746232984, 5711.543076553866, 5718.313802343704, 5720.628159169641, 5724.227229324029, 5592.3009623797025, 5644.322681278232, 5696.430356964312, 5712.971435142818, 5730.36965933747, 5106.285120083191, 5132.0249152661245, 5133.307003554547, 5139.8458046258675, 5167.689938603696, 22140.88929555358, 23678.763212368, 23798.405039874142, 24358.512829743308, 24534.509309813882, 2517.1819158773474, 2518.4333524956924, 2531.0, 2561.4877024595157, 2563.83335083219, 14474.927625361912, 14552.490662826856, 15307.846921530754, 15463.845361546353, 15564.37742490299, 2009.7588289405219, 2051.651219292724, 2066.4730493724005, 2075.962018990505, 2106.2943913788745, 69730.0, 74082.25917740808, 75455.0, 76811.61594192049, 78542.0, 11074.833877491845, 11679.88320116805, 11918.225315354648, 11960.461779219955, 11971.820422693667, 16616.916915415346, 16677.332906683598, 16734.4142954996, 16748.078855663054, 16761.0, 8789.296856251485, 8822.955885220534, 8827.823443531222, 8843.0, 8917.41394995457, 8425.4944703318, 8429.957850210832, 8493.108223636553, 8502.532360720095, 8603.655853765778, 5080.13637681595, 5126.948730512721, 5128.743562821844, 5141.203113517411, 5176.818811341585, 2101.243552321163, 2109.7890210979085, 2176.4232478393237, 2180.465785882469, 2190.211523851412, 1020.0921180149672, 1021.3004092196869, 1073.044989958937, 1078.82199437092, 1097.6981330134277, 19091.140898659316, 19173.424797256106, 19378.515537111685, 19380.612387752168, 19964.0, 1052.3422860712055, 1085.9511321990528, 1116.413882711583, 1118.4910865556153, 1135.1486385211092, 10693.518791654395, 10983.61557345489, 11016.669499915015, 11017.228793984505, 11166.609168679057, 468449.0, 481539.0, 482395.0, 483228.0, 484093.0, 84907.0, 89308.5534572336, 91381.54309228412, 92310.0, 92509.53745231366, 1060.6234786650627, 1130.5421304371744, 1135.0238794636605, 1135.28477059452, 1136.693092864922, 17516.0, 17604.119794010505, 17611.0, 17925.0, 18120.456386308433, 41304.58695413007, 42009.0, 42526.57473425226, 43239.135217296105, 44275.778621106685, 51283.74358128185, 54272.45727542832, 55207.17189242245, 60929.0, 61414.0, 8628.094050124646, 8658.870116948377, 8695.782605434915, 8743.519106448952, 8806.867896981423, 9573.856392154263, 13346.357717691633, 13453.663658408617, 13641.249731264876, 13649.38577763983, 11875.109366797698, 12109.636710898687, 12242.265464072185, 12316.261024338568, 12371.876281237432, 10928.617498387519, 11436.599719009795, 11574.768504629692, 11675.88324116748, 12019.0, 11874.881251187378, 12146.0, 12177.0, 12248.020158387486, 12536.561220357244, 8634.56827158652, 8671.4363566368, 8730.301575874042, 8765.167309105625, 8837.646494140163, 8365.62354694028, 11491.942540287246, 11567.76864462723, 11605.709857253636, 11695.590654327058], "value": 9551.726559044944, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.129536164386, 1595.6728870581528, 1770.6547223291464, 1812.8368446839781, 1906.247032422194, 8371.330293576515, 9047.14052165045, 9465.574049167786, 9713.417194968299, 9727.659531916384, 9108.635654573825, 9127.817443651124, 9192.034836342187, 9194.264458843294, 9207.493587852665, 2487.9626805597886, 2529.051605647882, 2529.3423709835392, 2529.734377890323, 2530.5192013517467, 2480.962785558218, 2514.0, 2514.4845306712173, 2518.4333524956924, 2521.0, 2461.3477428481465, 2477.52926943881, 2493.7880280176205, 2504.111040580595, 2504.6368276599883, 2442.3894026493376, 2458.0, 2460.59400198967, 2461.7661322174363, 2493.2395619336185, 2471.0980492120248, 2475.084218839023, 2497.675302210701, 2497.8501289922665, 2500.087468074158, 9360.953195234048, 9451.243900487945, 9506.952465237699, 9510.048995100504, 9534.761630959212, 5543.1408131739645, 5726.169705392736, 5728.770849166029, 5729.255196824428, 5735.340435849889, 3571.089372210096, 3645.434957581579, 3717.3494638438438, 3751.1184871555433, 3767.962320376816, 1148.5520646947698, 1168.1881092640617, 1174.0959461214902, 1209.7217639942774, 1210.2617403384018, 13458.865411345958, 13483.932580337134, 13507.054506184571, 13508.79736803939, 13577.59267221985, 4688.296755486705, 4704.08270387278, 4807.399075115611, 4860.708357498562, 4881.95118048822, 11200.0, 11271.0, 11343.092552595772, 11345.489452974636, 11373.431328433546, 5674.2339784129435, 5739.339975902742, 5745.511631511285, 5747.885042299215, 5783.566232532577, 4545.863624091283, 5050.520200580939, 5215.217717342429, 5231.973840130851, 5287.154055351125, 4289.742615443083, 4302.505211900609, 4319.049809042006, 4384.912301753947, 4400.295952647561, 1334.3595074364166, 1335.3189873164756, 1344.8117263583106, 1345.7173993461288, 1354.4852955876902, 924.9445033298024, 1034.162328513891, 1043.9791204175874, 1056.2447849787438, 1077.0521940692297, 6209.627422354673, 6410.391012853772, 6557.934420655828, 6574.474042076622, 6687.598744075371, 475.2704598441376, 487.7219984608739, 488.6896820518996, 490.2694984473181, 497.47267896030326, 4554.544545545419, 4579.679422440464, 4605.815767369335, 4611.884702882455, 4645.9303110453375, 11350.602728904449, 11624.302541847515, 12019.87980120205, 12110.939445302716, 12127.0, 11929.343886086175, 11946.10404219687, 11955.16313858039, 11992.280463172237, 12015.939920300343, 8650.91349086501, 8859.778505537284, 8884.111588841193, 8889.066648001995, 8891.777705557413, 6541.803745887631, 6693.497987650849, 6724.49566282521, 6734.191896972395, 6819.522633415613, 10543.894561054598, 10662.466876656292, 10811.405372704263, 10902.18233632465, 10902.236843420884, 10665.573377064831, 10842.349459032483, 10852.348859068481, 10896.346219226873, 10964.890351096386, 7399.519031262951, 7972.760817175494, 8137.6338064788415, 8373.371997100363, 8504.277136443225, 9189.172974432066, 9214.585343659417, 9215.124563166488, 9288.860667090134, 9290.256779457492, 7964.681412743657, 8059.838803223785, 8143.144969778088, 8143.307818835466, 8201.917980820115, 7915.0, 8101.230383113595, 8210.220029097227, 8249.133840946854, 8488.490690558587, 7490.325870671666, 7606.885896711443, 7718.035245594301, 7726.845463090594, 7736.497127686683, 5901.645901245939, 5902.2327097477055, 5934.970325148347, 5948.256467941507, 5996.190514280691, 5843.211166492469, 5922.318933322723, 5948.434898684618, 5983.880322393441, 5993.160957465871], "value": 4919.183558788321, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.68524170867073, 367.68746565419394, 367.96688298053186, 369.67837980956574, 373.34850685553715, 5611.719414029302, 5657.57568182387, 5685.630434021786, 5736.139579063142, 5794.956907756602, 5652.689102099383, 5690.260266165403, 5696.231008813809, 5699.715014249292, 5718.685472299022, 4498.370228168051, 4506.909861802762, 4522.570355816192, 4542.0, 4542.682012259143, 4439.866803995886, 4490.7530085845265, 4490.842820501283, 4494.213587575691, 4533.297338912457, 4418.172369683389, 4419.033530079116, 4426.535213802553, 4474.619657329131, 4480.775961201944, 4330.415393921811, 4468.798904049309, 4476.418065651477, 4495.1459222747735, 4505.301678239878, 3925.9203718977224, 3944.1717239379764, 3947.703922205846, 3952.920941581181, 3957.8126562031275, 5558.360788509332, 5568.972155139239, 5573.0, 5576.052071147915, 5596.244506991545, 5029.667138208378, 5064.670796398259, 5114.43741188469, 5133.768980395854, 5180.834312279744, 5925.377835327272, 5948.512871782054, 5970.0, 5995.160677505153, 5999.990003348883, 4290.442242508454, 4293.849715259951, 4322.113966636832, 4327.112941846945, 4345.50026746925, 6090.634561926298, 6225.782097626561, 6236.469900058501, 6305.68471576424, 6385.477736294184, 4380.912381752347, 4411.2941929291155, 4411.691181617321, 4414.3157810539415, 4434.357018232338, 4487.237169681162, 4489.259272220047, 4494.988627558773, 4501.234790085693, 4502.932456013163, 5015.272785446163, 5092.2361645753435, 5124.256982737482, 5129.9743501282255, 5131.358580177478, 5866.413358664185, 5983.948186424955, 5992.43071908168, 6003.849903752353, 6075.0, 1513.6528489644224, 1514.545636309103, 1516.651170230853, 1523.7638166084275, 1527.4043123181968, 977.6996594529259, 985.7042887133831, 992.5880759484733, 993.7118235711563, 1014.9441780702132, 5193.143131383355, 5294.391145018372, 5329.760160792696, 5400.864978375494, 5412.458754124635, 5577.609567330248, 5616.326040875121, 5618.91571626426, 5624.240727501817, 5633.69014704187, 5282.049231138355, 5369.926014797056, 5510.504054635102, 5899.115132730039, 5976.193213916153, 3269.836508174629, 3289.881440310306, 3290.769646124796, 3315.9834200829323, 3332.4670651500583, 6205.906911396332, 6456.3543645636, 6456.935430645727, 6481.675916204171, 6495.577787443801, 6300.495960323163, 6324.557280990287, 6326.367363263729, 6342.270638876588, 6345.90481142774, 6387.265464471552, 6423.743050277936, 6444.677766111676, 6469.288378278386, 6469.385408386196, 5925.259342582177, 6230.190075290183, 6245.219347581552, 6256.687165641609, 6259.812205633838, 6158.614311779814, 6163.876722465436, 6170.290416601969, 6171.9074213887725, 6177.2587289525545, 6282.3089460158435, 6422.293547709842, 6464.676766161767, 6483.319251478527, 6494.9025764612625, 4363.650907927295, 4376.649868010615, 4378.343248512749, 4392.506547773773, 4402.801873915618, 6050.788222412194, 6236.438720515175, 6244.875102498016, 6249.312575616769, 6269.429533891082, 6014.518838492998, 6019.849503762441, 6029.758809647565, 6039.849003774941, 6048.7278072487725, 6001.969990150196, 6021.157038014769, 6026.8548975694475, 6050.6369617823075, 6063.72713227897, 5668.433156684298, 5976.97011514957, 5992.513107060521, 6003.609765365237, 6026.0, 6080.841301337961, 6083.448720576224, 6107.694615269308, 6107.755689772359, 6129.0, 5664.688442135722, 5982.461578457785, 5983.700814959322, 5986.880262394815, 5994.340622531605], "value": 4575.034961598821, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.709584549562, 807.2008711375738, 814.3241109878797, 834.6119054639591, 847.1824689174945, 15115.0, 16331.428400006002, 16356.34574617017, 16358.182090895452, 16398.18009099546, 14784.482543110993, 14911.030782999098, 14921.253937303145, 14927.40290388383, 14934.925325373359, 853.5433543054452, 860.535310932096, 871.5075982070142, 873.8689196620526, 880.1946219209416, 864.7276108025983, 868.1405408645427, 871.5032431514039, 871.5859966515918, 871.7776966873438, 923.6443969071922, 924.0528458330198, 924.3160061554469, 926.1294383279729, 926.1988380051274, 913.0686699566438, 914.2046419614944, 916.9541522923894, 917.7063339731322, 920.0293690156882, 674.5042393840523, 675.1830285354727, 676.0096458688046, 676.3473248315399, 676.8409423785406, 15854.603634909105, 15894.0, 16006.519804405887, 16007.27967241477, 16028.439004634782, 15113.0, 15159.317830697644, 15286.541403757905, 15286.847131528653, 15540.06759594428, 12624.621261362174, 12629.368531573384, 12653.683657908534, 12717.745645087047, 12763.234205947672, 4083.8774836754947, 4084.5098588169312, 4092.611201935841, 4128.545859955402, 4248.214080395106, 79756.60121699412, 80631.596842016, 81237.59381203115, 81281.0, 82699.0, 11814.645560633024, 11955.581554645545, 12047.939760301142, 12092.576759813364, 12192.268463892195, 20647.69028464574, 20672.896635517027, 20834.374968750963, 20928.16287348489, 21206.893965530384, 8536.74389768308, 8613.22480976715, 8704.260137888225, 8791.428557143765, 8950.060243674321, 4999.875003124878, 5142.331496905378, 5191.922121168185, 5216.58267338612, 5253.973730131325, 3856.537215534154, 3973.384125460558, 3980.8805735827973, 3985.740926839746, 3988.1824226033596, 658.6278752504819, 663.9070530125787, 672.4284358295507, 680.7481231944113, 681.7341236917606, 678.8163513123435, 696.2202333386639, 704.6018999265399, 704.630069213667, 719.6437763307197, 10250.58997640101, 10352.948235258775, 10600.787984240273, 10612.522436490377, 10649.0, 658.9011648252705, 702.4205030849467, 720.6396801599201, 744.2260049548518, 751.8721817291074, 4774.474807771142, 4840.467548569654, 4864.805407783649, 4881.877953051202, 4939.975300123549, 73382.0, 92595.0, 114234.0, 120219.39890300493, 123149.38425307815, 64876.02685959714, 89741.10258897458, 97410.0, 104547.0, 105599.0, 91576.0, 93021.5348923251, 93549.53225233694, 97129.0, 97175.51412243035, 9155.725328240163, 9276.768080798034, 9475.620975160917, 9562.760930976503, 9612.903870961201, 46106.30840537462, 53841.73079134579, 54075.72962135164, 54135.729321353145, 55488.72255638696, 75661.0, 75793.0, 77308.2269177301, 78528.0, 79481.0, 13694.794578081535, 13874.23691696926, 13961.0, 14145.222012789396, 14295.428182872569, 14788.556343309718, 14789.556313310617, 14916.477923272634, 14989.0, 15592.986455880331, 14041.648958776112, 14062.156270623795, 14125.081869678437, 14152.363143658355, 14398.85601144017, 13837.930810345884, 14198.858011419754, 14235.074720143157, 14454.494092706705, 14561.635959101108, 13237.205767653586, 13494.460221591418, 13651.726965460437, 13852.72294554083, 14230.35963381671, 11220.326780393203, 11336.716582085513, 11424.885751142383, 11580.826287605862, 11585.0, 11820.0, 12270.75458490843, 12387.75224495487, 12388.442520086797, 12459.439325230567], "value": 7887.945807915062, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 112.0, 111.0, 111.0, 112.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 126.0, 150.0, 172.0, 129.0, 163.0, 162.0, 133.0, 189.0, 129.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 162.0, 166.0, 162.0, 164.0, 160.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 177.0, 78.0, 82.0, 76.0, 75.0, 168.0, 76.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 160.0, 84.0, 84.0, 84.0, 145.0, 84.0, 86.0, 141.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 119.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 149.0, 146.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 55.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 52.0, 63.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 59.0, 61.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 82.0, 81.0, 79.0, 77.0, 79.0, 103.0, 77.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 119.0, 127.0, 120.0, 125.0, 117.0, 124.0, 132.0, 133.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 159.0, 157.0, 159.0, 158.0, 158.0, 160.0, 160.0, 157.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 66.0, 62.0, 65.0, 62.0, 62.0, 61.0, 62.0, 61.0], "value": 62.7, "unit": "score"}]}]} 11:11:17 INFO - Return code: 0 11:11:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:17 ERROR - # TBPL SUCCESS # 11:11:17 INFO - Running post-action listener: _resource_record_post_action 11:11:17 INFO - ##### 11:11:17 INFO - ##### Finished run-tests step (success) 11:11:17 INFO - ##### 11:11:17 INFO - Running post-run listener: _resource_record_post_run 11:11:17 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 28672; Write bytes: 459489280; Read time: 20; Write time: 332988 11:11:17 INFO - TinderboxPrint: CPU usage
13.3% 11:11:17 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 20 11:11:17 INFO - TinderboxPrint: I/O write bytes / time
459,489,280 / 332,988 11:11:17 INFO - TinderboxPrint: CPU idle
8,191.6 (86.7%) 11:11:17 INFO - TinderboxPrint: CPU user
1,205.9 (12.8%) 11:11:17 INFO - TinderboxPrint: Swap in / out
0 / 0 11:11:17 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 235606016; Read time: 0; Write time: 218916 11:11:17 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 223883264; Read time: 8; Write time: 114072 11:11:18 INFO - Running post-run listener: _upload_blobber_files 11:11:18 INFO - Blob upload gear active. 11:11:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:18 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:11:18 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:18 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:11:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:11:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:19 INFO - (blobuploader) - INFO - Done attempting. 11:11:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:28 INFO - (blobuploader) - INFO - Done attempting. 11:11:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:11:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:11:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:29 INFO - (blobuploader) - INFO - Done attempting. 11:11:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:29 INFO - Return code: 0 11:11:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ca4c165f2eb4a949aa42940c36cd54793149800dd99c63b4719d19ca58844572cc4673beec9238187c98e8de8c28e9361a9e8b2d43e90fff572e58b58405c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2d5c1e18ec17ba60f4b9f912c3c62f524348fa311a85f74664070651b88421c530eaf09e27f41cd9cf185ac2092a1af12227e8f0a828ad849d5a70ffee8cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/782b02c9e8e5692a098b94a0654518bab00e79ac25924242ca605b593e75a572016615157c48ade547e67d29ce03e831767f7884baebda33209154229151c40c"} 11:11:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:29 INFO - Contents: 11:11:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ca4c165f2eb4a949aa42940c36cd54793149800dd99c63b4719d19ca58844572cc4673beec9238187c98e8de8c28e9361a9e8b2d43e90fff572e58b58405c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2d5c1e18ec17ba60f4b9f912c3c62f524348fa311a85f74664070651b88421c530eaf09e27f41cd9cf185ac2092a1af12227e8f0a828ad849d5a70ffee8cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/782b02c9e8e5692a098b94a0654518bab00e79ac25924242ca605b593e75a572016615157c48ade547e67d29ce03e831767f7884baebda33209154229151c40c"} 11:11:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:29 INFO - Copying logs to upload dir... 11:11:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.176534 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-08-04 11:11:29.334778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:29.340868) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 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-Beta/sha512/96ca4c165f2eb4a949aa42940c36cd54793149800dd99c63b4719d19ca58844572cc4673beec9238187c98e8de8c28e9361a9e8b2d43e90fff572e58b58405c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2d5c1e18ec17ba60f4b9f912c3c62f524348fa311a85f74664070651b88421c530eaf09e27f41cd9cf185ac2092a1af12227e8f0a828ad849d5a70ffee8cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/782b02c9e8e5692a098b94a0654518bab00e79ac25924242ca605b593e75a572016615157c48ade547e67d29ce03e831767f7884baebda33209154229151c40c"} build_url:https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/MSjqk_MrRGSdsXUGfGL6wg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/96ca4c165f2eb4a949aa42940c36cd54793149800dd99c63b4719d19ca58844572cc4673beec9238187c98e8de8c28e9361a9e8b2d43e90fff572e58b58405c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5a2d5c1e18ec17ba60f4b9f912c3c62f524348fa311a85f74664070651b88421c530eaf09e27f41cd9cf185ac2092a1af12227e8f0a828ad849d5a70ffee8cc1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/782b02c9e8e5692a098b94a0654518bab00e79ac25924242ca605b593e75a572016615157c48ade547e67d29ce03e831767f7884baebda33209154229151c40c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:29.365800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:29.366204) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1470333017.219593-2014306953 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:29.416247) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:11:29.416624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:11:29.416958) ========= ========= Total master_lag: 0.27 =========