builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-040 starttime: 1465500505.45 results: success (0) buildid: 20160609095531 builduid: 0f9345d66527428d978b57a8a271bbda revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.452964) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.453770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.454150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.470944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.471863) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 12:28:25-- 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% 41.8M=0s 2016-06-09 12:28:25 (41.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109767 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.600260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.600659) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022325 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.657072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:25.657436) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a11eb3fab3c603e2b13f8185db8e1815b44d8692 --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=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 12:28:25,800 truncating revision to first 12 chars 2016-06-09 12:28:25,800 Setting DEBUG logging. 2016-06-09 12:28:25,800 attempt 1/10 2016-06-09 12:28:25,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a11eb3fab3c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 12:28:26,206 unpacking tar archive at: mozilla-aurora-a11eb3fab3c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.756139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:26.433886) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:26.434462) ========= script_repo_revision: a11eb3fab3c603e2b13f8185db8e1815b44d8692 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:26.435389) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:26.436112) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 12:28:26.447279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-09 12:28:26.447617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:28:26 INFO - MultiFileLogger online at 20160609 12:28:26 in /builds/slave/test 12:28:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:28:26 INFO - {'append_to_log': False, 12:28:26 INFO - 'base_work_dir': '/builds/slave/test', 12:28:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:28:26 INFO - 'branch': 'Mozilla-Aurora', 12:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:28:26 INFO - 'config_files': ('talos/linux_config.py',), 12:28:26 INFO - 'default_actions': ('clobber', 12:28:26 INFO - 'read-buildbot-config', 12:28:26 INFO - 'download-and-extract', 12:28:26 INFO - 'populate-webroot', 12:28:26 INFO - 'create-virtualenv', 12:28:26 INFO - 'install', 12:28:26 INFO - 'run-tests'), 12:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:28:26 INFO - 'download_minidump_stackwalk': True, 12:28:26 INFO - 'download_symbols': 'ondemand', 12:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:28:26 INFO - 'installer_path': 'installer.exe', 12:28:26 INFO - 'log_level': 'info', 12:28:26 INFO - 'log_name': 'talos', 12:28:26 INFO - 'log_to_console': True, 12:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:28:26 INFO - 'opt_config_files': (), 12:28:26 INFO - 'pip_index': False, 12:28:26 INFO - 'sps_profile': False, 12:28:26 INFO - 'sps_profile_interval': 0, 12:28:26 INFO - 'suite': 'dromaeojs-e10s', 12:28:26 INFO - 'system_bits': '32', 12:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:28:26 INFO - 'title': 'talos-linux64-ix-040', 12:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:28:26 INFO - 'use_talos_json': True, 12:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:28:26 INFO - 'work_dir': 'build'} 12:28:26 INFO - ##### 12:28:26 INFO - ##### Running clobber step. 12:28:26 INFO - ##### 12:28:26 INFO - Running pre-action listener: _resource_record_pre_action 12:28:26 INFO - Running main action method: clobber 12:28:26 INFO - rmtree: /builds/slave/test/build 12:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:28:27 INFO - Running post-action listener: _resource_record_post_action 12:28:27 INFO - ##### 12:28:27 INFO - ##### Finished clobber step (success) 12:28:27 INFO - ##### 12:28:27 INFO - ##### 12:28:27 INFO - ##### Running read-buildbot-config step. 12:28:27 INFO - ##### 12:28:27 INFO - Running pre-action listener: _resource_record_pre_action 12:28:27 INFO - Running main action method: read_buildbot_config 12:28:27 INFO - Using buildbot properties: 12:28:27 INFO - { 12:28:27 INFO - "project": "", 12:28:27 INFO - "product": "firefox", 12:28:27 INFO - "script_repo_revision": "production", 12:28:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:28:27 INFO - "repository": "", 12:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:28:27 INFO - "buildid": "20160609095531", 12:28:27 INFO - "pgo_build": "True", 12:28:27 INFO - "basedir": "/builds/slave/test", 12:28:27 INFO - "buildnumber": 346, 12:28:27 INFO - "slavename": "talos-linux64-ix-040", 12:28:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:28:27 INFO - "platform": "ubuntu64_hw", 12:28:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:28:27 INFO - "branch": "mozilla-aurora", 12:28:27 INFO - "repo_path": "releases/mozilla-aurora", 12:28:27 INFO - "revision": "a11eb3fab3c603e2b13f8185db8e1815b44d8692", 12:28:27 INFO - "stage_platform": "linux64-pgo", 12:28:27 INFO - "builduid": "0f9345d66527428d978b57a8a271bbda", 12:28:27 INFO - "slavebuilddir": "test" 12:28:27 INFO - } 12:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 12:28:27 INFO - Running post-action listener: _resource_record_post_action 12:28:27 INFO - ##### 12:28:27 INFO - ##### Finished read-buildbot-config step (success) 12:28:27 INFO - ##### 12:28:27 INFO - ##### 12:28:27 INFO - ##### Running download-and-extract step. 12:28:27 INFO - ##### 12:28:27 INFO - Running pre-action listener: _resource_record_pre_action 12:28:27 INFO - Running main action method: download_and_extract 12:28:27 INFO - mkdir: /builds/slave/test/build/tests 12:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:27 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:28:34 INFO - Downloaded 1361 bytes. 12:28:34 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 12:28:34 INFO - Using the following test package requirements: 12:28:34 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:28:34 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:28:34 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:28:34 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'jsshell-linux-x86_64.zip'], 12:28:34 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:28:34 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 12:28:34 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:28:34 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:28:34 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:28:34 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 12:28:34 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:28:34 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:34 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:28:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:28:46 INFO - Downloaded 24473748 bytes. 12:28:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:28:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:28:47 INFO - Return code: 0 12:28:47 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:47 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 12:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:28:50 INFO - Downloaded 24473748 bytes. 12:28:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:28:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:28:51 INFO - Return code: 0 12:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:51 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:28:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:28:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:28:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 12:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:28:52 INFO - Downloaded 10833369 bytes. 12:28:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:28:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:28:52 INFO - Return code: 0 12:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:52 INFO - https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:28:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:28:54 INFO - Downloaded 63559230 bytes. 12:28:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:54 INFO - mkdir: /builds/slave/test/properties 12:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 12:28:54 INFO - Contents: 12:28:54 INFO - build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 12:28:54 INFO - Running post-action listener: _resource_record_post_action 12:28:54 INFO - Running post-action listener: set_extra_try_arguments 12:28:54 INFO - ##### 12:28:54 INFO - ##### Finished download-and-extract step (success) 12:28:54 INFO - ##### 12:28:54 INFO - ##### 12:28:54 INFO - ##### Running populate-webroot step. 12:28:54 INFO - ##### 12:28:54 INFO - Running pre-action listener: _resource_record_pre_action 12:28:54 INFO - Running main action method: populate_webroot 12:28:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:28:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:28:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:28:54 INFO - '--tppagecycles', 12:28:54 INFO - '7'], 12:28:54 INFO - 'tests': ['tsvgm']}}, 12:28:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:28:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:28:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:28:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:28:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:28:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['damp', 'tps']}, 12:28:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'tests': ['damp', 'tps']}, 12:28:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['dromaeo_dom']}, 12:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:28:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'other-e10s': {'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['a11yr', 12:28:54 INFO - 'ts_paint', 12:28:54 INFO - 'tpaint', 12:28:54 INFO - 'sessionrestore', 12:28:54 INFO - 'sessionrestore_no_auto_restore', 12:28:54 INFO - 'tabpaint']}, 12:28:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['tsvgx', 12:28:54 INFO - 'tsvgr_opacity', 12:28:54 INFO - 'tart', 12:28:54 INFO - 'tscrollx', 12:28:54 INFO - 'cart']}, 12:28:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:28:54 INFO - 'tsvgr_opacity', 12:28:54 INFO - 'tart', 12:28:54 INFO - 'tscrollx', 12:28:54 INFO - 'cart']}, 12:28:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'talos_options': ['--disable-e10s'], 12:28:54 INFO - 'tests': ['tp5o']}, 12:28:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'tests': ['tp5o']}, 12:28:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'talos_options': ['--disable-e10s', 12:28:54 INFO - '--xperf_path', 12:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:54 INFO - 'tests': ['tp5n']}, 12:28:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:28:54 INFO - 'talos_options': ['--xperf_path', 12:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:28:54 INFO - 'tests': ['tp5n']}}, 12:28:54 INFO - 'talos.zip': {'path': '', 12:28:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:28:54 INFO - Running post-action listener: _resource_record_post_action 12:28:54 INFO - ##### 12:28:54 INFO - ##### Finished populate-webroot step (success) 12:28:54 INFO - ##### 12:28:54 INFO - ##### 12:28:54 INFO - ##### Running create-virtualenv step. 12:28:54 INFO - ##### 12:28:54 INFO - Running pre-action listener: _resource_record_pre_action 12:28:54 INFO - Running main action method: create_virtualenv 12:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 12:28:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:28:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:28:54 INFO - Using real prefix '/usr' 12:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:28:55 INFO - Installing distribute.............................................................................................................................................................................................done. 12:28:57 INFO - Installing pip.................done. 12:28:57 INFO - Return code: 0 12:28:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:57 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:28:57 INFO - Using env: {'DISPLAY': ':0', 12:28:57 INFO - 'HOME': '/home/cltbld', 12:28:57 INFO - 'LANG': 'en_US.UTF-8', 12:28:57 INFO - 'LANGUAGE': 'en_US:en', 12:28:57 INFO - 'LOGNAME': 'cltbld', 12:28:57 INFO - 'MAIL': '/var/mail/cltbld', 12:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:57 INFO - 'MOZ_NO_REMOTE': '1', 12:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:57 INFO - 'NO_EM_RESTART': '1', 12:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:57 INFO - 'PWD': '/builds/slave/test', 12:28:57 INFO - 'SHELL': '/bin/bash', 12:28:57 INFO - 'SHLVL': '1', 12:28:57 INFO - 'TERM': 'linux', 12:28:57 INFO - 'TMOUT': '86400', 12:28:57 INFO - 'USER': 'cltbld', 12:28:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:57 INFO - '_': '/tools/buildbot/bin/python'} 12:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:28:57 INFO - Cleaning up... 12:28:57 INFO - Return code: 0 12:28:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:28:57 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:28:57 INFO - Using env: {'DISPLAY': ':0', 12:28:57 INFO - 'HOME': '/home/cltbld', 12:28:57 INFO - 'LANG': 'en_US.UTF-8', 12:28:57 INFO - 'LANGUAGE': 'en_US:en', 12:28:57 INFO - 'LOGNAME': 'cltbld', 12:28:57 INFO - 'MAIL': '/var/mail/cltbld', 12:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:28:57 INFO - 'MOZ_NO_REMOTE': '1', 12:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:28:57 INFO - 'NO_EM_RESTART': '1', 12:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:28:57 INFO - 'PWD': '/builds/slave/test', 12:28:57 INFO - 'SHELL': '/bin/bash', 12:28:57 INFO - 'SHLVL': '1', 12:28:57 INFO - 'TERM': 'linux', 12:28:57 INFO - 'TMOUT': '86400', 12:28:57 INFO - 'USER': 'cltbld', 12:28:57 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:28:57 INFO - '_': '/tools/buildbot/bin/python'} 12:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:28:57 INFO - Downloading/unpacking psutil>=3.1.1 12:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:28:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:28:59 INFO - Installing collected packages: psutil 12:28:59 INFO - Running setup.py install for psutil 12:28:59 INFO - building 'psutil._psutil_linux' extension 12:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:29:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:29:00 INFO - building 'psutil._psutil_posix' extension 12:29:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:29:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:29:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:29:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:29:00 INFO - Successfully installed psutil 12:29:00 INFO - Cleaning up... 12:29:00 INFO - Return code: 0 12:29:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:00 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:29:00 INFO - Using env: {'DISPLAY': ':0', 12:29:00 INFO - 'HOME': '/home/cltbld', 12:29:00 INFO - 'LANG': 'en_US.UTF-8', 12:29:00 INFO - 'LANGUAGE': 'en_US:en', 12:29:00 INFO - 'LOGNAME': 'cltbld', 12:29:00 INFO - 'MAIL': '/var/mail/cltbld', 12:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:00 INFO - 'MOZ_NO_REMOTE': '1', 12:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:00 INFO - 'NO_EM_RESTART': '1', 12:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:00 INFO - 'PWD': '/builds/slave/test', 12:29:00 INFO - 'SHELL': '/bin/bash', 12:29:00 INFO - 'SHLVL': '1', 12:29:00 INFO - 'TERM': 'linux', 12:29:00 INFO - 'TMOUT': '86400', 12:29:00 INFO - 'USER': 'cltbld', 12:29:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:00 INFO - '_': '/tools/buildbot/bin/python'} 12:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:29:02 INFO - Installing collected packages: mozsystemmonitor 12:29:02 INFO - Running setup.py install for mozsystemmonitor 12:29:02 INFO - Successfully installed mozsystemmonitor 12:29:02 INFO - Cleaning up... 12:29:02 INFO - Return code: 0 12:29:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:02 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:29:02 INFO - Using env: {'DISPLAY': ':0', 12:29:02 INFO - 'HOME': '/home/cltbld', 12:29:02 INFO - 'LANG': 'en_US.UTF-8', 12:29:02 INFO - 'LANGUAGE': 'en_US:en', 12:29:02 INFO - 'LOGNAME': 'cltbld', 12:29:02 INFO - 'MAIL': '/var/mail/cltbld', 12:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:02 INFO - 'MOZ_NO_REMOTE': '1', 12:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:02 INFO - 'NO_EM_RESTART': '1', 12:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:02 INFO - 'PWD': '/builds/slave/test', 12:29:02 INFO - 'SHELL': '/bin/bash', 12:29:02 INFO - 'SHLVL': '1', 12:29:02 INFO - 'TERM': 'linux', 12:29:02 INFO - 'TMOUT': '86400', 12:29:02 INFO - 'USER': 'cltbld', 12:29:02 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:02 INFO - '_': '/tools/buildbot/bin/python'} 12:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:02 INFO - Downloading/unpacking jsonschema==2.5.1 12:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:29:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:04 INFO - Downloading functools32-3.2.3-2.tar.gz 12:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:29:05 INFO - warning: no files found matching '*.txt' 12:29:05 INFO - no previously-included directories found matching 'build' 12:29:05 INFO - no previously-included directories found matching 'dist' 12:29:05 INFO - no previously-included directories found matching '.git*' 12:29:05 INFO - Installing collected packages: jsonschema, functools32 12:29:05 INFO - Running setup.py install for functools32 12:29:05 INFO - warning: no files found matching '*.txt' 12:29:05 INFO - no previously-included directories found matching 'build' 12:29:05 INFO - no previously-included directories found matching 'dist' 12:29:05 INFO - no previously-included directories found matching '.git*' 12:29:05 INFO - Successfully installed jsonschema functools32 12:29:05 INFO - Cleaning up... 12:29:05 INFO - Return code: 0 12:29:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:05 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:29:05 INFO - Using env: {'DISPLAY': ':0', 12:29:05 INFO - 'HOME': '/home/cltbld', 12:29:05 INFO - 'LANG': 'en_US.UTF-8', 12:29:05 INFO - 'LANGUAGE': 'en_US:en', 12:29:05 INFO - 'LOGNAME': 'cltbld', 12:29:05 INFO - 'MAIL': '/var/mail/cltbld', 12:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:05 INFO - 'MOZ_NO_REMOTE': '1', 12:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:05 INFO - 'NO_EM_RESTART': '1', 12:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:05 INFO - 'PWD': '/builds/slave/test', 12:29:05 INFO - 'SHELL': '/bin/bash', 12:29:05 INFO - 'SHLVL': '1', 12:29:05 INFO - 'TERM': 'linux', 12:29:05 INFO - 'TMOUT': '86400', 12:29:05 INFO - 'USER': 'cltbld', 12:29:05 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:05 INFO - '_': '/tools/buildbot/bin/python'} 12:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:05 INFO - Downloading/unpacking blobuploader==1.2.4 12:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:07 INFO - Downloading blobuploader-1.2.4.tar.gz 12:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:29:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:29:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:08 INFO - Downloading docopt-0.6.1.tar.gz 12:29:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:29:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:29:08 INFO - Running setup.py install for blobuploader 12:29:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:29:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:29:08 INFO - Running setup.py install for requests 12:29:08 INFO - Running setup.py install for docopt 12:29:08 INFO - Successfully installed blobuploader requests docopt 12:29:08 INFO - Cleaning up... 12:29:08 INFO - Return code: 0 12:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:08 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:29:08 INFO - Using env: {'DISPLAY': ':0', 12:29:08 INFO - 'HOME': '/home/cltbld', 12:29:08 INFO - 'LANG': 'en_US.UTF-8', 12:29:08 INFO - 'LANGUAGE': 'en_US:en', 12:29:08 INFO - 'LOGNAME': 'cltbld', 12:29:08 INFO - 'MAIL': '/var/mail/cltbld', 12:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:08 INFO - 'MOZ_NO_REMOTE': '1', 12:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:08 INFO - 'NO_EM_RESTART': '1', 12:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:08 INFO - 'PWD': '/builds/slave/test', 12:29:08 INFO - 'SHELL': '/bin/bash', 12:29:08 INFO - 'SHLVL': '1', 12:29:08 INFO - 'TERM': 'linux', 12:29:08 INFO - 'TMOUT': '86400', 12:29:08 INFO - 'USER': 'cltbld', 12:29:08 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:08 INFO - '_': '/tools/buildbot/bin/python'} 12:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:08 INFO - Running setup.py (path:/tmp/pip-e6qisr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:08 INFO - Running setup.py (path:/tmp/pip-6GtAFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:09 INFO - Running setup.py (path:/tmp/pip-Pi_C7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:09 INFO - Running setup.py (path:/tmp/pip-DPH6Pf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:09 INFO - Running setup.py (path:/tmp/pip-2cEH1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:09 INFO - Running setup.py (path:/tmp/pip-WQOrG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:09 INFO - Running setup.py (path:/tmp/pip-7bXFoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:09 INFO - Running setup.py (path:/tmp/pip-U8CHTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:09 INFO - Running setup.py (path:/tmp/pip-BNj9Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:09 INFO - Running setup.py (path:/tmp/pip-BMfUbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:09 INFO - Running setup.py (path:/tmp/pip-gthSTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:09 INFO - Running setup.py (path:/tmp/pip-NAfF40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:09 INFO - Running setup.py (path:/tmp/pip-ObwZNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:09 INFO - Running setup.py (path:/tmp/pip-d_cLA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:09 INFO - Running setup.py (path:/tmp/pip-zUTXIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:09 INFO - Running setup.py (path:/tmp/pip-bB6FPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:10 INFO - Running setup.py (path:/tmp/pip-z2hF9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:29:10 INFO - Running setup.py install for manifestparser 12:29:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Running setup.py install for mozcrash 12:29:10 INFO - Running setup.py install for mozdebug 12:29:10 INFO - Running setup.py install for mozdevice 12:29:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Running setup.py install for mozfile 12:29:10 INFO - Running setup.py install for mozhttpd 12:29:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Running setup.py install for mozinfo 12:29:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Running setup.py install for mozInstall 12:29:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:29:10 INFO - Running setup.py install for mozleak 12:29:11 INFO - Running setup.py install for mozlog 12:29:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Running setup.py install for moznetwork 12:29:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Running setup.py install for mozprocess 12:29:11 INFO - Running setup.py install for mozprofile 12:29:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Running setup.py install for mozrunner 12:29:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Running setup.py install for mozscreenshot 12:29:11 INFO - Running setup.py install for moztest 12:29:11 INFO - Running setup.py install for mozversion 12:29:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:29:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:29:11 INFO - Cleaning up... 12:29:11 INFO - Return code: 0 12:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:29:11 INFO - Using env: {'DISPLAY': ':0', 12:29:11 INFO - 'HOME': '/home/cltbld', 12:29:11 INFO - 'LANG': 'en_US.UTF-8', 12:29:11 INFO - 'LANGUAGE': 'en_US:en', 12:29:11 INFO - 'LOGNAME': 'cltbld', 12:29:11 INFO - 'MAIL': '/var/mail/cltbld', 12:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:11 INFO - 'MOZ_NO_REMOTE': '1', 12:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:11 INFO - 'NO_EM_RESTART': '1', 12:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:11 INFO - 'PWD': '/builds/slave/test', 12:29:11 INFO - 'SHELL': '/bin/bash', 12:29:11 INFO - 'SHLVL': '1', 12:29:11 INFO - 'TERM': 'linux', 12:29:11 INFO - 'TMOUT': '86400', 12:29:11 INFO - 'USER': 'cltbld', 12:29:11 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:11 INFO - '_': '/tools/buildbot/bin/python'} 12:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:29:12 INFO - Running setup.py (path:/tmp/pip-P5Lx3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:29:12 INFO - Running setup.py (path:/tmp/pip-ewL_ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:29:12 INFO - Running setup.py (path:/tmp/pip-soz6x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:29:12 INFO - Running setup.py (path:/tmp/pip-AaqTN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:29:12 INFO - Running setup.py (path:/tmp/pip-37BwDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:29:12 INFO - Running setup.py (path:/tmp/pip-HJTJNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:29:12 INFO - Running setup.py (path:/tmp/pip-PQz4Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:29:12 INFO - Running setup.py (path:/tmp/pip-L_AkyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:29:12 INFO - Running setup.py (path:/tmp/pip-s0V5xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:29:12 INFO - Running setup.py (path:/tmp/pip-ZoSA6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:29:12 INFO - Running setup.py (path:/tmp/pip-hYsIwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:29:12 INFO - Running setup.py (path:/tmp/pip-h1MpFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:29:13 INFO - Running setup.py (path:/tmp/pip-tbPAeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:29:13 INFO - Running setup.py (path:/tmp/pip-fhm_RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:13 INFO - Running setup.py (path:/tmp/pip-5P83kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:29:13 INFO - Running setup.py (path:/tmp/pip-sr7aan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:29:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:29:13 INFO - Running setup.py (path:/tmp/pip-g2CS5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:29:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:29:15 INFO - Downloading blessings-1.6.tar.gz 12:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:29:15 INFO - Installing collected packages: blessings 12:29:15 INFO - Running setup.py install for blessings 12:29:15 INFO - Successfully installed blessings 12:29:15 INFO - Cleaning up... 12:29:15 INFO - Return code: 0 12:29:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:15 INFO - Reading from file tmpfile_stdout 12:29:15 INFO - Current package versions: 12:29:15 INFO - argparse == 1.2.1 12:29:15 INFO - blessings == 1.6 12:29:15 INFO - blobuploader == 1.2.4 12:29:15 INFO - docopt == 0.6.1 12:29:15 INFO - functools32 == 3.2.3-2 12:29:15 INFO - jsonschema == 2.5.1 12:29:15 INFO - manifestparser == 1.1 12:29:15 INFO - mozInstall == 1.12 12:29:15 INFO - mozcrash == 0.17 12:29:15 INFO - mozdebug == 0.1 12:29:15 INFO - mozdevice == 0.48 12:29:15 INFO - mozfile == 1.2 12:29:15 INFO - mozhttpd == 0.7 12:29:15 INFO - mozinfo == 0.9 12:29:15 INFO - mozleak == 0.1 12:29:15 INFO - mozlog == 3.2 12:29:15 INFO - moznetwork == 0.27 12:29:15 INFO - mozprocess == 0.22 12:29:15 INFO - mozprofile == 0.28 12:29:15 INFO - mozrunner == 6.11 12:29:15 INFO - mozscreenshot == 0.1 12:29:15 INFO - mozsystemmonitor == 0.3 12:29:15 INFO - moztest == 0.7 12:29:15 INFO - mozversion == 1.4 12:29:15 INFO - psutil == 3.1.1 12:29:15 INFO - requests == 1.2.3 12:29:15 INFO - wsgiref == 0.1.2 12:29:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:15 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 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:29:15 INFO - Using env: {'DISPLAY': ':0', 12:29:15 INFO - 'HOME': '/home/cltbld', 12:29:15 INFO - 'LANG': 'en_US.UTF-8', 12:29:15 INFO - 'LANGUAGE': 'en_US:en', 12:29:15 INFO - 'LOGNAME': 'cltbld', 12:29:15 INFO - 'MAIL': '/var/mail/cltbld', 12:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:15 INFO - 'MOZ_NO_REMOTE': '1', 12:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:15 INFO - 'NO_EM_RESTART': '1', 12:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:15 INFO - 'PWD': '/builds/slave/test', 12:29:15 INFO - 'SHELL': '/bin/bash', 12:29:15 INFO - 'SHLVL': '1', 12:29:15 INFO - 'TERM': 'linux', 12:29:15 INFO - 'TMOUT': '86400', 12:29:15 INFO - 'USER': 'cltbld', 12:29:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:15 INFO - '_': '/tools/buildbot/bin/python'} 12:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:29:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:29:15 INFO - Cleaning up... 12:29:15 INFO - Return code: 0 12:29:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:29:15 INFO - Using env: {'DISPLAY': ':0', 12:29:15 INFO - 'HOME': '/home/cltbld', 12:29:15 INFO - 'LANG': 'en_US.UTF-8', 12:29:15 INFO - 'LANGUAGE': 'en_US:en', 12:29:15 INFO - 'LOGNAME': 'cltbld', 12:29:15 INFO - 'MAIL': '/var/mail/cltbld', 12:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:15 INFO - 'MOZ_NO_REMOTE': '1', 12:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:15 INFO - 'NO_EM_RESTART': '1', 12:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:15 INFO - 'PWD': '/builds/slave/test', 12:29:15 INFO - 'SHELL': '/bin/bash', 12:29:15 INFO - 'SHLVL': '1', 12:29:15 INFO - 'TERM': 'linux', 12:29:15 INFO - 'TMOUT': '86400', 12:29:15 INFO - 'USER': 'cltbld', 12:29:15 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:15 INFO - '_': '/tools/buildbot/bin/python'} 12:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:29:16 INFO - Cleaning up... 12:29:16 INFO - Return code: 0 12:29:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:29: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')]} 12:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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')]} 12:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:29: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb91f2def10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d7d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e48350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:29: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', 'flake8'] in /builds/slave/test/build 12:29: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 flake8 12:29:16 INFO - Using env: {'DISPLAY': ':0', 12:29:16 INFO - 'HOME': '/home/cltbld', 12:29:16 INFO - 'LANG': 'en_US.UTF-8', 12:29:16 INFO - 'LANGUAGE': 'en_US:en', 12:29:16 INFO - 'LOGNAME': 'cltbld', 12:29:16 INFO - 'MAIL': '/var/mail/cltbld', 12:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:16 INFO - 'MOZ_NO_REMOTE': '1', 12:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:16 INFO - 'NO_EM_RESTART': '1', 12:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:16 INFO - 'PWD': '/builds/slave/test', 12:29:16 INFO - 'SHELL': '/bin/bash', 12:29:16 INFO - 'SHLVL': '1', 12:29:16 INFO - 'TERM': 'linux', 12:29:16 INFO - 'TMOUT': '86400', 12:29:16 INFO - 'USER': 'cltbld', 12:29:16 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:16 INFO - '_': '/tools/buildbot/bin/python'} 12:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:29:16 INFO - Downloading/unpacking flake8 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:29:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:29:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29: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 12:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:29:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:29:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:29:18 INFO - no previously-included directories found matching 'docs/_build' 12:29:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:29:19 INFO - Running setup.py install for pep8 12:29:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:29:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:29:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:29:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:29:19 INFO - no previously-included directories found matching 'docs/_build' 12:29:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:29:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:29:19 INFO - Cleaning up... 12:29:19 INFO - Return code: 0 12:29:19 INFO - Running post-action listener: _resource_record_post_action 12:29:19 INFO - Running post-action listener: _start_resource_monitoring 12:29:19 INFO - Starting resource monitoring. 12:29:19 INFO - ##### 12:29:19 INFO - ##### Finished create-virtualenv step (success) 12:29:19 INFO - ##### 12:29:19 INFO - ##### 12:29:19 INFO - ##### Running install step. 12:29:19 INFO - ##### 12:29:19 INFO - Running pre-action listener: _resource_record_pre_action 12:29:19 INFO - Running main action method: install 12:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:29:19 INFO - Reading from file tmpfile_stdout 12:29:19 INFO - Detecting whether we're running mozinstall >=1.0... 12:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:29:19 INFO - Reading from file tmpfile_stdout 12:29:19 INFO - Output received: 12:29:19 INFO - Usage: mozinstall [options] installer 12:29:19 INFO - Options: 12:29:19 INFO - -h, --help show this help message and exit 12:29:19 INFO - -d DEST, --destination=DEST 12:29:19 INFO - Directory to install application into. [default: 12:29:19 INFO - "/builds/slave/test"] 12:29:19 INFO - --app=APP Application being installed. [default: firefox] 12:29:19 INFO - mkdir: /builds/slave/test/build/application 12:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:29:35 INFO - Reading from file tmpfile_stdout 12:29:35 INFO - Output received: 12:29:35 INFO - /builds/slave/test/build/application/firefox/firefox 12:29:35 INFO - Running post-action listener: _resource_record_post_action 12:29:35 INFO - ##### 12:29:35 INFO - ##### Finished install step (success) 12:29:35 INFO - ##### 12:29:35 INFO - ##### 12:29:35 INFO - ##### Running run-tests step. 12:29:35 INFO - ##### 12:29:35 INFO - Running pre-action listener: _resource_record_pre_action 12:29:35 INFO - Running main action method: run_tests 12:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:29:35 INFO - Python 2.7.3 12:29:35 INFO - Return code: 0 12:29:35 INFO - grabbing minidump binary from tooltool 12:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:29:35 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 0x1ed71c0>, '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 0x1ed80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ed8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:29:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:29:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:29:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:29:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:29:35 INFO - Return code: 0 12:29:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:29:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:29:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:29:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:29:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:29:36 INFO - Return code: 0 12:29:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:29:36 INFO - Using env: {'DISPLAY': ':0', 12:29:36 INFO - 'HOME': '/home/cltbld', 12:29:36 INFO - 'LANG': 'en_US.UTF-8', 12:29:36 INFO - 'LANGUAGE': 'en_US:en', 12:29:36 INFO - 'LOGNAME': 'cltbld', 12:29:36 INFO - 'MAIL': '/var/mail/cltbld', 12:29:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:36 INFO - 'MOZ_NO_REMOTE': '1', 12:29:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:36 INFO - 'NO_EM_RESTART': '1', 12:29:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:36 INFO - 'PWD': '/builds/slave/test', 12:29:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:36 INFO - 'SHELL': '/bin/bash', 12:29:36 INFO - 'SHLVL': '1', 12:29:36 INFO - 'TERM': 'linux', 12:29:36 INFO - 'TMOUT': '86400', 12:29:36 INFO - 'USER': 'cltbld', 12:29:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562', 12:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:36 INFO - '_': '/tools/buildbot/bin/python'} 12:29:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:29:36 INFO - mozversion application_buildid: 20160609095531 12:29:36 INFO - mozversion application_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 12:29:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:29:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:29:36 INFO - mozversion application_name: Firefox 12:29:36 INFO - mozversion application_remotingname: firefox-dev 12:29:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:29:36 INFO - mozversion application_vendor: Mozilla 12:29:36 INFO - mozversion application_version: 49.0a2 12:29:36 INFO - mozversion platform_buildid: 20160609095531 12:29:36 INFO - mozversion platform_changeset: a11eb3fab3c603e2b13f8185db8e1815b44d8692 12:29:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:29:36 INFO - mozversion platform_version: 49.0a2 12:29:36 INFO - using testdate: 1465500576 12:29:36 INFO - actual date: 1465500576 12:29:36 INFO - starting webserver on 'localhost:52648' 12:29:36 INFO - SUITE-START | Running 2 tests 12:29:36 INFO - TEST-START | dromaeo_css 12:29:36 INFO - operating with platform_type : linux_ 12:29:36 INFO - Initialising browser for dromaeo_css test... 12:29:36 INFO - TEST-INFO | started process 30671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMszppZ/profile http://localhost:52648/getInfo.html) 12:29:41 INFO - PROCESS | 30671 | __metrics Screen width/height:1600/1200 12:29:41 INFO - PROCESS | 30671 | colorDepth:24 12:29:41 INFO - PROCESS | 30671 | Browser inner width/height: 1024/697 12:29:41 INFO - PROCESS | 30671 | __metrics 12:29:42 ERROR - PROCESS | 30671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:29:43 INFO - TEST-INFO | 30671: exit 0 12:29:43 INFO - Browser initialized. 12:29:43 INFO - Running cycle 1/1 for dromaeo_css test... 12:29:43 INFO - TEST-INFO | started process 30798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMszppZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:54 INFO - PROCESS | 30798 | RSS: Main: 156213248 12:29:54 INFO - PROCESS | 30798 | 12:30:44 INFO - PROCESS | 30798 | 1465500644421 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:32:52 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52648/tests/dromaeo/cssquery-ext.html) 12:32:53 INFO - PROCESS | 30798 | RSS: Main: 159580160 12:32:53 INFO - PROCESS | 30798 | 12:35:55 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-ext.html (next: http://localhost:52648/tests/dromaeo/cssquery-jquery.html) 12:35:56 INFO - PROCESS | 30798 | RSS: Main: 157294592 12:35:56 INFO - PROCESS | 30798 | 12:38:58 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52648/tests/dromaeo/cssquery-mootools.html) 12:38:58 INFO - PROCESS | 30798 | RSS: Main: 157417472 12:38:58 INFO - PROCESS | 30798 | 12:42:00 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52648/tests/dromaeo/cssquery-prototype.html) 12:42:01 INFO - PROCESS | 30798 | RSS: Main: 156737536 12:42:01 INFO - PROCESS | 30798 | 12:45:03 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52648/tests/dromaeo/cssquery-yui.html) 12:45:04 INFO - PROCESS | 30798 | RSS: Main: 158900224 12:45:04 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | Cycle 1(1): loaded http://localhost:52648/tests/dromaeo/cssquery-yui.html (next: http://localhost:52648/tests/dromaeo/cssquery-dojo.html) 12:48:06 INFO - PROCESS | 30798 | RSS: Main: 158912512 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | __start_tp_report 12:48:06 INFO - PROCESS | 30798 | _x_x_mozilla_page_load 12:48:06 INFO - PROCESS | 30798 | _x_x_mozilla_page_load_details 12:48:06 INFO - PROCESS | 30798 | |i|pagename|runs| 12:48:06 INFO - PROCESS | 30798 | |0;dojo.html;3428.9485657715154;3447.3622379859726;3457.7406694497918;3463.480477928312;3463.9826800865976;5656.604037717357;5708.600397972138;5784.768609255635;5785.958527465054;5800.187973683687;5765.4522820332;5845.503132233765;5854.941450585493;5857.472827445529;5858.912116318259;5224.712640804754;5279.155335146377;5306.044911915854;5325.281087053257;5387.892242155154;5165.819196328111;5279.604029697769;5356.250124982505;5363.704996225206;5374.543163831079;5271.525562699357;5275.894482110355;5284.39229488608;5305.814296499623;5319.813806516772;5362.570994320445;5371.704556249405;5379.677219366811;5399.487048730384;5406.432324605899;5065.949340506621;5150.253213284091;5202.06362854686;5278.261043453919;5302.2311764793885;5710.828675139753;5711.7144142792695;5738;5744.741486633112;5746.482816546531;6220.1913751212505;6262.96868515659;6269.122322874801;6278.748850045993;6296.779612713579;5998.340182579913;6154.661493617849;6174.691265436711;6198.34917333678;6344.49244060474;5839.6204246724255;5840.2991641003355;5842.328132264759;5848.9179501792305;5886.999210134245;6268.404501572343;6310.832495988257;6348.1430006949395;6367.140436041075;6401.615903045832;5915.852103697442;6003.369646187175;6022.18700475439;6064.877997570376;6105.877882442326;6166.282793662852;6174.6912654368;6205.379462053758;6209.099680546386;6212.968935155295;6060.818175454743;6102.267727872595;6152.261728592597;6169.198004259418;6180.536459765445;6051.818445446644;6068.393160683984;6106.297775755756;6124.469519445561;6167.074938759222;4682.461516925529;4684.297355396649;4689.718616882998;4691.765411729468;4741.2176990796825;4142.5857414258335;4147.709660323749;4183.644390226865;4193.203291374629;4204.033072393367;5808.94191058084;5890.617109887844;5964.970175149097;5973.074173503114;6043.123747056652;6319.431251187415;6360;6364.172657554488;6369.936300636934;6379.234491860913;5853.09277062056;5875.441833025856;6078.696065196811;6095.512359011268;6103;5282.920756188661;5329.8401047967845;5366.302380690563;5385.165299378603;5415.756290966916;6556.114924485229;6585;6585.703643336062;6586.571872828251;6615.536912416181;6324.462420694293;6365.649889256136;6368.267649220399;6383.616982981036;6399;6261.530385221217;6395.42441180296;6474.5791523550815;6480.287168411377;6546.770863019771;6220.471259942775;6220.906686399798;6227.96886015567;6233.189685340877;6237.376262373908;6286.779962701284;6287.46556542699;6342.143810585697;6347.079673447417;6351.491880649629;5968.970155149196;6082.817515474543;6115.6662951758;6138.572327483795;6140.074827791203;6060.636361818305;6073.635581865102;6079.635221886701;6080.574359794772;6110.633361998294;5825.126231065374;5887.116932460165;5898.292204935436;5899.144624029577;5962.2249107615735;5954.3152537458745;5998.460138587374;6015.368386319374;6102.237220347457;6102.633841969496;5897;5971.522278217645;5977.790777322773;5985.820425387245;6002.759889604367 12:48:06 INFO - PROCESS | 30798 | |1;ext.html;646.6055706019329;649.5161104976793;659.3571268013686;663.5653646861308;697.466438174796;41583.79208103959;43138.35292470615;44087.559124408785;44226.33660495091;44421;43261;43994.78002609991;44093.33859992103;44108.558914410845;44192.3371149433;8684.30525557957;8858.822823543525;8873.911260887406;8897.555122243863;8902.599383027748;8805.25155361795;8897;8927.55362231889;8939.061398553156;8962.148595883413;8809.515476648781;8908.153725396109;8923.196912277894;8924.330675199353;8967.865482017774;8830.735077947671;8959.238464730506;8967.148120928534;8971;8990.05604411534;8772.210501054871;8872.689455869078;8893.155150260714;8920.063393343671;8921.063288354695;35559.4666080009;40107.19785604301;40604.187916241506;40698.79650601758;40764.38853417201;3278.6721327867263;3373.0724050885956;3480.6519348065244;3537.5754909411035;3635.073056370635;32885.6711432885;33079.3384132316;33085.33829323424;33640.831795841106;34242.315153696785;4409.382686423904;4504.527024662396;4512.413386259798;4530.139273538017;4601.608863246628;322734;325260;325533;325711;327543;38749.6125038746;39262.411063834064;39350.40974385387;39410.211795764495;39516.60483395129;40202;40887.38668919969;41034.38448423276;41047.58952410497;41152.1769564607;19160.520986975436;19457.221711131395;19495.512612184524;19537;19560.21759129619;14836.18400987956;14860.777088343684;14914.17972011528;14937.103773773608;14982.325795339237;20052.298169563994;20389.694154587694;20435.284765033153;20456.590868182553;20585.89707051455;7197.89203161953;7219.386352160021;7321.597312147776;7425.294597013275;7517.887231691529;990.6582229130938;1045.0803293102022;1114.3258328711013;1156.0231604294358;1172.806486929647;32630.51054234141;33341;33437;33579.16052098717;33707.49438758421;1126.8197088465806;1134.804153962086;1159.4029075026367;1163.4241050679968;1262.741138066694;17245;17578.472645820646;17730.65598928245;17751.467455976082;17807.109644517983;638171;646488;646556;981917;1002283;63797.362026379145;64889.67555162194;65983.34016659867;66286.66856665685;66535;1498.3781730581904;1503.503843731566;1525.4050920141153;1527.747921592947;1552.208373729406;32966.34067318592;33847.153821154665;34333.656663433045;34581.654183457846;34658;57981.4201857976;59373.703131484064;61620.38379616146;68037.3196268031;68181.3181868175;554418;561640;561938;562562;562838;46440.767796160806;47150;47331.52668473409;47769.28346074881;49693.50306497033;52011.47988520218;52937.20594191167;52974.20538691845;53321.20018199652;54197.72901135627;43933.56066439295;44832.551674482835;45215.32177017281;47064.294035588806;48836.26745598748;44106;44707;44828.10343793171;45724.31413528866;46390.30414543717;42713.786431067645;42744;43540;45428.545714543754;45613;37050.25899482049;38446.615533844306;38521.22957540889;38764.2247155061;39116.2176756469;29926.41618843851;29951.550726738682;30006.54990175193;30261.243468913453;30378.696213037587 12:48:06 INFO - PROCESS | 30798 | |2;jquery.html;404.215821306665;407.8429804525258;414.19645886979276;415.28570858124016;424.0416658352123;17054.914725426355;18519;19354.612907741837;19786.30747923823;20243.190272389103;19510.31713890014;19896.303629372975;20004.69992950107;20071.297504587343;20175.49561260969;5531.474509921551;5781.075027995522;5785.942140578603;5789.131630255453;5790.102534107199;5513.8345849624575;5566.137248726433;5725.885482290351;5726.7422965966425;5893.58744887858;5841.0362290222065;5875.412458754112;5876.265466816648;5883.529317654577;5888.941110588904;5497.670139791625;5820.854478638025;5840.649561026331;5863.76544938202;5865.472107510302;5624.71876406178;5668.093105103205;5729.341125770548;5734.053881109612;5756.856078598069;18752.531186720305;22774.316770496913;23296.88351558248;23571.410714732097;23778.167764128346;2373.2880135959144;2384.2022935368436;2426.745191754858;2434.1237154624323;2465.6794616699895;9266.814663706755;9497.905020949771;9709;9891.06034926688;10519.52662130206;1933.806619338055;1998.870073445236;1999.4001799460104;2020.40398082566;2061.4331058958755;83410.99999999939;84559;85149.57425212896;86995;87085.12914870834;10996.560137594406;11076.280041797258;11164.218504704755;11292.491837867316;11690.70773230659;14262.286885655883;14634.414623415158;14669.193194374198;14767.63080922964;15082.698346033018;8856.335774816915;8874.156955089256;8977;9044;9079;8782.956085219534;8830.381873268809;8846.911530884738;8877.289816814638;8931.776705582282;5130.461301563357;5157.535821775983;5158.329417175743;5214.217867319932;5223.764930578133;1868.6169335286233;2004.759428868516;2099.580083983179;2113.746350437957;2116.5766846630736;980.0836218136066;1045.9947700261603;1056.9365838049741;1080.8919108089285;1116.7598966222301;18800.811991879906;19325.710114348298;19390.515237118903;19574.21703131859;19705.408837734893;1014.8832884218261;1057.5981127171626;1062.490004797686;1064.1539975719322;1076.4832880217539;10679;10810.405427701551;11005.724856878482;11013.504392302366;11071.225014249087;516499;519465;525980;528708;532177;95806.52096739471;97043;97615.51192243994;98067.50966245124;99756.50121749345;997.7904640025531;1001.3641337750436;1054.8312270036756;1083.3283364314175;1084.3114622214794;17149.655817116043;17331.393401230896;17377.21802518915;17659.82340176633;17754.644907102043;33384.833075835435;38419;40054.399184012844;41206.793966029974;41828.95427614334;53934.46065539294;57786.13320800276;59061.70469147627;59518;59653.70173149106;8629.26651234627;8755.430896991675;8767.868481972648;8852.114788521096;8944.776380590278;9584.185344245818;10469.371837689763;13281;13960.720785584028;14298.57104286873;12203;12216.572419965258;12359.814602780785;12372.13395062337;12521.248725076524;11897.702557435787;11918.761624767283;11923.165378423428;12010.33943133136;12242.571509997108;12380.319082450551;12512.0615953802;12522.436490357773;12829.16610420357;12943.482260709843;8968.417052891542;8985.101489850962;9000.954995225244;9078.319126065704;9155.77110572241;8820.5589720515;12146.93926530397;12174.45214965311;12283.877161228631;12285 12:48:06 INFO - PROCESS | 30798 | |3;mootools.html;1537.5079974408193;1573.708863860186;1711.8630509559237;1817.3094224194804;1842.189436647874;8746.387752857287;9315.860262096074;9347;10080.99999999999;10095.747606309837;9398.389104708189;9644.614215431375;9785.168260697832;9809.215262778978;9816;2507.674002379688;2536.353229926366;2536.5941449368106;2540.64430979663;2543.5675935090985;2458.815588830836;2520.18094119411;2535.5055764126005;2535.556277651413;2542.402535404188;2473.4434752180705;2490.3774056485877;2514.2959971208093;2521.697396312445;2525.4191535946743;2379.167291447997;2380.9523809523885;2389.522095580891;2424.381782645423;2430.3438071720625;2357.7524359942304;2404.5791986402483;2404.61526155816;2412.8311018228733;2427.453822889853;9648.807023859554;9676.854847177297;9701.90298097017;9740.707778766577;9753.90246097537;5726.112452569859;5882.176495290662;5892.499137573312;5898;5907.350191478934;3682.9447558286647;3793.715471339633;3837.079101015764;3849.287881741887;3912.1197730510694;1254.3853511779253;1301.1542497376781;1308.6335825968745;1324.8675132486771;1328.9468421263139;13953.86046139546;14046.859531404658;14072.014958952877;14086.647833804134;14088.084274522123;4918.48355922623;5029.723365214948;5034.16936205522;5044.218146187347;5117.795288188431;11803.645890623295;11832.585859494877;11854.881451185378;11865.881341186478;11883.762324753456;5747.3677895431465;5777.0467872801355;5783.537317014629;5799.449052340021;5819.185314056035;4667.7199368037345;4957.429895561984;5055.16589762685;5092.363454568179;5227.424983251839;4274.358846173099;4301.075268817157;4301.225779359683;4313.892152696208;4337.240982827992;1292.689754458923;1315.2174456198738;1324.9668758280927;1329.6144118205611;1364.0315376082895;1059.904608585231;1076.8277075667856;1080.7514271717548;1082.718493191776;1090.803655342046;6438.967805160944;6477.77327793525;6538.248101468297;6600.966995164993;6608.669566521655;478.58124141376294;485.03720115570565;490.14959046055066;490.9214525675875;497.8257609836601;4481.215787237221;4512.458504979423;4514.525974772667;4518.480374756945;4531.207038768202;11813.350265735295;12257.387130643432;12269.07981901361;12346.320952347707;12417.875821241672;12163.209391389708;12177;12204.511819527297;12230.14388992762;12296.446659900326;8341.708040218564;8525;8557.48655080697;8775.385722999456;8888;6650.301718319507;6861.725530978705;6886.586804791728;6961.6519174042105;6999.230084690782;11249.887501124884;11316.434178291218;11407.087433005505;11499.310041397543;11504.94247528757;11305.660830175108;11412.08703303717;11460.312381257152;11584.94207528957;11591.710207244887;7915.643796029308;8235.50586964784;8364.205400486944;8366.83266334682;8637.956810215908;9595.040495950629;9595.808083838423;9702.5148742564;9703.12671859536;9704.902950970682;8485.575721214038;8712.172343627346;8737.519436431057;8778;8849.64601415962;8391.622376992927;8391.790205244917;8485.533295668798;8563.657453702031;8652.264557512683;7554.962225188839;7563.281488258606;7665.271799179069;7671.693132274647;7684.9231507686445;5300.681959082313;5570.275864137636;5587.3015873015875;5629;5739.081746920473;5550.888982220252;5563.833085007456;5582.7766889323975;5614.466625670555;5629.54963602919 12:48:06 INFO - PROCESS | 30798 | |4;prototype.html;344.13106905064717;345.23013679494727;348.0758585954292;350.8807005618089;350.9210427653778;5742.966266072105;5761.30864296284;5795.652260864345;5817.360090390059;5827.475527202551;5731.541476681866;5737;5739.311282646078;5750;5767.855803604912;4229.688796473088;4261.169072030955;4425.380446737459;4434.334849772527;4446.444194475691;4405.427294451717;4417.873442272216;4427.756473393962;4433.357163211333;4437.35658329542;4417.27115026022;4425.159219748238;4425.402570652969;4429.557044295577;4430.734155950653;4288.356746488021;4412.4043254160915;4423.668224883147;4444.444444444444;4465.285554311311;3858.440526123696;3876.3604005339084;3879.495665563487;3883.5533913600016;3900.5709371969347;5488.53347465466;5514.145307477347;5520.944790552083;5556.222128901957;5565.41563135873;4972.5276098770555;5056.873578160538;5066.36670416198;5087.499187739626;5093.643444958854;5889.823305300848;5942.762289508458;5972.731227094791;5982.37185095563;6019.337872833985;4313.870583882489;4325.675574331937;4330.437043184366;4332.241857674926;4333.659823695232;5940.584159108864;6209.944309467402;6239.220097487814;6273.686315684243;6299.212598425197;4352.956470435255;4366.759828209415;4386.298192289282;4386.561343865588;4392.692511524163;4418.911621767546;4429.844955426544;4443.644508439317;4444.777761111932;4445.777711114431;4811.518848115231;5066.544011038951;5084.3898732152375;5088.287639730441;5092.0579692756955;6011.729472173763;6017.608855424471;6053.122297266872;6079.75680972765;6082.787102451393;1490.709311684233;1495.940162393492;1502.481643832876;1521.2241756704161;1538.1155835394693;954.9236061115095;1006.6577363696379;1015.28422462164;1038.7351225437465;1044.8746150461993;5836.387179346192;5875.531117220695;5904.5238690327415;5921.822345329647;5938.61399009063;6162.168107305456;6170.5372097092895;6190.473809726133;6192.256929168529;6202.4417802398;5732.541396688255;6034;6042.758289668452;6044.274687037496;6050.57645964787;3321.7342612590933;3325.2019515316633;3364.5794275715534;3375.915602109967;3382.2051817822794;6226.62640241587;6420.7431702731365;6481.546291759531;6486.610803351814;6487.859006527835;6343.111964324999;6384.361563843671;6395.936040639534;6441.25925518562;6441.516886233551;6076.27084749824;6428.682120165355;6430.549861509649;6444.904366257748;6448.9355106449275;6256;6281.246250449793;6286.37136286386;6298.370162983665;6298.464630506458;5968.641881487125;6158.938410615837;6192.535559833121;6206.193194884636;6228.22147231596;6393.680315984089;6399.328070552711;6447.451966582893;6495.382938620824;6512.502124511484;4338.566143385762;4385.758783266951;4391.3193455014525;4400.845970391149;4401.823927042882;6088.208532890696;6270.811875643738;6282.403171698681;6287;6292.244930608356;6056.7274472649715;6066.696665166813;6116.174316467398;6118.816435506942;6136.64993701385;5893.616914900518;6063.636181829104;6096.756129754937;6105.694715264308;6107.786227482017;5832.50423713989;5930.851728706644;5963.373845746134;5965.464677512126;5982;6097.115918191926;6120.234970628671;6138.969305153446;6140.631562106288;6148.079662160438;5749.597528172988;5971.104014553025;5997.790077347272;6021.909671354845;6031.7587296507645 12:48:06 INFO - PROCESS | 30798 | |5;yui.html;799.6161842315688;804.213682554024;811.9797005074872;847.6760786802027;875.7110153649296;15275.236238188088;15383.153926534036;15554.84445155548;15567.29947152378;15587.45443909462;14813.851861481382;14825.406983720639;14868.776968345483;14873.851261487382;14877.851221487781;698.8287869471986;832.7127141136298;836.9832603347929;837.7654256808104;838.4759525296689;832.5421018439864;840.3613253926999;851.5827244650108;854.4275335525182;858.9184027517407;891.3047822698305;893.5041052216018;894.0433735902587;894.0880302091863;894.432035657359;912.6668765900398;915.0666320353236;915.7939463620633;917.729269865388;920.3097676742443;645.4320198225579;649.4901502320656;649.8830210562097;649.9480041596709;653.2846533046354;14909.478168264168;14930.402783888632;14965;14984.47554335593;15005;14242.216678082701;15154.090754554762;15486.380544778196;15541.222938853012;15595.064296142154;12412.441440135126;12470.314132722697;12503.187292825936;12553.811692824615;12760.106792524526;3997.520297564282;4072.490938632671;4126.174765047002;4129.380592911058;4190.015346393595;77019;79643;80336.59831700863;80783.5960820198;81210.78183827306;11610.593629222936;11793.29240245588;11892.345920974429;11950.880491194977;11998.700032499257;20176.69734953977;20250.594988100154;20450.59098818045;20509.17963281482;20583.176672933216;8307.958460207781;8368.832623347498;8386;8510.404271700922;8758.824823503493;4812.470628230892;4879.194932836042;4986.077575648516;5017.122003649347;5032.547070763649;3785.6025117362833;3884.786336751449;3891.747036442622;3892.2604705106505;3896.980515097406;617.7528988404584;624.5097598385337;630.5932673425615;635.5106567942751;640.1837656987378;652.8531080506943;677.2110491277705;681.924988251292;738.5605564689001;759.4152502572988;10056.29605927578;10189.286749927434;10521.316114452537;10549.525271362807;10648.946755266328;663.8738639658546;698.2528694297054;771.4908160613968;822.1860358245294;861.3453775130946;4747.145513807548;4931.506849315111;4940.110780059552;4984.27727979441;5016.799328026838;103723;103771;106439.46780266204;107294.46352768186;111650;79578.6021069891;88384.55807721049;93166;96619.51690241645;101437;56030.43969560334;56622.15066774002;56853.71573142108;57612;88214.55892720624;9251.491167985825;9692.757681057748;9788.119069283799;9793.412395256308;9806.509674516388;38171.618283817916;47963;52355.21467177919;53247;53654.73172634112;66989;68603;76399.61800190964;77293.61353193199;79076.60461697655;11235.887641123483;13126.40931158081;13278.734425311246;13298.468061277828;13534;13568.79646805279;13938.372773225026;15238.923805380902;16041.598960026093;16713.74929376036;14213.715725685635;14255.928720356747;14659.267036647912;14683.265836708335;14843.109413435228;12711;12858.549950751678;12893.161944473579;14957.850421496081;14980.625484362978;13977.58067257984;14094.788578171541;14481.710365792836;14618.122912625277;15261.313240904408;11112;11715.685298392984;11734.413279335828;12045.879541204826;12239.449224784728;12498.75002499963;12514.436850341574;12582.622521324374;12594.181378210387;12652.557160499338 12:48:06 INFO - PROCESS | 30798 | __end_tp_report 12:48:06 INFO - PROCESS | 30798 | __start_cc_report 12:48:06 INFO - PROCESS | 30798 | _x_x_mozilla_cycle_collect,368 12:48:06 INFO - PROCESS | 30798 | __end_cc_report 12:48:06 INFO - PROCESS | 30798 | __startTimestamp1465501686685__endTimestamp 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | ------- Summary: start ------- 12:48:06 INFO - PROCESS | 30798 | Number of tests: 6 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#0] dojo.html Cycles:165 Average:5783.77 Median:5985.82 stddev:662.95 (11.1%) stddev-sans-first:638.73 12:48:06 INFO - PROCESS | 30798 | Values: 3428.9 3447.4 3457.7 3463.5 3464.0 5656.6 5708.6 5784.8 5786.0 5800.2 5765.5 5845.5 5854.9 5857.5 5858.9 5224.7 5279.2 5306.0 5325.3 5387.9 5165.8 5279.6 5356.3 5363.7 5374.5 5271.5 5275.9 5284.4 5305.8 5319.8 5362.6 5371.7 5379.7 5399.5 5406.4 5065.9 5150.3 5202.1 5278.3 5302.2 5710.8 5711.7 5738.0 5744.7 5746.5 6220.2 6263.0 6269.1 6278.7 6296.8 5998.3 6154.7 6174.7 6198.3 6344.5 5839.6 5840.3 5842.3 5848.9 5887.0 6268.4 6310.8 6348.1 6367.1 6401.6 5915.9 6003.4 6022.2 6064.9 6105.9 6166.3 6174.7 6205.4 6209.1 6213.0 6060.8 6102.3 6152.3 6169.2 6180.5 6051.8 6068.4 6106.3 6124.5 6167.1 4682.5 4684.3 4689.7 4691.8 4741.2 4142.6 4147.7 4183.6 4193.2 4204.0 5808.9 5890.6 5965.0 5973.1 6043.1 6319.4 6360.0 6364.2 6369.9 6379.2 5853.1 5875.4 6078.7 6095.5 6103.0 5282.9 5329.8 5366.3 5385.2 5415.8 6556.1 6585.0 6585.7 6586.6 6615.5 6324.5 6365.6 6368.3 6383.6 6399.0 6261.5 6395.4 6474.6 6480.3 6546.8 6220.5 6220.9 6228.0 6233.2 6237.4 6286.8 6287.5 6342.1 6347.1 6351.5 5969.0 6082.8 6115.7 6138.6 6140.1 6060.6 6073.6 6079.6 6080.6 6110.6 5825.1 5887.1 5898.3 5899.1 5962.2 5954.3 5998.5 6015.4 6102.2 6102.6 5897.0 5971.5 5977.8 5985.8 6002.8 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#1] ext.html Cycles:180 Average:70736.79 Median:43736.78 stddev:160145.44 (366.2%) stddev-sans-first:160508.22 12:48:06 INFO - PROCESS | 30798 | Values: 646.6 649.5 659.4 663.6 697.5 41583.8 43138.4 44087.6 44226.3 44421.0 43261.0 43994.8 44093.3 44108.6 44192.3 8684.3 8858.8 8873.9 8897.6 8902.6 8805.3 8897.0 8927.6 8939.1 8962.1 8809.5 8908.2 8923.2 8924.3 8967.9 8830.7 8959.2 8967.1 8971.0 8990.1 8772.2 8872.7 8893.2 8920.1 8921.1 35559.5 40107.2 40604.2 40698.8 40764.4 3278.7 3373.1 3480.7 3537.6 3635.1 32885.7 33079.3 33085.3 33640.8 34242.3 4409.4 4504.5 4512.4 4530.1 4601.6 322734.0 325260.0 325533.0 325711.0 327543.0 38749.6 39262.4 39350.4 39410.2 39516.6 40202.0 40887.4 41034.4 41047.6 41152.2 19160.5 19457.2 19495.5 19537.0 19560.2 14836.2 14860.8 14914.2 14937.1 14982.3 20052.3 20389.7 20435.3 20456.6 20585.9 7197.9 7219.4 7321.6 7425.3 7517.9 990.7 1045.1 1114.3 1156.0 1172.8 32630.5 33341.0 33437.0 33579.2 33707.5 1126.8 1134.8 1159.4 1163.4 1262.7 17245.0 17578.5 17730.7 17751.5 17807.1 638171.0 646488.0 646556.0 981917.0 1002283.0 63797.4 64889.7 65983.3 66286.7 66535.0 1498.4 1503.5 1525.4 1527.7 1552.2 32966.3 33847.2 34333.7 34581.7 34658.0 57981.4 59373.7 61620.4 68037.3 68181.3 554418.0 561640.0 561938.0 562562.0 562838.0 46440.8 47150.0 47331.5 47769.3 49693.5 52011.5 52937.2 52974.2 53321.2 54197.7 43933.6 44832.6 45215.3 47064.3 48836.3 44106.0 44707.0 44828.1 45724.3 46390.3 42713.8 42744.0 43540.0 45428.5 45613.0 37050.3 38446.6 38521.2 38764.2 39116.2 29926.4 29951.6 30006.5 30261.2 30378.7 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#2] jquery.html Cycles:180 Average:30274.56 Median:2449.90 stddev:86476.79 (3529.8%) stddev-sans-first:86690.29 12:48:06 INFO - PROCESS | 30798 | Values: 404.2 407.8 414.2 415.3 424.0 17054.9 18519.0 19354.6 19786.3 20243.2 19510.3 19896.3 20004.7 20071.3 20175.5 5531.5 5781.1 5785.9 5789.1 5790.1 5513.8 5566.1 5725.9 5726.7 5893.6 5841.0 5875.4 5876.3 5883.5 5888.9 5497.7 5820.9 5840.6 5863.8 5865.5 5624.7 5668.1 5729.3 5734.1 5756.9 18752.5 22774.3 23296.9 23571.4 23778.2 2373.3 2384.2 2426.7 2434.1 2465.7 9266.8 9497.9 9709.0 9891.1 10519.5 1933.8 1998.9 1999.4 2020.4 2061.4 83411.0 84559.0 85149.6 86995.0 87085.1 10996.6 11076.3 11164.2 11292.5 11690.7 14262.3 14634.4 14669.2 14767.6 15082.7 8856.3 8874.2 8977.0 9044.0 9079.0 8783.0 8830.4 8846.9 8877.3 8931.8 5130.5 5157.5 5158.3 5214.2 5223.8 1868.6 2004.8 2099.6 2113.7 2116.6 980.1 1046.0 1056.9 1080.9 1116.8 18800.8 19325.7 19390.5 19574.2 19705.4 1014.9 1057.6 1062.5 1064.2 1076.5 10679.0 10810.4 11005.7 11013.5 11071.2 516499.0 519465.0 525980.0 528708.0 532177.0 95806.5 97043.0 97615.5 98067.5 99756.5 997.8 1001.4 1054.8 1083.3 1084.3 17149.7 17331.4 17377.2 17659.8 17754.6 33384.8 38419.0 40054.4 41206.8 41829.0 53934.5 57786.1 59061.7 59518.0 59653.7 8629.3 8755.4 8767.9 8852.1 8944.8 9584.2 10469.4 13281.0 13960.7 14298.6 12203.0 12216.6 12359.8 12372.1 12521.2 11897.7 11918.8 11923.2 12010.3 12242.6 12380.3 12512.1 12522.4 12829.2 12943.5 8968.4 8985.1 9001.0 9078.3 9155.8 8820.6 12146.9 12174.5 12283.9 12285.0 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#3] mootools.html Cycles:180 Average:6406.88 Median:4524.84 stddev:3752.34 (82.9%) stddev-sans-first:3745.03 12:48:06 INFO - PROCESS | 30798 | Values: 1537.5 1573.7 1711.9 1817.3 1842.2 8746.4 9315.9 9347.0 10081.0 10095.7 9398.4 9644.6 9785.2 9809.2 9816.0 2507.7 2536.4 2536.6 2540.6 2543.6 2458.8 2520.2 2535.5 2535.6 2542.4 2473.4 2490.4 2514.3 2521.7 2525.4 2379.2 2381.0 2389.5 2424.4 2430.3 2357.8 2404.6 2404.6 2412.8 2427.5 9648.8 9676.9 9701.9 9740.7 9753.9 5726.1 5882.2 5892.5 5898.0 5907.4 3682.9 3793.7 3837.1 3849.3 3912.1 1254.4 1301.2 1308.6 1324.9 1328.9 13953.9 14046.9 14072.0 14086.6 14088.1 4918.5 5029.7 5034.2 5044.2 5117.8 11803.6 11832.6 11854.9 11865.9 11883.8 5747.4 5777.0 5783.5 5799.4 5819.2 4667.7 4957.4 5055.2 5092.4 5227.4 4274.4 4301.1 4301.2 4313.9 4337.2 1292.7 1315.2 1325.0 1329.6 1364.0 1059.9 1076.8 1080.8 1082.7 1090.8 6439.0 6477.8 6538.2 6601.0 6608.7 478.6 485.0 490.1 490.9 497.8 4481.2 4512.5 4514.5 4518.5 4531.2 11813.4 12257.4 12269.1 12346.3 12417.9 12163.2 12177.0 12204.5 12230.1 12296.4 8341.7 8525.0 8557.5 8775.4 8888.0 6650.3 6861.7 6886.6 6961.7 6999.2 11249.9 11316.4 11407.1 11499.3 11504.9 11305.7 11412.1 11460.3 11584.9 11591.7 7915.6 8235.5 8364.2 8366.8 8638.0 9595.0 9595.8 9702.5 9703.1 9704.9 8485.6 8712.2 8737.5 8778.0 8849.6 8391.6 8391.8 8485.5 8563.7 8652.3 7555.0 7563.3 7665.3 7671.7 7684.9 5300.7 5570.3 5587.3 5629.0 5739.1 5550.9 5563.8 5582.8 5614.5 5629.5 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#4] prototype.html Cycles:180 Average:5087.25 Median:5829.99 stddev:1517.50 (26.0%) stddev-sans-first:1479.41 12:48:06 INFO - PROCESS | 30798 | Values: 344.1 345.2 348.1 350.9 350.9 5743.0 5761.3 5795.7 5817.4 5827.5 5731.5 5737.0 5739.3 5750.0 5767.9 4229.7 4261.2 4425.4 4434.3 4446.4 4405.4 4417.9 4427.8 4433.4 4437.4 4417.3 4425.2 4425.4 4429.6 4430.7 4288.4 4412.4 4423.7 4444.4 4465.3 3858.4 3876.4 3879.5 3883.6 3900.6 5488.5 5514.1 5520.9 5556.2 5565.4 4972.5 5056.9 5066.4 5087.5 5093.6 5889.8 5942.8 5972.7 5982.4 6019.3 4313.9 4325.7 4330.4 4332.2 4333.7 5940.6 6209.9 6239.2 6273.7 6299.2 4353.0 4366.8 4386.3 4386.6 4392.7 4418.9 4429.8 4443.6 4444.8 4445.8 4811.5 5066.5 5084.4 5088.3 5092.1 6011.7 6017.6 6053.1 6079.8 6082.8 1490.7 1495.9 1502.5 1521.2 1538.1 954.9 1006.7 1015.3 1038.7 1044.9 5836.4 5875.5 5904.5 5921.8 5938.6 6162.2 6170.5 6190.5 6192.3 6202.4 5732.5 6034.0 6042.8 6044.3 6050.6 3321.7 3325.2 3364.6 3375.9 3382.2 6226.6 6420.7 6481.5 6486.6 6487.9 6343.1 6384.4 6395.9 6441.3 6441.5 6076.3 6428.7 6430.5 6444.9 6448.9 6256.0 6281.2 6286.4 6298.4 6298.5 5968.6 6158.9 6192.5 6206.2 6228.2 6393.7 6399.3 6447.5 6495.4 6512.5 4338.6 4385.8 4391.3 4400.8 4401.8 6088.2 6270.8 6282.4 6287.0 6292.2 6056.7 6066.7 6116.2 6118.8 6136.6 5893.6 6063.6 6096.8 6105.7 6107.8 5832.5 5930.9 5963.4 5965.5 5982.0 6097.1 6120.2 6139.0 6140.6 6148.1 5749.6 5971.1 5997.8 6021.9 6031.8 12:48:06 INFO - PROCESS | 30798 | 12:48:06 INFO - PROCESS | 30798 | [#5] yui.html Cycles:180 Average:19937.18 Median:4159.70 stddev:27583.18 (663.1%) stddev-sans-first:27623.13 12:48:06 INFO - PROCESS | 30798 | Values: 799.6 804.2 812.0 847.7 875.7 15275.2 15383.2 15554.8 15567.3 15587.5 14813.9 14825.4 14868.8 14873.9 14877.9 698.8 832.7 837.0 837.8 838.5 832.5 840.4 851.6 854.4 858.9 891.3 893.5 894.0 894.1 894.4 912.7 915.1 915.8 917.7 920.3 645.4 649.5 649.9 649.9 653.3 14909.5 14930.4 14965.0 14984.5 15005.0 14242.2 15154.1 15486.4 15541.2 15595.1 12412.4 12470.3 12503.2 12553.8 12760.1 3997.5 4072.5 4126.2 4129.4 4190.0 77019.0 79643.0 80336.6 80783.6 81210.8 11610.6 11793.3 11892.3 11950.9 11998.7 20176.7 20250.6 20450.6 20509.2 20583.2 8308.0 8368.8 8386.0 8510.4 8758.8 4812.5 4879.2 4986.1 5017.1 5032.5 3785.6 3884.8 3891.7 3892.3 3897.0 617.8 624.5 630.6 635.5 640.2 652.9 677.2 681.9 738.6 759.4 10056.3 10189.3 10521.3 10549.5 10648.9 663.9 698.3 771.5 822.2 861.3 4747.1 4931.5 4940.1 4984.3 5016.8 103723.0 103771.0 106439.5 107294.5 111650.0 79578.6 88384.6 93166.0 96619.5 101437.0 56030.4 56622.2 56853.7 57612.0 88214.6 9251.5 9692.8 9788.1 9793.4 9806.5 38171.6 47963.0 52355.2 53247.0 53654.7 66989.0 68603.0 76399.6 77293.6 79076.6 11235.9 13126.4 13278.7 13298.5 13534.0 13568.8 13938.4 15238.9 16041.6 16713.7 14213.7 14255.9 14659.3 14683.3 14843.1 12711.0 12858.5 12893.2 14957.9 14980.6 13977.6 14094.8 14481.7 14618.1 15261.3 11112.0 11715.7 11734.4 12045.9 12239.4 12498.8 12514.4 12582.6 12594.2 12652.6 12:48:06 INFO - PROCESS | 30798 | -------- Summary: end -------- 12:48:06 INFO - PROCESS | 30798 | 12:48:07 INFO - TEST-INFO | 30798: exit 0 12:48:07 INFO - TEST-OK | dromaeo_css | took 1110772ms 12:48:07 INFO - TEST-START | kraken 12:48:07 INFO - operating with platform_type : linux_ 12:48:07 INFO - Initialising browser for kraken test... 12:48:07 INFO - TEST-INFO | started process 31039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWK9quu/profile http://localhost:52648/getInfo.html) 12:48:11 INFO - PROCESS | 31039 | __metrics Screen width/height:1600/1200 12:48:11 INFO - PROCESS | 31039 | colorDepth:24 12:48:11 INFO - PROCESS | 31039 | Browser inner width/height: 1024/697 12:48:11 INFO - PROCESS | 31039 | __metrics 12:48:12 ERROR - PROCESS | 31039 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 12:48:13 INFO - TEST-INFO | 31039: exit 0 12:48:13 INFO - Browser initialized. 12:48:13 INFO - Running cycle 1/1 for kraken test... 12:48:13 INFO - TEST-INFO | started process 31167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWK9quu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:48:25 INFO - PROCESS | 31167 | RSS: Main: 155672576 12:48:25 INFO - PROCESS | 31167 | 12:48:27 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52648/tests/kraken/driver.html?testName=audio-beat-detection) 12:48:28 INFO - PROCESS | 31167 | RSS: Main: 161095680 12:48:28 INFO - PROCESS | 31167 | 12:48:31 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52648/tests/kraken/driver.html?testName=audio-dft) 12:48:31 INFO - PROCESS | 31167 | RSS: Main: 160808960 12:48:31 INFO - PROCESS | 31167 | 12:48:34 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52648/tests/kraken/driver.html?testName=audio-fft) 12:48:35 INFO - PROCESS | 31167 | RSS: Main: 161304576 12:48:35 INFO - PROCESS | 31167 | 12:48:37 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52648/tests/kraken/driver.html?testName=audio-oscillator) 12:48:37 INFO - PROCESS | 31167 | RSS: Main: 161468416 12:48:37 INFO - PROCESS | 31167 | 12:48:40 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:48:40 INFO - PROCESS | 31167 | RSS: Main: 161140736 12:48:40 INFO - PROCESS | 31167 | 12:48:43 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52648/tests/kraken/driver.html?testName=imaging-darkroom) 12:48:44 INFO - PROCESS | 31167 | RSS: Main: 161202176 12:48:44 INFO - PROCESS | 31167 | 12:48:47 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52648/tests/kraken/driver.html?testName=imaging-desaturate) 12:48:48 INFO - PROCESS | 31167 | RSS: Main: 161591296 12:48:48 INFO - PROCESS | 31167 | 12:48:51 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52648/tests/kraken/driver.html?testName=json-parse-financial) 12:48:51 INFO - PROCESS | 31167 | RSS: Main: 161230848 12:48:51 INFO - PROCESS | 31167 | 12:48:53 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:48:53 INFO - PROCESS | 31167 | RSS: Main: 161230848 12:48:53 INFO - PROCESS | 31167 | 12:48:55 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:48:56 INFO - PROCESS | 31167 | RSS: Main: 160894976 12:48:56 INFO - PROCESS | 31167 | 12:48:58 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:48:59 INFO - PROCESS | 31167 | RSS: Main: 161521664 12:48:59 INFO - PROCESS | 31167 | 12:49:01 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:49:02 INFO - PROCESS | 31167 | RSS: Main: 161529856 12:49:02 INFO - PROCESS | 31167 | 12:49:04 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:49:05 INFO - PROCESS | 31167 | RSS: Main: 161779712 12:49:05 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | Cycle 1(1): loaded http://localhost:52648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52648/tests/kraken/driver.html?testName=ai-astar) 12:49:07 INFO - PROCESS | 31167 | RSS: Main: 162496512 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | __start_tp_report 12:49:07 INFO - PROCESS | 31167 | _x_x_mozilla_page_load 12:49:07 INFO - PROCESS | 31167 | _x_x_mozilla_page_load_details 12:49:07 INFO - PROCESS | 31167 | |i|pagename|runs| 12:49:07 INFO - PROCESS | 31167 | |0;ai-astar;112;106;110;111;111;112;110;111;110;111 12:49:07 INFO - PROCESS | 31167 | |1;audio-beat-detection;158;124;150;171;125;153;160;125;180;126 12:49:07 INFO - PROCESS | 31167 | |2;audio-dft;162;163;161;164;164;162;160;161;160;161 12:49:07 INFO - PROCESS | 31167 | |3;audio-fft;75;75;76;181;75;74;74;76;180;76 12:49:07 INFO - PROCESS | 31167 | |4;audio-oscillator;84;84;155;84;84;84;142;85;86;150 12:49:07 INFO - PROCESS | 31167 | |5;imaging-gaussian-blur;117;117;117;117;118;117;120;118;117;118 12:49:07 INFO - PROCESS | 31167 | |6;imaging-darkroom;147;147;148;146;146;146;146;147;148;146 12:49:07 INFO - PROCESS | 31167 | |7;imaging-desaturate;95;99;98;95;95;95;95;95;95;95 12:49:07 INFO - PROCESS | 31167 | |8;json-parse-financial;51;54;54;51;53;53;55;52;52;52 12:49:07 INFO - PROCESS | 31167 | |9;json-stringify-tinderbox;62;61;60;61;61;60;60;60;61;61 12:49:07 INFO - PROCESS | 31167 | |10;stanford-crypto-aes;76;76;76;76;78;78;84;79;106;82 12:49:07 INFO - PROCESS | 31167 | |11;stanford-crypto-ccm;128;117;126;117;136;127;118;150;138;119 12:49:07 INFO - PROCESS | 31167 | |12;stanford-crypto-pbkdf2;154;153;152;152;158;151;155;151;154;151 12:49:07 INFO - PROCESS | 31167 | |13;stanford-crypto-sha256-iterative;66;62;61;61;65;59;60;60;59;59 12:49:07 INFO - PROCESS | 31167 | __end_tp_report 12:49:07 INFO - PROCESS | 31167 | __start_cc_report 12:49:07 INFO - PROCESS | 31167 | _x_x_mozilla_cycle_collect,874 12:49:07 INFO - PROCESS | 31167 | __end_cc_report 12:49:07 INFO - PROCESS | 31167 | __startTimestamp1465501747424__endTimestamp 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | ------- Summary: start ------- 12:49:07 INFO - PROCESS | 31167 | Number of tests: 14 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.71 (1.5%) stddev-sans-first:1.72 12:49:07 INFO - PROCESS | 31167 | Values: 112.0 106.0 110.0 111.0 111.0 112.0 110.0 111.0 110.0 111.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:155.50 stddev:20.92 (13.5%) stddev-sans-first:21.82 12:49:07 INFO - PROCESS | 31167 | Values: 158.0 124.0 150.0 171.0 125.0 153.0 160.0 125.0 180.0 126.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 12:49:07 INFO - PROCESS | 31167 | Values: 162.0 163.0 161.0 164.0 164.0 162.0 160.0 161.0 160.0 161.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#3] audio-fft Cycles:10 Average:96.20 Median:75.00 stddev:44.44 (59.2%) stddev-sans-first:46.47 12:49:07 INFO - PROCESS | 31167 | Values: 75.0 75.0 76.0 181.0 75.0 74.0 74.0 76.0 180.0 76.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#4] audio-oscillator Cycles:10 Average:103.80 Median:84.00 stddev:31.35 (37.3%) stddev-sans-first:32.42 12:49:07 INFO - PROCESS | 31167 | Values: 84.0 84.0 155.0 84.0 84.0 84.0 142.0 85.0 86.0 150.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 12:49:07 INFO - PROCESS | 31167 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 120.0 118.0 117.0 118.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:49:07 INFO - PROCESS | 31167 | Values: 147.0 147.0 148.0 146.0 146.0 146.0 146.0 147.0 148.0 146.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.56 12:49:07 INFO - PROCESS | 31167 | Values: 95.0 99.0 98.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.34 (2.5%) stddev-sans-first:1.27 12:49:07 INFO - PROCESS | 31167 | Values: 51.0 54.0 54.0 51.0 53.0 53.0 55.0 52.0 52.0 52.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 12:49:07 INFO - PROCESS | 31167 | Values: 62.0 61.0 60.0 61.0 61.0 60.0 60.0 60.0 61.0 61.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:78.00 stddev:9.17 (11.8%) stddev-sans-first:9.54 12:49:07 INFO - PROCESS | 31167 | Values: 76.0 76.0 76.0 76.0 78.0 78.0 84.0 79.0 106.0 82.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:10.93 (8.6%) stddev-sans-first:11.59 12:49:07 INFO - PROCESS | 31167 | Values: 128.0 117.0 126.0 117.0 136.0 127.0 118.0 150.0 138.0 119.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.10 Median:153.50 stddev:2.23 (1.5%) stddev-sans-first:2.35 12:49:07 INFO - PROCESS | 31167 | Values: 154.0 153.0 152.0 152.0 158.0 151.0 155.0 151.0 154.0 151.0 12:49:07 INFO - PROCESS | 31167 | 12:49:07 INFO - PROCESS | 31167 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.20 Median:61.00 stddev:2.49 (4.1%) stddev-sans-first:1.94 12:49:07 INFO - PROCESS | 31167 | Values: 66.0 62.0 61.0 61.0 65.0 59.0 60.0 60.0 59.0 59.0 12:49:07 INFO - PROCESS | 31167 | -------- Summary: end -------- 12:49:07 INFO - PROCESS | 31167 | 12:49:08 INFO - TEST-INFO | 31167: exit 0 12:49:08 INFO - TEST-OK | kraken | took 60996ms 12:49:08 INFO - SUITE-END | took 1171s 12:49:08 INFO - Completed test suite (00:19:32) 12:49:08 INFO - javascript benchmark 12:49:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7671.866887951582, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3428.9485657715154, 3447.3622379859726, 3457.7406694497918, 3463.480477928312, 3463.9826800865976, 5656.604037717357, 5708.600397972138, 5784.768609255635, 5785.958527465054, 5800.187973683687, 5765.4522820332, 5845.503132233765, 5854.941450585493, 5857.472827445529, 5858.912116318259, 5224.712640804754, 5279.155335146377, 5306.044911915854, 5325.281087053257, 5387.892242155154, 5165.819196328111, 5279.604029697769, 5356.250124982505, 5363.704996225206, 5374.543163831079, 5271.525562699357, 5275.894482110355, 5284.39229488608, 5305.814296499623, 5319.813806516772, 5362.570994320445, 5371.704556249405, 5379.677219366811, 5399.487048730384, 5406.432324605899, 5065.949340506621, 5150.253213284091, 5202.06362854686, 5278.261043453919, 5302.2311764793885, 5710.828675139753, 5711.7144142792695, 5738.0, 5744.741486633112, 5746.482816546531, 6220.1913751212505, 6262.96868515659, 6269.122322874801, 6278.748850045993, 6296.779612713579, 5998.340182579913, 6154.661493617849, 6174.691265436711, 6198.34917333678, 6344.49244060474, 5839.6204246724255, 5840.2991641003355, 5842.328132264759, 5848.9179501792305, 5886.999210134245, 6268.404501572343, 6310.832495988257, 6348.1430006949395, 6367.140436041075, 6401.615903045832, 5915.852103697442, 6003.369646187175, 6022.18700475439, 6064.877997570376, 6105.877882442326, 6166.282793662852, 6174.6912654368, 6205.379462053758, 6209.099680546386, 6212.968935155295, 6060.818175454743, 6102.267727872595, 6152.261728592597, 6169.198004259418, 6180.536459765445, 6051.818445446644, 6068.393160683984, 6106.297775755756, 6124.469519445561, 6167.074938759222, 4682.461516925529, 4684.297355396649, 4689.718616882998, 4691.765411729468, 4741.2176990796825, 4142.5857414258335, 4147.709660323749, 4183.644390226865, 4193.203291374629, 4204.033072393367, 5808.94191058084, 5890.617109887844, 5964.970175149097, 5973.074173503114, 6043.123747056652, 6319.431251187415, 6360.0, 6364.172657554488, 6369.936300636934, 6379.234491860913, 5853.09277062056, 5875.441833025856, 6078.696065196811, 6095.512359011268, 6103.0, 5282.920756188661, 5329.8401047967845, 5366.302380690563, 5385.165299378603, 5415.756290966916, 6556.114924485229, 6585.0, 6585.703643336062, 6586.571872828251, 6615.536912416181, 6324.462420694293, 6365.649889256136, 6368.267649220399, 6383.616982981036, 6399.0, 6261.530385221217, 6395.42441180296, 6474.5791523550815, 6480.287168411377, 6546.770863019771, 6220.471259942775, 6220.906686399798, 6227.96886015567, 6233.189685340877, 6237.376262373908, 6286.779962701284, 6287.46556542699, 6342.143810585697, 6347.079673447417, 6351.491880649629, 5968.970155149196, 6082.817515474543, 6115.6662951758, 6138.572327483795, 6140.074827791203, 6060.636361818305, 6073.635581865102, 6079.635221886701, 6080.574359794772, 6110.633361998294, 5825.126231065374, 5887.116932460165, 5898.292204935436, 5899.144624029577, 5962.2249107615735, 5954.3152537458745, 5998.460138587374, 6015.368386319374, 6102.237220347457, 6102.633841969496, 5897.0, 5971.522278217645, 5977.790777322773, 5985.820425387245, 6002.759889604367], "value": 5739.168640387555, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.6055706019329, 649.5161104976793, 659.3571268013686, 663.5653646861308, 697.466438174796, 41583.79208103959, 43138.35292470615, 44087.559124408785, 44226.33660495091, 44421.0, 43261.0, 43994.78002609991, 44093.33859992103, 44108.558914410845, 44192.3371149433, 8684.30525557957, 8858.822823543525, 8873.911260887406, 8897.555122243863, 8902.599383027748, 8805.25155361795, 8897.0, 8927.55362231889, 8939.061398553156, 8962.148595883413, 8809.515476648781, 8908.153725396109, 8923.196912277894, 8924.330675199353, 8967.865482017774, 8830.735077947671, 8959.238464730506, 8967.148120928534, 8971.0, 8990.05604411534, 8772.210501054871, 8872.689455869078, 8893.155150260714, 8920.063393343671, 8921.063288354695, 35559.4666080009, 40107.19785604301, 40604.187916241506, 40698.79650601758, 40764.38853417201, 3278.6721327867263, 3373.0724050885956, 3480.6519348065244, 3537.5754909411035, 3635.073056370635, 32885.6711432885, 33079.3384132316, 33085.33829323424, 33640.831795841106, 34242.315153696785, 4409.382686423904, 4504.527024662396, 4512.413386259798, 4530.139273538017, 4601.608863246628, 322734.0, 325260.0, 325533.0, 325711.0, 327543.0, 38749.6125038746, 39262.411063834064, 39350.40974385387, 39410.211795764495, 39516.60483395129, 40202.0, 40887.38668919969, 41034.38448423276, 41047.58952410497, 41152.1769564607, 19160.520986975436, 19457.221711131395, 19495.512612184524, 19537.0, 19560.21759129619, 14836.18400987956, 14860.777088343684, 14914.17972011528, 14937.103773773608, 14982.325795339237, 20052.298169563994, 20389.694154587694, 20435.284765033153, 20456.590868182553, 20585.89707051455, 7197.89203161953, 7219.386352160021, 7321.597312147776, 7425.294597013275, 7517.887231691529, 990.6582229130938, 1045.0803293102022, 1114.3258328711013, 1156.0231604294358, 1172.806486929647, 32630.51054234141, 33341.0, 33437.0, 33579.16052098717, 33707.49438758421, 1126.8197088465806, 1134.804153962086, 1159.4029075026367, 1163.4241050679968, 1262.741138066694, 17245.0, 17578.472645820646, 17730.65598928245, 17751.467455976082, 17807.109644517983, 638171.0, 646488.0, 646556.0, 981917.0, 1002283.0, 63797.362026379145, 64889.67555162194, 65983.34016659867, 66286.66856665685, 66535.0, 1498.3781730581904, 1503.503843731566, 1525.4050920141153, 1527.747921592947, 1552.208373729406, 32966.34067318592, 33847.153821154665, 34333.656663433045, 34581.654183457846, 34658.0, 57981.4201857976, 59373.703131484064, 61620.38379616146, 68037.3196268031, 68181.3181868175, 554418.0, 561640.0, 561938.0, 562562.0, 562838.0, 46440.767796160806, 47150.0, 47331.52668473409, 47769.28346074881, 49693.50306497033, 52011.47988520218, 52937.20594191167, 52974.20538691845, 53321.20018199652, 54197.72901135627, 43933.56066439295, 44832.551674482835, 45215.32177017281, 47064.294035588806, 48836.26745598748, 44106.0, 44707.0, 44828.10343793171, 45724.31413528866, 46390.30414543717, 42713.786431067645, 42744.0, 43540.0, 45428.545714543754, 45613.0, 37050.25899482049, 38446.615533844306, 38521.22957540889, 38764.2247155061, 39116.2176756469, 29926.41618843851, 29951.550726738682, 30006.54990175193, 30261.243468913453, 30378.696213037587], "value": 21264.68180137208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.215821306665, 407.8429804525258, 414.19645886979276, 415.28570858124016, 424.0416658352123, 17054.914725426355, 18519.0, 19354.612907741837, 19786.30747923823, 20243.190272389103, 19510.31713890014, 19896.303629372975, 20004.69992950107, 20071.297504587343, 20175.49561260969, 5531.474509921551, 5781.075027995522, 5785.942140578603, 5789.131630255453, 5790.102534107199, 5513.8345849624575, 5566.137248726433, 5725.885482290351, 5726.7422965966425, 5893.58744887858, 5841.0362290222065, 5875.412458754112, 5876.265466816648, 5883.529317654577, 5888.941110588904, 5497.670139791625, 5820.854478638025, 5840.649561026331, 5863.76544938202, 5865.472107510302, 5624.71876406178, 5668.093105103205, 5729.341125770548, 5734.053881109612, 5756.856078598069, 18752.531186720305, 22774.316770496913, 23296.88351558248, 23571.410714732097, 23778.167764128346, 2373.2880135959144, 2384.2022935368436, 2426.745191754858, 2434.1237154624323, 2465.6794616699895, 9266.814663706755, 9497.905020949771, 9709.0, 9891.06034926688, 10519.52662130206, 1933.806619338055, 1998.870073445236, 1999.4001799460104, 2020.40398082566, 2061.4331058958755, 83410.99999999939, 84559.0, 85149.57425212896, 86995.0, 87085.12914870834, 10996.560137594406, 11076.280041797258, 11164.218504704755, 11292.491837867316, 11690.70773230659, 14262.286885655883, 14634.414623415158, 14669.193194374198, 14767.63080922964, 15082.698346033018, 8856.335774816915, 8874.156955089256, 8977.0, 9044.0, 9079.0, 8782.956085219534, 8830.381873268809, 8846.911530884738, 8877.289816814638, 8931.776705582282, 5130.461301563357, 5157.535821775983, 5158.329417175743, 5214.217867319932, 5223.764930578133, 1868.6169335286233, 2004.759428868516, 2099.580083983179, 2113.746350437957, 2116.5766846630736, 980.0836218136066, 1045.9947700261603, 1056.9365838049741, 1080.8919108089285, 1116.7598966222301, 18800.811991879906, 19325.710114348298, 19390.515237118903, 19574.21703131859, 19705.408837734893, 1014.8832884218261, 1057.5981127171626, 1062.490004797686, 1064.1539975719322, 1076.4832880217539, 10679.0, 10810.405427701551, 11005.724856878482, 11013.504392302366, 11071.225014249087, 516499.0, 519465.0, 525980.0, 528708.0, 532177.0, 95806.52096739471, 97043.0, 97615.51192243994, 98067.50966245124, 99756.50121749345, 997.7904640025531, 1001.3641337750436, 1054.8312270036756, 1083.3283364314175, 1084.3114622214794, 17149.655817116043, 17331.393401230896, 17377.21802518915, 17659.82340176633, 17754.644907102043, 33384.833075835435, 38419.0, 40054.399184012844, 41206.793966029974, 41828.95427614334, 53934.46065539294, 57786.13320800276, 59061.70469147627, 59518.0, 59653.70173149106, 8629.26651234627, 8755.430896991675, 8767.868481972648, 8852.114788521096, 8944.776380590278, 9584.185344245818, 10469.371837689763, 13281.0, 13960.720785584028, 14298.57104286873, 12203.0, 12216.572419965258, 12359.814602780785, 12372.13395062337, 12521.248725076524, 11897.702557435787, 11918.761624767283, 11923.165378423428, 12010.33943133136, 12242.571509997108, 12380.319082450551, 12512.0615953802, 12522.436490357773, 12829.16610420357, 12943.482260709843, 8968.417052891542, 8985.101489850962, 9000.954995225244, 9078.319126065704, 9155.77110572241, 8820.5589720515, 12146.93926530397, 12174.45214965311, 12283.877161228631, 12285.0], "value": 9450.731746842022, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.5079974408193, 1573.708863860186, 1711.8630509559237, 1817.3094224194804, 1842.189436647874, 8746.387752857287, 9315.860262096074, 9347.0, 10080.99999999999, 10095.747606309837, 9398.389104708189, 9644.614215431375, 9785.168260697832, 9809.215262778978, 9816.0, 2507.674002379688, 2536.353229926366, 2536.5941449368106, 2540.64430979663, 2543.5675935090985, 2458.815588830836, 2520.18094119411, 2535.5055764126005, 2535.556277651413, 2542.402535404188, 2473.4434752180705, 2490.3774056485877, 2514.2959971208093, 2521.697396312445, 2525.4191535946743, 2379.167291447997, 2380.9523809523885, 2389.522095580891, 2424.381782645423, 2430.3438071720625, 2357.7524359942304, 2404.5791986402483, 2404.61526155816, 2412.8311018228733, 2427.453822889853, 9648.807023859554, 9676.854847177297, 9701.90298097017, 9740.707778766577, 9753.90246097537, 5726.112452569859, 5882.176495290662, 5892.499137573312, 5898.0, 5907.350191478934, 3682.9447558286647, 3793.715471339633, 3837.079101015764, 3849.287881741887, 3912.1197730510694, 1254.3853511779253, 1301.1542497376781, 1308.6335825968745, 1324.8675132486771, 1328.9468421263139, 13953.86046139546, 14046.859531404658, 14072.014958952877, 14086.647833804134, 14088.084274522123, 4918.48355922623, 5029.723365214948, 5034.16936205522, 5044.218146187347, 5117.795288188431, 11803.645890623295, 11832.585859494877, 11854.881451185378, 11865.881341186478, 11883.762324753456, 5747.3677895431465, 5777.0467872801355, 5783.537317014629, 5799.449052340021, 5819.185314056035, 4667.7199368037345, 4957.429895561984, 5055.16589762685, 5092.363454568179, 5227.424983251839, 4274.358846173099, 4301.075268817157, 4301.225779359683, 4313.892152696208, 4337.240982827992, 1292.689754458923, 1315.2174456198738, 1324.9668758280927, 1329.6144118205611, 1364.0315376082895, 1059.904608585231, 1076.8277075667856, 1080.7514271717548, 1082.718493191776, 1090.803655342046, 6438.967805160944, 6477.77327793525, 6538.248101468297, 6600.966995164993, 6608.669566521655, 478.58124141376294, 485.03720115570565, 490.14959046055066, 490.9214525675875, 497.8257609836601, 4481.215787237221, 4512.458504979423, 4514.525974772667, 4518.480374756945, 4531.207038768202, 11813.350265735295, 12257.387130643432, 12269.07981901361, 12346.320952347707, 12417.875821241672, 12163.209391389708, 12177.0, 12204.511819527297, 12230.14388992762, 12296.446659900326, 8341.708040218564, 8525.0, 8557.48655080697, 8775.385722999456, 8888.0, 6650.301718319507, 6861.725530978705, 6886.586804791728, 6961.6519174042105, 6999.230084690782, 11249.887501124884, 11316.434178291218, 11407.087433005505, 11499.310041397543, 11504.94247528757, 11305.660830175108, 11412.08703303717, 11460.312381257152, 11584.94207528957, 11591.710207244887, 7915.643796029308, 8235.50586964784, 8364.205400486944, 8366.83266334682, 8637.956810215908, 9595.040495950629, 9595.808083838423, 9702.5148742564, 9703.12671859536, 9704.902950970682, 8485.575721214038, 8712.172343627346, 8737.519436431057, 8778.0, 8849.64601415962, 8391.622376992927, 8391.790205244917, 8485.533295668798, 8563.657453702031, 8652.264557512683, 7554.962225188839, 7563.281488258606, 7665.271799179069, 7671.693132274647, 7684.9231507686445, 5300.681959082313, 5570.275864137636, 5587.3015873015875, 5629.0, 5739.081746920473, 5550.888982220252, 5563.833085007456, 5582.7766889323975, 5614.466625670555, 5629.54963602919], "value": 4997.480048547192, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.13106905064717, 345.23013679494727, 348.0758585954292, 350.8807005618089, 350.9210427653778, 5742.966266072105, 5761.30864296284, 5795.652260864345, 5817.360090390059, 5827.475527202551, 5731.541476681866, 5737.0, 5739.311282646078, 5750.0, 5767.855803604912, 4229.688796473088, 4261.169072030955, 4425.380446737459, 4434.334849772527, 4446.444194475691, 4405.427294451717, 4417.873442272216, 4427.756473393962, 4433.357163211333, 4437.35658329542, 4417.27115026022, 4425.159219748238, 4425.402570652969, 4429.557044295577, 4430.734155950653, 4288.356746488021, 4412.4043254160915, 4423.668224883147, 4444.444444444444, 4465.285554311311, 3858.440526123696, 3876.3604005339084, 3879.495665563487, 3883.5533913600016, 3900.5709371969347, 5488.53347465466, 5514.145307477347, 5520.944790552083, 5556.222128901957, 5565.41563135873, 4972.5276098770555, 5056.873578160538, 5066.36670416198, 5087.499187739626, 5093.643444958854, 5889.823305300848, 5942.762289508458, 5972.731227094791, 5982.37185095563, 6019.337872833985, 4313.870583882489, 4325.675574331937, 4330.437043184366, 4332.241857674926, 4333.659823695232, 5940.584159108864, 6209.944309467402, 6239.220097487814, 6273.686315684243, 6299.212598425197, 4352.956470435255, 4366.759828209415, 4386.298192289282, 4386.561343865588, 4392.692511524163, 4418.911621767546, 4429.844955426544, 4443.644508439317, 4444.777761111932, 4445.777711114431, 4811.518848115231, 5066.544011038951, 5084.3898732152375, 5088.287639730441, 5092.0579692756955, 6011.729472173763, 6017.608855424471, 6053.122297266872, 6079.75680972765, 6082.787102451393, 1490.709311684233, 1495.940162393492, 1502.481643832876, 1521.2241756704161, 1538.1155835394693, 954.9236061115095, 1006.6577363696379, 1015.28422462164, 1038.7351225437465, 1044.8746150461993, 5836.387179346192, 5875.531117220695, 5904.5238690327415, 5921.822345329647, 5938.61399009063, 6162.168107305456, 6170.5372097092895, 6190.473809726133, 6192.256929168529, 6202.4417802398, 5732.541396688255, 6034.0, 6042.758289668452, 6044.274687037496, 6050.57645964787, 3321.7342612590933, 3325.2019515316633, 3364.5794275715534, 3375.915602109967, 3382.2051817822794, 6226.62640241587, 6420.7431702731365, 6481.546291759531, 6486.610803351814, 6487.859006527835, 6343.111964324999, 6384.361563843671, 6395.936040639534, 6441.25925518562, 6441.516886233551, 6076.27084749824, 6428.682120165355, 6430.549861509649, 6444.904366257748, 6448.9355106449275, 6256.0, 6281.246250449793, 6286.37136286386, 6298.370162983665, 6298.464630506458, 5968.641881487125, 6158.938410615837, 6192.535559833121, 6206.193194884636, 6228.22147231596, 6393.680315984089, 6399.328070552711, 6447.451966582893, 6495.382938620824, 6512.502124511484, 4338.566143385762, 4385.758783266951, 4391.3193455014525, 4400.845970391149, 4401.823927042882, 6088.208532890696, 6270.811875643738, 6282.403171698681, 6287.0, 6292.244930608356, 6056.7274472649715, 6066.696665166813, 6116.174316467398, 6118.816435506942, 6136.64993701385, 5893.616914900518, 6063.636181829104, 6096.756129754937, 6105.694715264308, 6107.786227482017, 5832.50423713989, 5930.851728706644, 5963.373845746134, 5965.464677512126, 5982.0, 6097.115918191926, 6120.234970628671, 6138.969305153446, 6140.631562106288, 6148.079662160438, 5749.597528172988, 5971.104014553025, 5997.790077347272, 6021.909671354845, 6031.7587296507645], "value": 4598.07269823046, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.6161842315688, 804.213682554024, 811.9797005074872, 847.6760786802027, 875.7110153649296, 15275.236238188088, 15383.153926534036, 15554.84445155548, 15567.29947152378, 15587.45443909462, 14813.851861481382, 14825.406983720639, 14868.776968345483, 14873.851261487382, 14877.851221487781, 698.8287869471986, 832.7127141136298, 836.9832603347929, 837.7654256808104, 838.4759525296689, 832.5421018439864, 840.3613253926999, 851.5827244650108, 854.4275335525182, 858.9184027517407, 891.3047822698305, 893.5041052216018, 894.0433735902587, 894.0880302091863, 894.432035657359, 912.6668765900398, 915.0666320353236, 915.7939463620633, 917.729269865388, 920.3097676742443, 645.4320198225579, 649.4901502320656, 649.8830210562097, 649.9480041596709, 653.2846533046354, 14909.478168264168, 14930.402783888632, 14965.0, 14984.47554335593, 15005.0, 14242.216678082701, 15154.090754554762, 15486.380544778196, 15541.222938853012, 15595.064296142154, 12412.441440135126, 12470.314132722697, 12503.187292825936, 12553.811692824615, 12760.106792524526, 3997.520297564282, 4072.490938632671, 4126.174765047002, 4129.380592911058, 4190.015346393595, 77019.0, 79643.0, 80336.59831700863, 80783.5960820198, 81210.78183827306, 11610.593629222936, 11793.29240245588, 11892.345920974429, 11950.880491194977, 11998.700032499257, 20176.69734953977, 20250.594988100154, 20450.59098818045, 20509.17963281482, 20583.176672933216, 8307.958460207781, 8368.832623347498, 8386.0, 8510.404271700922, 8758.824823503493, 4812.470628230892, 4879.194932836042, 4986.077575648516, 5017.122003649347, 5032.547070763649, 3785.6025117362833, 3884.786336751449, 3891.747036442622, 3892.2604705106505, 3896.980515097406, 617.7528988404584, 624.5097598385337, 630.5932673425615, 635.5106567942751, 640.1837656987378, 652.8531080506943, 677.2110491277705, 681.924988251292, 738.5605564689001, 759.4152502572988, 10056.29605927578, 10189.286749927434, 10521.316114452537, 10549.525271362807, 10648.946755266328, 663.8738639658546, 698.2528694297054, 771.4908160613968, 822.1860358245294, 861.3453775130946, 4747.145513807548, 4931.506849315111, 4940.110780059552, 4984.27727979441, 5016.799328026838, 103723.0, 103771.0, 106439.46780266204, 107294.46352768186, 111650.0, 79578.6021069891, 88384.55807721049, 93166.0, 96619.51690241645, 101437.0, 56030.43969560334, 56622.15066774002, 56853.71573142108, 57612.0, 88214.55892720624, 9251.491167985825, 9692.757681057748, 9788.119069283799, 9793.412395256308, 9806.509674516388, 38171.618283817916, 47963.0, 52355.21467177919, 53247.0, 53654.73172634112, 66989.0, 68603.0, 76399.61800190964, 77293.61353193199, 79076.60461697655, 11235.887641123483, 13126.40931158081, 13278.734425311246, 13298.468061277828, 13534.0, 13568.79646805279, 13938.372773225026, 15238.923805380902, 16041.598960026093, 16713.74929376036, 14213.715725685635, 14255.928720356747, 14659.267036647912, 14683.265836708335, 14843.109413435228, 12711.0, 12858.549950751678, 12893.161944473579, 14957.850421496081, 14980.625484362978, 13977.58067257984, 14094.788578171541, 14481.710365792836, 14618.122912625277, 15261.313240904408, 11112.0, 11715.685298392984, 11734.413279335828, 12045.879541204826, 12239.449224784728, 12498.75002499963, 12514.436850341574, 12582.622521324374, 12594.181378210387, 12652.557160499338], "value": 7692.472325714911, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 111.0, 111.0, 112.0, 110.0, 111.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 150.0, 171.0, 125.0, 153.0, 160.0, 125.0, 180.0, 126.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 164.0, 164.0, 162.0, 160.0, 161.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 181.0, 75.0, 74.0, 74.0, 76.0, 180.0, 76.0], "value": 96.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 84.0, 84.0, 84.0, 142.0, 85.0, 86.0, 150.0], "value": 103.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 98.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 54.0, 51.0, 53.0, 53.0, 55.0, 52.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 78.0, 78.0, 84.0, 79.0, 106.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 117.0, 126.0, 117.0, 136.0, 127.0, 118.0, 150.0, 138.0, 119.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 152.0, 152.0, 158.0, 151.0, 155.0, 151.0, 154.0, 151.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 61.0, 61.0, 65.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 61.2, "unit": "score"}]}]} 12:49:08 INFO - Return code: 0 12:49:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:49:08 ERROR - # TBPL SUCCESS # 12:49:08 INFO - Running post-action listener: _resource_record_post_action 12:49:08 INFO - ##### 12:49:08 INFO - ##### Finished run-tests step (success) 12:49:08 INFO - ##### 12:49:08 INFO - Running post-run listener: _resource_record_post_run 12:49:08 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505233408; Read time: 20; Write time: 412940 12:49:08 INFO - TinderboxPrint: CPU usage
13.3% 12:49:08 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 20 12:49:08 INFO - TinderboxPrint: I/O write bytes / time
505,233,408 / 412,940 12:49:08 INFO - TinderboxPrint: CPU idle
8,220.8 (86.7%) 12:49:08 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 12:49:08 INFO - TinderboxPrint: Swap in / out
0 / 0 12:49:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252342272; Read time: 0; Write time: 239548 12:49:08 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 252735488; Read time: 20; Write time: 173356 12:49:09 INFO - Running post-run listener: _upload_blobber_files 12:49:09 INFO - Blob upload gear active. 12:49:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:49:09 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 12:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:49:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:10 INFO - (blobuploader) - INFO - Done attempting. 12:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:49:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:13 INFO - (blobuploader) - INFO - Done attempting. 12:49:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:49:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:49:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:49:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:49:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:49:14 INFO - (blobuploader) - INFO - Done attempting. 12:49:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:49:14 INFO - Return code: 0 12:49:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:49:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:49:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/268a7a059fba44b03eb011719b239ee00bb78e8787d32f901cf2652c7db9e6a1d28c446d26a6c60adc75ec1261a9ca422a9958709192411bb14fc5ab931a6d7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa2bb1ccddea6ef1a3f8d5df3b5017296ab81623c3abf2f530c12e9ff7dacba595feb91b10019b6566fa75e43eb3bffa3c7fcb77add755cba7909f8e144ce19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3606e6877344f1e0ead3b18abf6c947f45967c5bce77d6a87580ce6009f4dd8d084097cc071968cf7df45ec914ecece4d48d81df4e8c46dc770c5f9751368779"} 12:49:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:49:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:49:14 INFO - Contents: 12:49:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/268a7a059fba44b03eb011719b239ee00bb78e8787d32f901cf2652c7db9e6a1d28c446d26a6c60adc75ec1261a9ca422a9958709192411bb14fc5ab931a6d7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa2bb1ccddea6ef1a3f8d5df3b5017296ab81623c3abf2f530c12e9ff7dacba595feb91b10019b6566fa75e43eb3bffa3c7fcb77add755cba7909f8e144ce19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3606e6877344f1e0ead3b18abf6c947f45967c5bce77d6a87580ce6009f4dd8d084097cc071968cf7df45ec914ecece4d48d81df4e8c46dc770c5f9751368779"} 12:49:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:49:14 INFO - Copying logs to upload dir... 12:49:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:49:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.098287 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-09 12:49:14.569350) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:49:14.573551) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/268a7a059fba44b03eb011719b239ee00bb78e8787d32f901cf2652c7db9e6a1d28c446d26a6c60adc75ec1261a9ca422a9958709192411bb14fc5ab931a6d7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa2bb1ccddea6ef1a3f8d5df3b5017296ab81623c3abf2f530c12e9ff7dacba595feb91b10019b6566fa75e43eb3bffa3c7fcb77add755cba7909f8e144ce19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3606e6877344f1e0ead3b18abf6c947f45967c5bce77d6a87580ce6009f4dd8d084097cc071968cf7df45ec914ecece4d48d81df4e8c46dc770c5f9751368779"} build_url:https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/CroygOq3Qdmv-C0FzBWfcQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/268a7a059fba44b03eb011719b239ee00bb78e8787d32f901cf2652c7db9e6a1d28c446d26a6c60adc75ec1261a9ca422a9958709192411bb14fc5ab931a6d7d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa2bb1ccddea6ef1a3f8d5df3b5017296ab81623c3abf2f530c12e9ff7dacba595feb91b10019b6566fa75e43eb3bffa3c7fcb77add755cba7909f8e144ce19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3606e6877344f1e0ead3b18abf6c947f45967c5bce77d6a87580ce6009f4dd8d084097cc071968cf7df45ec914ecece4d48d81df4e8c46dc770c5f9751368779"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 12:49:14.602226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:49:14.602747) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465499793.427888-981765562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 12:49:14.687769) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:49:14.688610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 12:49:14.689489) ========= ========= Total master_lag: 0.19 =========