builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1466066753.0 results: success (0) buildid: 20160616000726 builduid: 6ec867bba8354a8baeab27087efa5a18 revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:52.996382) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:52.997539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:52.998254) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:53.010001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:53.010599) ========= 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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 01:45:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.2M=0s 2016-06-16 01:45:54 (38.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:53.158476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:53.158844) ========= 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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:53.211933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 01:45:53.212811) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 01:45:54,308 truncating revision to first 12 chars 2016-06-16 01:45:54,308 Setting DEBUG logging. 2016-06-16 01:45:54,308 attempt 1/10 2016-06-16 01:45:54,308 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 01:45:55,446 unpacking tar archive at: mozilla-central-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=1.471454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 01:45:54.700158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:54.700546) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:54.701032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:54.701343) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 01:45:54.710289) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-16 01:45:54.710616) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:45:55 INFO - MultiFileLogger online at 20160616 01:45:55 in /builds/slave/test 01:45:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:45:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:45:55 INFO - {'append_to_log': False, 01:45:55 INFO - 'base_work_dir': '/builds/slave/test', 01:45:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:45:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:45:55 INFO - 'branch': 'Firefox-Non-PGO', 01:45:55 INFO - 'buildbot_json_path': 'buildprops.json', 01:45:55 INFO - 'config_files': ('talos/linux_config.py',), 01:45:55 INFO - 'default_actions': ('clobber', 01:45:55 INFO - 'read-buildbot-config', 01:45:55 INFO - 'download-and-extract', 01:45:55 INFO - 'populate-webroot', 01:45:55 INFO - 'create-virtualenv', 01:45:55 INFO - 'install', 01:45:55 INFO - 'run-tests'), 01:45:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:45:55 INFO - 'download_minidump_stackwalk': True, 01:45:55 INFO - 'download_symbols': 'ondemand', 01:45:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:45:55 INFO - 'tooltool.py': '/tools/tooltool.py', 01:45:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:45:55 INFO - '/tools/misc-python/virtualenv.py')}, 01:45:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:45:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:45:55 INFO - 'installer_path': 'installer.exe', 01:45:55 INFO - 'log_level': 'info', 01:45:55 INFO - 'log_name': 'talos', 01:45:55 INFO - 'log_to_console': True, 01:45:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:45:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:45:55 INFO - 'opt_config_files': (), 01:45:55 INFO - 'pip_index': False, 01:45:55 INFO - 'sps_profile': False, 01:45:55 INFO - 'sps_profile_interval': 0, 01:45:55 INFO - 'suite': 'dromaeojs-e10s', 01:45:55 INFO - 'system_bits': '32', 01:45:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:45:55 INFO - 'title': 'talos-linux64-ix-063', 01:45:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:45:55 INFO - 'use_talos_json': True, 01:45:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:45:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:45:55 INFO - 'work_dir': 'build'} 01:45:55 INFO - ##### 01:45:55 INFO - ##### Running clobber step. 01:45:55 INFO - ##### 01:45:55 INFO - Running pre-action listener: _resource_record_pre_action 01:45:55 INFO - Running main action method: clobber 01:45:55 INFO - rmtree: /builds/slave/test/build 01:45:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:45:56 INFO - Running post-action listener: _resource_record_post_action 01:45:56 INFO - ##### 01:45:56 INFO - ##### Finished clobber step (success) 01:45:56 INFO - ##### 01:45:56 INFO - ##### 01:45:56 INFO - ##### Running read-buildbot-config step. 01:45:56 INFO - ##### 01:45:56 INFO - Running pre-action listener: _resource_record_pre_action 01:45:56 INFO - Running main action method: read_buildbot_config 01:45:56 INFO - Using buildbot properties: 01:45:56 INFO - { 01:45:56 INFO - "project": "", 01:45:56 INFO - "product": "firefox", 01:45:56 INFO - "script_repo_revision": "production", 01:45:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 01:45:56 INFO - "repository": "", 01:45:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 01:45:56 INFO - "buildid": "20160616000726", 01:45:56 INFO - "pgo_build": "False", 01:45:56 INFO - "basedir": "/builds/slave/test", 01:45:56 INFO - "buildnumber": 348, 01:45:56 INFO - "slavename": "talos-linux64-ix-063", 01:45:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:45:56 INFO - "platform": "ubuntu64_hw", 01:45:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:45:56 INFO - "branch": "mozilla-central", 01:45:56 INFO - "repo_path": "mozilla-central", 01:45:56 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 01:45:56 INFO - "stage_platform": "linux64", 01:45:56 INFO - "builduid": "6ec867bba8354a8baeab27087efa5a18", 01:45:56 INFO - "slavebuilddir": "test" 01:45:56 INFO - } 01:45:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:45:56 INFO - Running post-action listener: _resource_record_post_action 01:45:56 INFO - ##### 01:45:56 INFO - ##### Finished read-buildbot-config step (success) 01:45:56 INFO - ##### 01:45:56 INFO - ##### 01:45:56 INFO - ##### Running download-and-extract step. 01:45:56 INFO - ##### 01:45:56 INFO - Running pre-action listener: _resource_record_pre_action 01:45:56 INFO - Running main action method: download_and_extract 01:45:56 INFO - mkdir: /builds/slave/test/build/tests 01:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:56 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:45:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:45:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:45:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:45:57 INFO - Downloaded 1361 bytes. 01:45:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:45:57 INFO - Using the following test package requirements: 01:45:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:45:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:45:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'jsshell-linux-x86_64.zip'], 01:45:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:45:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:45:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:45:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:45:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:45:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:45:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:45:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:45: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')]} 01:45:57 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:45:58 INFO - Downloaded 22654279 bytes. 01:45:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:45:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:45:59 INFO - Return code: 0 01:45:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:45:59 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:45:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:45:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:00 INFO - Downloaded 22654279 bytes. 01:46:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:46:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:46:04 INFO - Return code: 0 01:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:04 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:46:05 INFO - Downloaded 14405384 bytes. 01:46:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:46:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:46:05 INFO - Return code: 0 01:46: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')]} 01:46:05 INFO - https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:46:07 INFO - Downloaded 55449102 bytes. 01:46:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:07 INFO - mkdir: /builds/slave/test/properties 01:46:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:07 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:07 INFO - Contents: 01:46:07 INFO - build_url:https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:08 INFO - Running post-action listener: _resource_record_post_action 01:46:08 INFO - Running post-action listener: set_extra_try_arguments 01:46:08 INFO - ##### 01:46:08 INFO - ##### Finished download-and-extract step (success) 01:46:08 INFO - ##### 01:46:08 INFO - ##### 01:46:08 INFO - ##### Running populate-webroot step. 01:46:08 INFO - ##### 01:46:08 INFO - Running pre-action listener: _resource_record_pre_action 01:46:08 INFO - Running main action method: populate_webroot 01:46:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:08 INFO - '--tppagecycles', 01:46:08 INFO - '7'], 01:46:08 INFO - 'tests': ['tsvgm']}}, 01:46:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['damp', 'tps']}, 01:46:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'tests': ['damp', 'tps']}, 01:46:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['dromaeo_dom']}, 01:46:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['basic_compositor_video']}, 01:46:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:46:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['a11yr', 01:46:08 INFO - 'ts_paint', 01:46:08 INFO - 'tpaint', 01:46:08 INFO - 'sessionrestore', 01:46:08 INFO - 'sessionrestore_no_auto_restore', 01:46:08 INFO - 'tabpaint']}, 01:46:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['tsvgx', 01:46:08 INFO - 'tsvgr_opacity', 01:46:08 INFO - 'tart', 01:46:08 INFO - 'tscrollx', 01:46:08 INFO - 'cart']}, 01:46:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:08 INFO - 'tsvgr_opacity', 01:46:08 INFO - 'tart', 01:46:08 INFO - 'tscrollx', 01:46:08 INFO - 'cart']}, 01:46:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'talos_options': ['--disable-e10s'], 01:46:08 INFO - 'tests': ['tp5o']}, 01:46:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'tests': ['tp5o']}, 01:46:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'talos_options': ['--disable-e10s', 01:46:08 INFO - '--xperf_path', 01:46:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:08 INFO - 'tests': ['tp5n']}, 01:46:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:08 INFO - 'talos_options': ['--xperf_path', 01:46:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:08 INFO - 'tests': ['tp5n']}}, 01:46:08 INFO - 'talos.zip': {'path': '', 01:46:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:08 INFO - Running post-action listener: _resource_record_post_action 01:46:08 INFO - ##### 01:46:08 INFO - ##### Finished populate-webroot step (success) 01:46:08 INFO - ##### 01:46:08 INFO - ##### 01:46:08 INFO - ##### Running create-virtualenv step. 01:46:08 INFO - ##### 01:46:08 INFO - Running pre-action listener: _resource_record_pre_action 01:46:08 INFO - Running main action method: create_virtualenv 01:46:08 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:46:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:08 INFO - Using real prefix '/usr' 01:46:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:08 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:10 INFO - Installing pip.................done. 01:46:10 INFO - Return code: 0 01:46:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46:10 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')]} 01:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:10 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')]} 01:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:10 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:10 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 01:46:10 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 01:46:10 INFO - Using env: {'DISPLAY': ':0', 01:46:10 INFO - 'HOME': '/home/cltbld', 01:46:10 INFO - 'LANG': 'en_US.UTF-8', 01:46:10 INFO - 'LANGUAGE': 'en_US:en', 01:46:10 INFO - 'LOGNAME': 'cltbld', 01:46:10 INFO - 'MAIL': '/var/mail/cltbld', 01:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:10 INFO - 'MOZ_NO_REMOTE': '1', 01:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:10 INFO - 'NO_EM_RESTART': '1', 01:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:10 INFO - 'PWD': '/builds/slave/test', 01:46:10 INFO - 'SHELL': '/bin/bash', 01:46:10 INFO - 'SHLVL': '1', 01:46:10 INFO - 'TERM': 'linux', 01:46:10 INFO - 'TMOUT': '86400', 01:46:10 INFO - 'USER': 'cltbld', 01:46:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:10 INFO - '_': '/tools/buildbot/bin/python'} 01:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:10 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 01:46:10 INFO - Cleaning up... 01:46:10 INFO - Return code: 0 01:46:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:10 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')]} 01:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:10 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')]} 01:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:10 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:10 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 01:46:10 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 01:46:10 INFO - Using env: {'DISPLAY': ':0', 01:46:10 INFO - 'HOME': '/home/cltbld', 01:46:10 INFO - 'LANG': 'en_US.UTF-8', 01:46:10 INFO - 'LANGUAGE': 'en_US:en', 01:46:10 INFO - 'LOGNAME': 'cltbld', 01:46:10 INFO - 'MAIL': '/var/mail/cltbld', 01:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:10 INFO - 'MOZ_NO_REMOTE': '1', 01:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:10 INFO - 'NO_EM_RESTART': '1', 01:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:10 INFO - 'PWD': '/builds/slave/test', 01:46:10 INFO - 'SHELL': '/bin/bash', 01:46:10 INFO - 'SHLVL': '1', 01:46:10 INFO - 'TERM': 'linux', 01:46:10 INFO - 'TMOUT': '86400', 01:46:10 INFO - 'USER': 'cltbld', 01:46:10 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:10 INFO - '_': '/tools/buildbot/bin/python'} 01:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:11 INFO - Downloading/unpacking psutil>=3.1.1 01:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:13 INFO - Installing collected packages: psutil 01:46:13 INFO - Running setup.py install for psutil 01:46:13 INFO - building 'psutil._psutil_linux' extension 01:46:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:46:13 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 01:46:13 INFO - building 'psutil._psutil_posix' extension 01:46:13 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 01:46:13 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 01:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:13 INFO - Successfully installed psutil 01:46:13 INFO - Cleaning up... 01:46:13 INFO - Return code: 0 01:46:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:13 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')]} 01:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:13 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')]} 01:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:13 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:13 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 01:46:13 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 01:46:13 INFO - Using env: {'DISPLAY': ':0', 01:46:13 INFO - 'HOME': '/home/cltbld', 01:46:13 INFO - 'LANG': 'en_US.UTF-8', 01:46:13 INFO - 'LANGUAGE': 'en_US:en', 01:46:13 INFO - 'LOGNAME': 'cltbld', 01:46:13 INFO - 'MAIL': '/var/mail/cltbld', 01:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:13 INFO - 'MOZ_NO_REMOTE': '1', 01:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:13 INFO - 'NO_EM_RESTART': '1', 01:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:13 INFO - 'PWD': '/builds/slave/test', 01:46:13 INFO - 'SHELL': '/bin/bash', 01:46:13 INFO - 'SHLVL': '1', 01:46:13 INFO - 'TERM': 'linux', 01:46:13 INFO - 'TMOUT': '86400', 01:46:13 INFO - 'USER': 'cltbld', 01:46:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:13 INFO - '_': '/tools/buildbot/bin/python'} 01:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:46:15 INFO - Installing collected packages: mozsystemmonitor 01:46:15 INFO - Running setup.py install for mozsystemmonitor 01:46:15 INFO - Successfully installed mozsystemmonitor 01:46:15 INFO - Cleaning up... 01:46:15 INFO - Return code: 0 01:46:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46: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==2.5.1'] in /builds/slave/test/build 01:46: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==2.5.1 01:46:15 INFO - Using env: {'DISPLAY': ':0', 01:46:15 INFO - 'HOME': '/home/cltbld', 01:46:15 INFO - 'LANG': 'en_US.UTF-8', 01:46:15 INFO - 'LANGUAGE': 'en_US:en', 01:46:15 INFO - 'LOGNAME': 'cltbld', 01:46:15 INFO - 'MAIL': '/var/mail/cltbld', 01:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:15 INFO - 'MOZ_NO_REMOTE': '1', 01:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:15 INFO - 'NO_EM_RESTART': '1', 01:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:15 INFO - 'PWD': '/builds/slave/test', 01:46:15 INFO - 'SHELL': '/bin/bash', 01:46:15 INFO - 'SHLVL': '1', 01:46:15 INFO - 'TERM': 'linux', 01:46:15 INFO - 'TMOUT': '86400', 01:46:15 INFO - 'USER': 'cltbld', 01:46:15 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:15 INFO - '_': '/tools/buildbot/bin/python'} 01:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:16 INFO - Downloading/unpacking jsonschema==2.5.1 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:18 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:18 INFO - warning: no files found matching '*.txt' 01:46:18 INFO - no previously-included directories found matching 'build' 01:46:18 INFO - no previously-included directories found matching 'dist' 01:46:18 INFO - no previously-included directories found matching '.git*' 01:46:18 INFO - Installing collected packages: jsonschema, functools32 01:46:18 INFO - Running setup.py install for functools32 01:46:18 INFO - warning: no files found matching '*.txt' 01:46:18 INFO - no previously-included directories found matching 'build' 01:46:18 INFO - no previously-included directories found matching 'dist' 01:46:18 INFO - no previously-included directories found matching '.git*' 01:46:18 INFO - Successfully installed jsonschema functools32 01:46:18 INFO - Cleaning up... 01:46:18 INFO - Return code: 0 01:46:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46:18 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')]} 01:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:18 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')]} 01:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:18 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:18 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 01:46:18 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 01:46:18 INFO - Using env: {'DISPLAY': ':0', 01:46:18 INFO - 'HOME': '/home/cltbld', 01:46:18 INFO - 'LANG': 'en_US.UTF-8', 01:46:18 INFO - 'LANGUAGE': 'en_US:en', 01:46:18 INFO - 'LOGNAME': 'cltbld', 01:46:18 INFO - 'MAIL': '/var/mail/cltbld', 01:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:18 INFO - 'MOZ_NO_REMOTE': '1', 01:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:18 INFO - 'NO_EM_RESTART': '1', 01:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:18 INFO - 'PWD': '/builds/slave/test', 01:46:18 INFO - 'SHELL': '/bin/bash', 01:46:18 INFO - 'SHLVL': '1', 01:46:18 INFO - 'TERM': 'linux', 01:46:18 INFO - 'TMOUT': '86400', 01:46:18 INFO - 'USER': 'cltbld', 01:46:18 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:18 INFO - '_': '/tools/buildbot/bin/python'} 01:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:18 INFO - Downloading/unpacking blobuploader==1.2.4 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:20 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:20 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 01:46:20 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 01:46:20 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 01:46:20 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 01:46:20 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 01:46:20 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 01:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:21 INFO - Downloading docopt-0.6.1.tar.gz 01:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:21 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:21 INFO - Running setup.py install for blobuploader 01:46:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:21 INFO - Running setup.py install for requests 01:46:21 INFO - Running setup.py install for docopt 01:46:21 INFO - Successfully installed blobuploader requests docopt 01:46:21 INFO - Cleaning up... 01:46:21 INFO - Return code: 0 01:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:21 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')]} 01:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:21 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')]} 01:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:21 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:21 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 01:46:21 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 01:46:21 INFO - Using env: {'DISPLAY': ':0', 01:46:21 INFO - 'HOME': '/home/cltbld', 01:46:21 INFO - 'LANG': 'en_US.UTF-8', 01:46:21 INFO - 'LANGUAGE': 'en_US:en', 01:46:21 INFO - 'LOGNAME': 'cltbld', 01:46:21 INFO - 'MAIL': '/var/mail/cltbld', 01:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:21 INFO - 'MOZ_NO_REMOTE': '1', 01:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:21 INFO - 'NO_EM_RESTART': '1', 01:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:21 INFO - 'PWD': '/builds/slave/test', 01:46:21 INFO - 'SHELL': '/bin/bash', 01:46:21 INFO - 'SHLVL': '1', 01:46:21 INFO - 'TERM': 'linux', 01:46:21 INFO - 'TMOUT': '86400', 01:46:21 INFO - 'USER': 'cltbld', 01:46:21 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:21 INFO - '_': '/tools/buildbot/bin/python'} 01:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:22 INFO - Running setup.py (path:/tmp/pip-x1QIA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:22 INFO - Running setup.py (path:/tmp/pip-DuOdJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:22 INFO - Running setup.py (path:/tmp/pip-jWuh0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:22 INFO - Running setup.py (path:/tmp/pip-5oz_n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:22 INFO - Running setup.py (path:/tmp/pip-8WXtwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:22 INFO - Running setup.py (path:/tmp/pip-GclHQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:22 INFO - Running setup.py (path:/tmp/pip-EHH8d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:22 INFO - Running setup.py (path:/tmp/pip-nO1eOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:22 INFO - Running setup.py (path:/tmp/pip-EJpIyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:22 INFO - Running setup.py (path:/tmp/pip-_aylY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:22 INFO - Running setup.py (path:/tmp/pip-zIwgLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:22 INFO - Running setup.py (path:/tmp/pip-DGr7tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:22 INFO - Running setup.py (path:/tmp/pip-JxAgzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:23 INFO - Running setup.py (path:/tmp/pip-ZwjiNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:23 INFO - Running setup.py (path:/tmp/pip-tfRSzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:23 INFO - Running setup.py (path:/tmp/pip-zgvqOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:23 INFO - Running setup.py (path:/tmp/pip-jbUmmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:46:23 INFO - Running setup.py install for manifestparser 01:46:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:46:23 INFO - Running setup.py install for mozcrash 01:46:23 INFO - Running setup.py install for mozdebug 01:46:23 INFO - Running setup.py install for mozdevice 01:46:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:46:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:46:23 INFO - Running setup.py install for mozfile 01:46:23 INFO - Running setup.py install for mozhttpd 01:46:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:46:23 INFO - Running setup.py install for mozinfo 01:46:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for mozInstall 01:46:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for mozleak 01:46:24 INFO - Running setup.py install for mozlog 01:46:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for moznetwork 01:46:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for mozprocess 01:46:24 INFO - Running setup.py install for mozprofile 01:46:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for mozrunner 01:46:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:46:24 INFO - Running setup.py install for mozscreenshot 01:46:24 INFO - Running setup.py install for moztest 01:46:25 INFO - Running setup.py install for mozversion 01:46:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:46:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:46:25 INFO - Cleaning up... 01:46:25 INFO - Return code: 0 01:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:46:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:46:25 INFO - Using env: {'DISPLAY': ':0', 01:46:25 INFO - 'HOME': '/home/cltbld', 01:46:25 INFO - 'LANG': 'en_US.UTF-8', 01:46:25 INFO - 'LANGUAGE': 'en_US:en', 01:46:25 INFO - 'LOGNAME': 'cltbld', 01:46:25 INFO - 'MAIL': '/var/mail/cltbld', 01:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:25 INFO - 'MOZ_NO_REMOTE': '1', 01:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:25 INFO - 'NO_EM_RESTART': '1', 01:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:25 INFO - 'PWD': '/builds/slave/test', 01:46:25 INFO - 'SHELL': '/bin/bash', 01:46:25 INFO - 'SHLVL': '1', 01:46:25 INFO - 'TERM': 'linux', 01:46:25 INFO - 'TMOUT': '86400', 01:46:25 INFO - 'USER': 'cltbld', 01:46:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:25 INFO - '_': '/tools/buildbot/bin/python'} 01:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:25 INFO - Running setup.py (path:/tmp/pip-p3qZm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:25 INFO - Running setup.py (path:/tmp/pip-WySbH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:46:25 INFO - Running setup.py (path:/tmp/pip-5bl4_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:46:25 INFO - Running setup.py (path:/tmp/pip-3DADd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:46:25 INFO - Running setup.py (path:/tmp/pip-Ilkyda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:46:25 INFO - Running setup.py (path:/tmp/pip-otc1GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:46:25 INFO - Running setup.py (path:/tmp/pip-nKrg3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:46:25 INFO - Running setup.py (path:/tmp/pip-jGClWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:46:25 INFO - Running setup.py (path:/tmp/pip-SDBDv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:46:25 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)) 01:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:46:26 INFO - Running setup.py (path:/tmp/pip-PPHieM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:46:26 INFO - Running setup.py (path:/tmp/pip-AyZbUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:46:26 INFO - Running setup.py (path:/tmp/pip-rc72LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:46:26 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)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:46:26 INFO - Running setup.py (path:/tmp/pip-xFX27t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:46:26 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)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:46:26 INFO - Running setup.py (path:/tmp/pip-Ht0YmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:46:26 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)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:26 INFO - Running setup.py (path:/tmp/pip-Xi5lFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:46:26 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)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:46:26 INFO - Running setup.py (path:/tmp/pip-N_1j1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:46:26 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)) 01:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:46:26 INFO - Running setup.py (path:/tmp/pip-_ra9zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:46:26 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)) 01:46:26 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)) 01:46:26 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)) 01:46:26 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)) 01:46:26 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)) 01:46:26 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)) 01:46:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:46:26 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 01:46:26 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 01:46:26 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 01:46:26 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 01:46:26 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 01:46:26 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 01:46:28 INFO - Downloading blessings-1.6.tar.gz 01:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:46:28 INFO - Installing collected packages: blessings 01:46:28 INFO - Running setup.py install for blessings 01:46:28 INFO - Successfully installed blessings 01:46:28 INFO - Cleaning up... 01:46:28 INFO - Return code: 0 01:46:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:46:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:28 INFO - Reading from file tmpfile_stdout 01:46:28 INFO - Current package versions: 01:46:28 INFO - argparse == 1.2.1 01:46:28 INFO - blessings == 1.6 01:46:28 INFO - blobuploader == 1.2.4 01:46:28 INFO - docopt == 0.6.1 01:46:28 INFO - functools32 == 3.2.3-2 01:46:28 INFO - jsonschema == 2.5.1 01:46:28 INFO - manifestparser == 1.1 01:46:28 INFO - mozInstall == 1.12 01:46:28 INFO - mozcrash == 0.17 01:46:28 INFO - mozdebug == 0.1 01:46:28 INFO - mozdevice == 0.48 01:46:28 INFO - mozfile == 1.2 01:46:28 INFO - mozhttpd == 0.7 01:46:28 INFO - mozinfo == 0.9 01:46:28 INFO - mozleak == 0.1 01:46:28 INFO - mozlog == 3.2 01:46:28 INFO - moznetwork == 0.27 01:46:28 INFO - mozprocess == 0.22 01:46:28 INFO - mozprofile == 0.28 01:46:28 INFO - mozrunner == 6.11 01:46:28 INFO - mozscreenshot == 0.1 01:46:28 INFO - mozsystemmonitor == 0.3 01:46:28 INFO - moztest == 0.7 01:46:28 INFO - mozversion == 1.4 01:46:28 INFO - psutil == 3.1.1 01:46:28 INFO - requests == 1.2.3 01:46:28 INFO - wsgiref == 0.1.2 01:46:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:28 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')]} 01:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:28 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')]} 01:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:28 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 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:28 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 01:46:28 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 01:46:28 INFO - Using env: {'DISPLAY': ':0', 01:46:28 INFO - 'HOME': '/home/cltbld', 01:46:28 INFO - 'LANG': 'en_US.UTF-8', 01:46:28 INFO - 'LANGUAGE': 'en_US:en', 01:46:28 INFO - 'LOGNAME': 'cltbld', 01:46:28 INFO - 'MAIL': '/var/mail/cltbld', 01:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:28 INFO - 'MOZ_NO_REMOTE': '1', 01:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:28 INFO - 'NO_EM_RESTART': '1', 01:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:28 INFO - 'PWD': '/builds/slave/test', 01:46:28 INFO - 'SHELL': '/bin/bash', 01:46:28 INFO - 'SHLVL': '1', 01:46:28 INFO - 'TERM': 'linux', 01:46:28 INFO - 'TMOUT': '86400', 01:46:28 INFO - 'USER': 'cltbld', 01:46:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:28 INFO - '_': '/tools/buildbot/bin/python'} 01:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:46:29 INFO - Cleaning up... 01:46:29 INFO - Return code: 0 01:46:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:46:29 INFO - Using env: {'DISPLAY': ':0', 01:46:29 INFO - 'HOME': '/home/cltbld', 01:46:29 INFO - 'LANG': 'en_US.UTF-8', 01:46:29 INFO - 'LANGUAGE': 'en_US:en', 01:46:29 INFO - 'LOGNAME': 'cltbld', 01:46:29 INFO - 'MAIL': '/var/mail/cltbld', 01:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:29 INFO - 'MOZ_NO_REMOTE': '1', 01:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:29 INFO - 'NO_EM_RESTART': '1', 01:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:29 INFO - 'PWD': '/builds/slave/test', 01:46:29 INFO - 'SHELL': '/bin/bash', 01:46:29 INFO - 'SHLVL': '1', 01:46:29 INFO - 'TERM': 'linux', 01:46:29 INFO - 'TMOUT': '86400', 01:46:29 INFO - 'USER': 'cltbld', 01:46:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:29 INFO - '_': '/tools/buildbot/bin/python'} 01:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:46:29 INFO - Cleaning up... 01:46:29 INFO - Return code: 0 01:46:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa86c561f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x216b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2238020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, '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': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', '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 01:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:46:29 INFO - Using env: {'DISPLAY': ':0', 01:46:29 INFO - 'HOME': '/home/cltbld', 01:46:29 INFO - 'LANG': 'en_US.UTF-8', 01:46:29 INFO - 'LANGUAGE': 'en_US:en', 01:46:29 INFO - 'LOGNAME': 'cltbld', 01:46:29 INFO - 'MAIL': '/var/mail/cltbld', 01:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:29 INFO - 'MOZ_NO_REMOTE': '1', 01:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:29 INFO - 'NO_EM_RESTART': '1', 01:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:29 INFO - 'PWD': '/builds/slave/test', 01:46:29 INFO - 'SHELL': '/bin/bash', 01:46:29 INFO - 'SHLVL': '1', 01:46:29 INFO - 'TERM': 'linux', 01:46:29 INFO - 'TMOUT': '86400', 01:46:29 INFO - 'USER': 'cltbld', 01:46:29 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:29 INFO - '_': '/tools/buildbot/bin/python'} 01:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:29 INFO - Downloading/unpacking flake8 01:46:29 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 01:46:29 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 01:46:29 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 01:46:29 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 01:46:29 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 01:46:29 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 01:46:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:46:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:46:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:46:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:32 INFO - no previously-included directories found matching 'docs/_build' 01:46:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:46:32 INFO - Running setup.py install for pep8 01:46:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:46:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:46:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:46:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:46:32 INFO - no previously-included directories found matching 'docs/_build' 01:46:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:46:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:46:32 INFO - Cleaning up... 01:46:32 INFO - Return code: 0 01:46:32 INFO - Running post-action listener: _resource_record_post_action 01:46:32 INFO - Running post-action listener: _start_resource_monitoring 01:46:32 INFO - Starting resource monitoring. 01:46:32 INFO - ##### 01:46:32 INFO - ##### Finished create-virtualenv step (success) 01:46:32 INFO - ##### 01:46:32 INFO - ##### 01:46:32 INFO - ##### Running install step. 01:46:32 INFO - ##### 01:46:32 INFO - Running pre-action listener: _resource_record_pre_action 01:46:32 INFO - Running main action method: install 01:46:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:46:32 INFO - Reading from file tmpfile_stdout 01:46:32 INFO - Detecting whether we're running mozinstall >=1.0... 01:46:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:46:32 INFO - Reading from file tmpfile_stdout 01:46:32 INFO - Output received: 01:46:32 INFO - Usage: mozinstall [options] installer 01:46:32 INFO - Options: 01:46:32 INFO - -h, --help show this help message and exit 01:46:32 INFO - -d DEST, --destination=DEST 01:46:32 INFO - Directory to install application into. [default: 01:46:32 INFO - "/builds/slave/test"] 01:46:32 INFO - --app=APP Application being installed. [default: firefox] 01:46:32 INFO - mkdir: /builds/slave/test/build/application 01:46:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:46:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:46:52 INFO - Reading from file tmpfile_stdout 01:46:52 INFO - Output received: 01:46:52 INFO - /builds/slave/test/build/application/firefox/firefox 01:46:52 INFO - Running post-action listener: _resource_record_post_action 01:46:52 INFO - ##### 01:46:52 INFO - ##### Finished install step (success) 01:46:52 INFO - ##### 01:46:52 INFO - ##### 01:46:52 INFO - ##### Running run-tests step. 01:46:52 INFO - ##### 01:46:52 INFO - Running pre-action listener: _resource_record_pre_action 01:46:52 INFO - Running main action method: run_tests 01:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:46:52 INFO - Python 2.7.3 01:46:52 INFO - Return code: 0 01:46:52 INFO - grabbing minidump binary from tooltool 01:46: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')]} 01:46:52 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 0x22ca2e0>, '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 0x2236140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22365d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:46:52 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 01:46:52 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 01:46:52 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 01:46:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:46:52 INFO - Return code: 0 01:46:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:46:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:46:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:46:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:46:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:46:59 INFO - Return code: 0 01:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 01:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 01:46:59 INFO - Using env: {'DISPLAY': ':0', 01:46:59 INFO - 'HOME': '/home/cltbld', 01:46:59 INFO - 'LANG': 'en_US.UTF-8', 01:46:59 INFO - 'LANGUAGE': 'en_US:en', 01:46:59 INFO - 'LOGNAME': 'cltbld', 01:46:59 INFO - 'MAIL': '/var/mail/cltbld', 01:46:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:46:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:59 INFO - 'MOZ_NO_REMOTE': '1', 01:46:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:59 INFO - 'NO_EM_RESTART': '1', 01:46:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:59 INFO - 'PWD': '/builds/slave/test', 01:46:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:46:59 INFO - 'SHELL': '/bin/bash', 01:46:59 INFO - 'SHLVL': '1', 01:46:59 INFO - 'TERM': 'linux', 01:46:59 INFO - 'TMOUT': '86400', 01:46:59 INFO - 'USER': 'cltbld', 01:46:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371', 01:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:59 INFO - '_': '/tools/buildbot/bin/python'} 01:46:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 01:46:59 INFO - mozversion application_buildid: 20160616000726 01:46:59 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 01:46:59 INFO - mozversion application_display_name: Nightly 01:46:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:46:59 INFO - mozversion application_name: Firefox 01:46:59 INFO - mozversion application_remotingname: firefox 01:46:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:46:59 INFO - mozversion application_vendor: Mozilla 01:46:59 INFO - mozversion application_version: 50.0a1 01:46:59 INFO - mozversion platform_buildid: 20160616000726 01:46:59 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 01:46:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:46:59 INFO - mozversion platform_version: 50.0a1 01:46:59 INFO - using testdate: 1466066819 01:46:59 INFO - actual date: 1466066819 01:46:59 INFO - starting webserver on 'localhost:54182' 01:46:59 INFO - SUITE-START | Running 2 tests 01:46:59 INFO - TEST-START | dromaeo_css 01:46:59 INFO - operating with platform_type : linux_ 01:46:59 INFO - Initialising browser for dromaeo_css test... 01:46:59 INFO - TEST-INFO | started process 21595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp75MnXJ/profile http://localhost:54182/getInfo.html) 01:47:07 INFO - PROCESS | 21595 | __metrics Screen width/height:1600/1200 01:47:07 INFO - PROCESS | 21595 | colorDepth:24 01:47:07 INFO - PROCESS | 21595 | Browser inner width/height: 1024/697 01:47:07 INFO - PROCESS | 21595 | __metrics 01:47:09 ERROR - PROCESS | 21595 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:47:10 INFO - TEST-INFO | 21595: exit 0 01:47:10 INFO - Browser initialized. 01:47:10 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:10 INFO - TEST-INFO | started process 21718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp75MnXJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:22 INFO - PROCESS | 21718 | RSS: Main: 186408960 01:47:22 INFO - PROCESS | 21718 | 01:48:12 INFO - PROCESS | 21718 | 1466066892012 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] 01:50:29 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54182/tests/dromaeo/cssquery-ext.html) 01:50:31 INFO - PROCESS | 21718 | RSS: Main: 186322944 01:50:31 INFO - PROCESS | 21718 | 01:53:33 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-ext.html (next: http://localhost:54182/tests/dromaeo/cssquery-jquery.html) 01:53:33 INFO - PROCESS | 21718 | RSS: Main: 188289024 01:53:33 INFO - PROCESS | 21718 | 01:56:35 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54182/tests/dromaeo/cssquery-mootools.html) 01:56:36 INFO - PROCESS | 21718 | RSS: Main: 189054976 01:56:36 INFO - PROCESS | 21718 | 01:59:38 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54182/tests/dromaeo/cssquery-prototype.html) 01:59:38 INFO - PROCESS | 21718 | RSS: Main: 186953728 01:59:38 INFO - PROCESS | 21718 | 02:02:41 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54182/tests/dromaeo/cssquery-yui.html) 02:02:42 INFO - PROCESS | 21718 | RSS: Main: 188944384 02:02:42 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | Cycle 1(1): loaded http://localhost:54182/tests/dromaeo/cssquery-yui.html (next: http://localhost:54182/tests/dromaeo/cssquery-dojo.html) 02:05:44 INFO - PROCESS | 21718 | RSS: Main: 189890560 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | __start_tp_report 02:05:44 INFO - PROCESS | 21718 | _x_x_mozilla_page_load 02:05:44 INFO - PROCESS | 21718 | _x_x_mozilla_page_load_details 02:05:44 INFO - PROCESS | 21718 | |i|pagename|runs| 02:05:44 INFO - PROCESS | 21718 | |0;dojo.html;2657.986710066449;2687.3684684099244;2694.7439993200614;2698.4603079384106;2716.0629582793954;4778.426588809339;4902.852914412573;4924.581410580096;4938.604911607072;4948.059868624968;4784.78468468918;5023.120953833083;5066.290719299301;5078.619103567229;5125.2055931330515;4583.885402864922;4689.9765501172615;4690.765461726917;4693.319468677039;4706.882327941795;4479.776011199459;4500.324951257305;4502.8198872045405;4524.411826462571;4618.930716039262;4487.551244875519;4493.393391892118;4493.775311234458;4543.40935678363;4553.726776393427;4564.7717614119165;4570.200214962369;4571.337156112379;4577.473590537097;4620.745858977755;4464.486584042812;4509;4547.749873756942;4549.886252843672;4551.5676010778925;4930.137225985474;4951.603871690256;4962.826301079481;4974.10466116099;5007.073691367073;5309.362876454811;5342.385625653022;5363.570914326844;5366.517013468807;5375.489328513785;5348.545373643245;5400.567954563626;5405.054115529767;5424.891502170013;5431.701256430855;4991.126552853236;5025.095482813055;5031.4465408805;5037.29477873098;5093.490650934877;5332.493413125747;5457.863553411196;5493.972530137324;5535.086710692691;5542.057850165482;5292.52367286946;5308.867278318073;5326.866828329323;5330.120530112488;5368.624196306299;5396.91904621431;5407.78368865241;5408.513233808976;5417.918731219035;5463.644863083887;5182.585393168612;5207.479252074838;5228.686278823283;5231.110711179109;5367.704776237344;5188;5254.264402983586;5266.420693723688;5288.656237344637;5298.81454149103;4509.413776209138;4511.436070491189;4511.70673906195;4517.164324599959;4553.089382123589;3912.158885839558;3913.1391093959282;3922.4508568800393;3945.349017412095;3969.285528604879;4598.333241679938;4643.976780116145;4645.256758918625;4649.256119020941;4691;5353.116735738559;5376.354837419534;5386.407495175527;5391.595630327741;5477.20580515823;4444.866654000385;4547.15877562652;4568.086382723469;4614.077184563033;4622.560856718606;4826.831060912851;4831.0096430231715;4840.975795121002;4885.5847252983185;4905.926411103907;5017.698938063728;5022.246663000579;5023.296738456546;5027.271045698426;5028.019536190408;5140.074786538309;5338.813141540028;5350.678959262456;5397.568194544506;5409.377921539073;5025.748712564284;5029.497050294941;5034.899302014012;5038.319826823332;5083;5311.468853114658;5317.867053323543;5320.946790532045;5343.5457986071615;5352.839414817562;5250.737463126905;5254.5533629641905;5275.155975043975;5275.577953763766;5282.709450980233;5155.43290238066;5160.071187186342;5178.663386879841;5186.533212010937;5221.660592061504;5064.518870707277;5122.103631864484;5156.484351564814;5162.148245539444;5176.145935920682;5081.110805609078;5136;5140.254663073908;5140.357455318085;5163.896722065462;5276.20856871457;5302.602304827076;5312.1766126250495;5319.228711836685;5357.812476563302;5002.674826136289;5043.596512278936;5098.872528186825;5126.128558145049;5179.300794392709 02:05:44 INFO - PROCESS | 21718 | |1;ext.html;529.590770768043;572.6564061563062;590.8138936235085;594.2898236607253;604.5309896950414;34209.82895085524;37678.24643507132;37686.17353698473;37746.62253377465;38337;38279.617203827955;38536.80731596345;38952;38960.22079558407;39088.80455597725;7702.499337543056;7790.259925307087;7810.1408845027;7832.746760518318;7896.012998375203;7725.420593455485;7728.420368472359;7746;7784.338331241823;7793.688252469923;7771.689132434724;7792.3376512996465;7829.373650108007;7865.606719664022;7891.960540197291;7750.534967901944;7770.922290777076;7821.843563128734;7855.096663883669;7858.371330293591;7727.111382191064;7802.219778022152;7813.804654883674;7820.061592608867;7829.608519573999;36384.818075909716;36412.81793591015;36609.45085823715;36614.45078323827;36825.63174368249;2956.586077949089;3057.6942305769467;3178.570892929471;3243.043302225849;3436.9484457733156;29486.852565737034;29661.110166695034;29693.554596681068;30065.398692026254;30110.69889301101;3447.7760395059895;3472.1666799967825;3502.1944952660774;3508.561429821272;3565.1978304881454;239887;240431;240547;241394;242869;50485.495145048815;50548.24177637338;50619;50626.49373506291;50763.746181268856;32102.839485802422;32993.835030825176;33085.338293234;35158.29683406318;35310.47034294488;12486.375681215903;12503.56237531682;12625.431855566521;12665.556705515262;12714.554990575285;9174.311926605531;9313.720588382359;9356.812863742687;9362.719118426457;9365.157135857806;17561;17629.55926101832;17704.55738606545;17758.11209439523;17810.19854106568;6668.699908504129;6831.9658401707675;6974.163100427981;7044.92955070453;7130.358267755927;793.6626933553332;923.736735030513;931.5932941258748;974.8294048541477;979.407458487619;27351.316217094733;27980.44039119247;28336.43327133487;28663.57004644932;28778.136655900358;883.8762573239752;931.5575101826713;952.7237101240563;975.1370037516849;1060.6234786650782;14207.431702731776;14400.639984000274;14577.344019519147;14633.341499632543;14769.483068092564;395091;398011;399269;400041;400109;48789.5121048785;49090.50909490931;49517.257241141415;49670.006599868524;49818.75090624524;1144.5307423956137;1173.2549830857467;1203.8916497515265;1205.2406983600276;1209.0750575809514;26108.216753496665;27285.727142729113;27442.5883611742;27514.724852751217;27749.445011099262;40590.79704601458;40626.593734062284;40961.795191023855;41005.38491922564;41063.794681026404;332045;334886;335034;335288;336030;24581.87709061443;24803.751962480866;24920.875395622905;25176.622350665122;25248.873755631103;40911.1817763649;41555.37666935059;42359.7882010588;42652.78673606612;42749.786251068545;34084.31831363309;36421.45367819432;36603.26793464062;36892.63107368892;37007.07482312964;35538.289234215685;36180.45729314115;36260.274794503435;36554;36737.26525469422;33742.32515349728;35846.10384740298;36341.27317453689;36652.45021324736;36855.07862303464;32154.90993085442;33414.49878251877;33557.496637549964;33592.66407335895;33646.495302569994;25174.24477265685;25421.87289063543;25649.102281420062;25675.614865776653;26048 02:05:44 INFO - PROCESS | 21718 | |2;jquery.html;363.9818009099546;365.56132640831004;367.845504887947;376.3864900212653;383.58189573365024;15711.607209819746;16306.184690765458;17348.21933013014;17365.652686946287;17391.21739521723;14819.77770333446;15328.233588320596;15596.766048509253;15697.764533532007;15724.842751572509;4995.825146119886;5252.290940723011;5272.499112584298;5280.1815718563685;5298.7350632468415;5155.252488389181;5184.792608295683;5248.186531087687;5257.842264732064;5270.525652691257;5129.871753206163;5180.197069454241;5201.115810312256;5209.869753256161;5215.58275337972;5000.549950504472;5085.644004919657;5101.770420331094;5165.431802501722;5184.248283998799;4493.303537951622;4629.675922685414;4651.372064771246;4651.906961860744;4660.184467718136;19838.40484785459;20453.488662783402;21136.260230891847;21141.788582114135;21240.362789116196;2098.0768461876723;2128;2360.0087963055385;2536.5941449368197;2569.370504226458;13240.933795330962;13524.661883452894;13805.723885522333;13810.93094534521;13851.584452466443;1744.9040302783342;1748.8513476354526;1749.3265092939182;1786.4372722592473;1835.2750663487848;65574.3442565573;65926.34073659297;66064;66877.3312266876;66906;9860.408375497493;9941.701748947544;10016.14862736661;10053.849192262122;10089;13556.93221533886;13583.117097388638;13631.931840340932;13640.249786261851;13678.931605342108;6577.901331480031;6616.801495955129;6771.424428923597;6805.421539169226;6916.100906882174;6103.6948152592195;6154.261488621304;6269.686515674198;6391.041343798374;6488.31872653374;5400.216968539618;6085.604435711664;6285.465735412449;6372.490200783926;6374.139491168726;1711.9828801711824;1775.5028591994262;1794.1298470241923;1796.2006906926292;1837.2742766607116;850.7873031742065;879.564615515324;884.9292056635454;918.169057003413;924.4222361024359;15198.772018419733;17072.2317495713;17487.38794142199;17681.292748289925;18092.457226283233;855.8373908957278;865.1089377940731;898.5148020069089;904.9411788233743;906.0305473143804;9813.656522021694;10166.898331016742;10230.897691022994;10242.846357304647;10333.121684656739;380170;386343;388953;394189;397706;63990.6800466004;64712;64773.67613161904;65356.673216633615;66210;886.2245535156737;909.8089401225817;920.3373571028849;933.1368484152132;938.7606160429184;15476;15752.606184845012;15755;15786.526404207892;16226.513204603882;33051.504227436126;34491.4826277601;34521.48217776786;34594.789182378496;35503.82248088743;43528.586984084766;45550.08899822051;46354.536454635025;47945.716574055135;49597;7826.960865195638;7883.526988380716;7889.408294377829;7889.684412623431;7979.202079792207;11827.704307392383;12034.75930481403;12056.939715301718;12131.272123672608;12160.148789584644;5041.2438134280155;6395.8720825582295;9953.452560109263;10595.258331916692;10775.299605525615;10735;10792.082672972885;10804.891951080388;10820.134389248999;10826.813913199816;10725.946370268099;10820.97200765926;10869.184811139037;10899.073578745896;11056.281341712764;7732.574708391093;7774.545130129266;7784.727534536264;7958.482698624803;7973.681052757825;10468.110210632181;10528;10556.472176391304;10640.946795265974;10782.67651970442 02:05:44 INFO - PROCESS | 21718 | |3;mootools.html;1360.4218207261915;1387.1399732166055;1414.6816966182603;1539.830618631951;1547.2982061104822;7000.96499517503;7445.516041457308;7682.347000504949;7958.92041079589;7988;7954.681812727484;7972.481788683732;8032.835238890358;8038.477498962563;8047.678092876293;2185.442712108414;2203.063697928374;2219.3120132758895;2223.2663221136986;2224.655178447343;1941.4369832748487;1977.6044791041777;2025.9262590826886;2033.7864524224965;2036.674132138858;2167.6206663833764;2170.934871953836;2178.194068194762;2185.584738899612;2228.1644383356243;2057.732494775677;2057.897105144737;2062.5668609592003;2062.742157230346;2066.018641145459;2068.2761033638258;2116.8200702940267;2129.031290762715;2136.198925402974;2136.8076873081495;7910.52536847791;8018.158093400168;8043.155468675764;8128.918710812875;8146.796330091795;4337.436133302682;4416.00639856033;4428.734275943421;4441.15618032576;4444.088961762831;2810.18504633656;2871.253474096729;2886.480433521965;2900.941981160365;2908.8109272897404;894.9373543851933;918.3709159225951;920.8987011428737;927.4110939553365;928.4800511713462;10973.615923442641;10998.12015038795;11027.944860275727;11032.172587055922;11078.224524283303;4120.876373708794;4139.586041395896;4247.660187185018;4247.787610619456;4297.011687311936;9264;9313.627454901729;9330.300227482965;9340.299477539213;9359.110884465965;4458.041521072985;4476.932846007313;4492.348609451611;4492.640588752892;4499.032707967803;3524.347995620767;3904.4338570907626;3911.7848518331766;3984.7609143451486;4025.8389664413094;3649.3248748981523;3673.0633688409284;3765.548134223911;3776.055986003499;3787.981060094682;1187.2757617853104;1201.741625550511;1206.927584344942;1208.2629595946466;1209.5161935225804;684.4319215051495;802.4543310548883;816.8202995341135;827.7971896885181;832.98334033319;5030.245463180552;5144.717040562805;5156.432792392834;5235.162374020215;5275.20871869215;390.11638638483856;855.8074433252593;855.9700410485727;868.5657171414293;923.0063063782198;3172.3020935394175;3325.617553981275;3351.4135026370286;3355.9328813423595;3380.4591265397416;9656.613735450645;9666.323357364918;9796.559154838049;9837.704868853945;9911.801763964824;9517.952410237904;9699.806003880023;9713.70858874235;9724.659636912816;9809.068138526829;7098.716051357991;7285.4171666266575;7408.296211859864;7417.332440080419;7488.138864030706;5230.503102205284;5450.700211488248;5486.533644640251;5491.0939694951485;5516.365617953987;9093.4998575079;9195.724128276162;9215.677451289173;9290.256779457492;9306.302027347841;9034.683786067457;9350.205232555038;9361.251099912128;9412.67055653049;9461.148496635336;6629.46964242869;6629.966850165718;6862.828429289308;6926.515143939876;6932.549384290005;7478.738244161428;7579.924200757921;7588.241175882367;7611.086669599684;7616.504927179715;6680.665966701743;6892.758753443605;6893.103896493424;6941.271166527442;6948.166220053626;6634.800955971328;6729.528932974645;6831.453483721191;6846.7945961621235;6942.618156001468;6175.752969881154;6250.249970003629;6255.812325630239;6260.373962603703;6279.560430769802;4470.821167153277;4561.429821272341;4576.222042252758;4584.243599805995;4587.72473651582;4415.27148020573;4517.6837621366185;4525.818967241274;4582.9541704582525;4620.653450991122 02:05:44 INFO - PROCESS | 21718 | |4;prototype.html;276.1687321163298;287.0627401533992;288.04369493282303;289.8246560830696;293.83985727778366;4934.506549345064;5023.874403139924;5071.771770270338;5097.082525145473;5172.689638621685;5044.772985215665;5061.16490779021;5061.772220250088;5079.898402031957;5080.542751152396;3967.662748666367;3967.7817720025387;3968.2063587282514;3975.3241948868763;3986.123052928351;3915.414257225814;3945.3884647879627;3978.124812541251;3980.2039592081555;4013.1973605279063;3903.882883513499;3912.2762288976487;3923.9607603924023;3931.5282166140105;3944.566097729262;3964.623360780721;3980.4228386883883;3987.5813039631003;4001.099752555681;4004.379321205218;3497.877574284888;3530.382183117944;3531.823408829574;3532.4877892705413;3549.893503194908;4922.729249891255;4973.577245934064;4973.925391119136;4982.87542811429;5048.242763585455;4444.35556844259;4526;4572.634189264851;4585.28928016158;4600.953990460086;5374.3013408256675;5384.946150538483;5396.487333703292;5414;5421.728913554307;3747.419150031722;3799.2401519696173;3824.598417166213;3830.578636349999;3841.769493830379;5656.8969051035065;5657.4908258256955;5671.432856714337;5673.177389278531;5673.574481913873;3907.27715372657;3947.526296844397;3952.387379956054;3953.466282051944;3968.7817170055346;3805.3911374179997;3962.9405558916637;4025.5571887092397;4028.1540876415693;4030.395440683862;4490.191765482245;4499.572540608637;4502.57225563571;4505.639548836085;4575.359449677047;5341.946580534222;5349.786008559614;5383.246345511631;5388.407275199725;5424.728763561806;1271.6121582917115;1349.7030653256268;1368.7809950407886;1377.6831328794233;1378.2970684950747;863.2101627011215;877.5612193903048;882.4969767232616;882.7219425880827;888.8488956877346;4154.231467178582;4180.498340199135;4202.348635961431;4229.175310814423;4262.680298977527;4842.370491836039;4857.295692124622;4908.263760435963;4915.377925284647;4947.6536642434685;4254.808533615995;4255.638270747021;4258.148370325947;4274.572542745763;4296.677749168824;2462.9507409851703;2639.775619072362;2641.775449086849;2644.206737978637;2661.7471340222646;4560.996580752296;4575.839845605387;4584.601696482605;4632.587060946444;4645.953540464619;4988.6757360771435;4993.375828021497;5005.4483110235215;5011.674241174312;5016.398032236155;4281.807318670667;4579.702319349165;4599.839005634787;4604.250384853868;4629.629629629621;4861.7326047066335;4896.2410826321975;4931.605471562339;4937.382827146606;4989.301497790239;4816.182533218107;4830.516948305141;4857.222844344888;4901.460839307744;4924.340855937753;4303.741775493355;4585.266357382803;4594.540545945379;4599.747013914267;4616.515265897033;3549.6095429502216;3560.8575656974467;3564.821758912096;3573.4997100405444;3587.9103022424647;4860.30253209458;4872.3909511311085;4920.957802511917;4939.53074457926;5290.280658785987;5259.47405259471;5338.172583249602;5353.330833645794;5401.432849550741;5404.216388623706;5347.679139251657;5356.78572857097;5447.591430642797;5475.288212532345;5495.148252020943;5111.87220319495;5227.660202086852;5229.895402092013;5276;5284.656497327662;5389;5389.194619802253;5397.514223719884;5429.294191755204;5441.755121019484;5281.853744810305;5333.879885223992;5337.653052551572;5359.27649767292;5364.329458817648 02:05:44 INFO - PROCESS | 21718 | |5;yui.html;608.8386577556945;615.375393975115;650.4796163069544;710.9857802843943;756.8637645223861;12283.938580307096;12828;12847.100702950796;13372.331383430837;13382.531611393602;13106.541271055516;14056;14611.269436528184;14639.121652700846;15289.159096249701;623.8689875126229;773.3697036914924;789.940754443419;790.7825348029295;796.3390385979623;790.5612385126252;799.4324029938722;801.3308887079296;801.3669201330971;803.5540275147291;840.3949156607264;841.0286119531951;841.272299460965;845.2350622686448;845.471580262336;822.6298165825402;827.437342607027;833.5915401453275;833.8582440985047;834.5952213176605;611.703323887914;611.9235095613049;611.9785807496717;612.2744547710932;613.772904025509;12766.297853618047;12797.808032879515;12842.807357889638;12872.163309384954;12906.677333066655;13721.588352349445;13743.656408589764;13976.371063302176;14221.146731196059;14293.714125717532;10536.104431123364;10672.359658420519;10849.891501084967;10900.291481053706;11153.944230278797;3280.491523813813;3393.117789374756;3446.327966046622;3452.482127680843;3552.786832790041;45733;46604.5339546607;55494.44505554933;59437;59491.70254148745;10439.843402348972;10715.517801698943;10756.78486430267;10794.892051079545;10836.566537338576;19747.703784443245;19867.205311787366;19974.60050798976;20007;20079.39761807148;6534.085228068075;6725.327467253333;6886;6935.375816176467;7056.15326160864;3530.6822385985383;3667.284879448482;3682.355587772183;3732.794696291676;3734.3464893643504;2768.8338699678084;2865.6561212654615;2866.412385461017;2874.956875646867;2878.337982264091;535.6893002058797;564.5850300029475;574.6552068758712;578.1039388947115;580.7734983356494;459.9421330938894;462.780179414782;462.9166749984968;463.43229543808565;469.577380357674;7572.280633339824;7593.430492713069;7725.613719314012;7764.22357764219;7832.725854595175;392.1236037456283;413.3881854854832;423.1853681662787;466.7013111608573;477.8255936583122;3432.5537680101925;3566.3937130687327;3630.5280313559597;3650.3429382711365;3764.416515440111;91120;91386.54306728423;94384.52807736055;95161;95484.52257738667;48239.75880120577;48696.75651621719;49110.75444622754;79360;80783.59608201921;73971.63014184787;75229.62385188039;76033.6198319016;76937;78594.21405785983;7030.50786444944;7080.185778635317;7120.2167761547225;7129.39400150993;7219;36074.45888311625;36951.26097477982;38211.42682859815;41653;43710.56289437065;40340.193196135326;48518;57443;57981.42018579929;58798.70600646969;10755.171620824322;10771.51528181218;10779.299345542515;10955.34267943926;11045.779084418105;11655.18413711066;11903.940480297542;11997.644781094392;12284.447199876206;12533.51872082637;10889.183311251529;10895.782084358427;11082.944585277022;11182;11659.358735269641;9998.600055997678;10063.647772327933;10085;10274.075333220046;10401.94799026;10868.67393978182;10968.780624387307;11131.55473781072;11324.263922844988;11481.311121332747;8671.306295496472;8697.739067827975;8806;8963.686270980485;9053.864192037256;9301.302402319989;9502.144806967406;9507.572159252712;9510.191633711212;9587.280953928623 02:05:44 INFO - PROCESS | 21718 | __end_tp_report 02:05:44 INFO - PROCESS | 21718 | __start_cc_report 02:05:44 INFO - PROCESS | 21718 | _x_x_mozilla_cycle_collect,368 02:05:44 INFO - PROCESS | 21718 | __end_cc_report 02:05:44 INFO - PROCESS | 21718 | __startTimestamp1466067944870__endTimestamp 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | ------- Summary: start ------- 02:05:44 INFO - PROCESS | 21718 | Number of tests: 6 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#0] dojo.html Cycles:165 Average:4928.88 Median:5064.52 stddev:537.13 (10.6%) stddev-sans-first:508.38 02:05:44 INFO - PROCESS | 21718 | Values: 2658.0 2687.4 2694.7 2698.5 2716.1 4778.4 4902.9 4924.6 4938.6 4948.1 4784.8 5023.1 5066.3 5078.6 5125.2 4583.9 4690.0 4690.8 4693.3 4706.9 4479.8 4500.3 4502.8 4524.4 4618.9 4487.6 4493.4 4493.8 4543.4 4553.7 4564.8 4570.2 4571.3 4577.5 4620.7 4464.5 4509.0 4547.7 4549.9 4551.6 4930.1 4951.6 4962.8 4974.1 5007.1 5309.4 5342.4 5363.6 5366.5 5375.5 5348.5 5400.6 5405.1 5424.9 5431.7 4991.1 5025.1 5031.4 5037.3 5093.5 5332.5 5457.9 5494.0 5535.1 5542.1 5292.5 5308.9 5326.9 5330.1 5368.6 5396.9 5407.8 5408.5 5417.9 5463.6 5182.6 5207.5 5228.7 5231.1 5367.7 5188.0 5254.3 5266.4 5288.7 5298.8 4509.4 4511.4 4511.7 4517.2 4553.1 3912.2 3913.1 3922.5 3945.3 3969.3 4598.3 4644.0 4645.3 4649.3 4691.0 5353.1 5376.4 5386.4 5391.6 5477.2 4444.9 4547.2 4568.1 4614.1 4622.6 4826.8 4831.0 4841.0 4885.6 4905.9 5017.7 5022.2 5023.3 5027.3 5028.0 5140.1 5338.8 5350.7 5397.6 5409.4 5025.7 5029.5 5034.9 5038.3 5083.0 5311.5 5317.9 5320.9 5343.5 5352.8 5250.7 5254.6 5275.2 5275.6 5282.7 5155.4 5160.1 5178.7 5186.5 5221.7 5064.5 5122.1 5156.5 5162.1 5176.1 5081.1 5136.0 5140.3 5140.4 5163.9 5276.2 5302.6 5312.2 5319.2 5357.8 5002.7 5043.6 5098.9 5126.1 5179.3 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#1] ext.html Cycles:180 Average:46973.37 Median:36633.45 stddev:87347.25 (238.4%) stddev-sans-first:87522.68 02:05:44 INFO - PROCESS | 21718 | Values: 529.6 572.7 590.8 594.3 604.5 34209.8 37678.2 37686.2 37746.6 38337.0 38279.6 38536.8 38952.0 38960.2 39088.8 7702.5 7790.3 7810.1 7832.7 7896.0 7725.4 7728.4 7746.0 7784.3 7793.7 7771.7 7792.3 7829.4 7865.6 7892.0 7750.5 7770.9 7821.8 7855.1 7858.4 7727.1 7802.2 7813.8 7820.1 7829.6 36384.8 36412.8 36609.5 36614.5 36825.6 2956.6 3057.7 3178.6 3243.0 3436.9 29486.9 29661.1 29693.6 30065.4 30110.7 3447.8 3472.2 3502.2 3508.6 3565.2 239887.0 240431.0 240547.0 241394.0 242869.0 50485.5 50548.2 50619.0 50626.5 50763.7 32102.8 32993.8 33085.3 35158.3 35310.5 12486.4 12503.6 12625.4 12665.6 12714.6 9174.3 9313.7 9356.8 9362.7 9365.2 17561.0 17629.6 17704.6 17758.1 17810.2 6668.7 6832.0 6974.2 7044.9 7130.4 793.7 923.7 931.6 974.8 979.4 27351.3 27980.4 28336.4 28663.6 28778.1 883.9 931.6 952.7 975.1 1060.6 14207.4 14400.6 14577.3 14633.3 14769.5 395091.0 398011.0 399269.0 400041.0 400109.0 48789.5 49090.5 49517.3 49670.0 49818.8 1144.5 1173.3 1203.9 1205.2 1209.1 26108.2 27285.7 27442.6 27514.7 27749.4 40590.8 40626.6 40961.8 41005.4 41063.8 332045.0 334886.0 335034.0 335288.0 336030.0 24581.9 24803.8 24920.9 25176.6 25248.9 40911.2 41555.4 42359.8 42652.8 42749.8 34084.3 36421.5 36603.3 36892.6 37007.1 35538.3 36180.5 36260.3 36554.0 36737.3 33742.3 35846.1 36341.3 36652.5 36855.1 32154.9 33414.5 33557.5 33592.7 33646.5 25174.2 25421.9 25649.1 25675.6 26048.0 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#2] jquery.html Cycles:180 Average:23809.89 Median:387648.00 stddev:63932.78 (16.5%) stddev-sans-first:64087.90 02:05:44 INFO - PROCESS | 21718 | Values: 364.0 365.6 367.8 376.4 383.6 15711.6 16306.2 17348.2 17365.7 17391.2 14819.8 15328.2 15596.8 15697.8 15724.8 4995.8 5252.3 5272.5 5280.2 5298.7 5155.3 5184.8 5248.2 5257.8 5270.5 5129.9 5180.2 5201.1 5209.9 5215.6 5000.5 5085.6 5101.8 5165.4 5184.2 4493.3 4629.7 4651.4 4651.9 4660.2 19838.4 20453.5 21136.3 21141.8 21240.4 2098.1 2128.0 2360.0 2536.6 2569.4 13240.9 13524.7 13805.7 13810.9 13851.6 1744.9 1748.9 1749.3 1786.4 1835.3 65574.3 65926.3 66064.0 66877.3 66906.0 9860.4 9941.7 10016.1 10053.8 10089.0 13556.9 13583.1 13631.9 13640.2 13678.9 6577.9 6616.8 6771.4 6805.4 6916.1 6103.7 6154.3 6269.7 6391.0 6488.3 5400.2 6085.6 6285.5 6372.5 6374.1 1712.0 1775.5 1794.1 1796.2 1837.3 850.8 879.6 884.9 918.2 924.4 15198.8 17072.2 17487.4 17681.3 18092.5 855.8 865.1 898.5 904.9 906.0 9813.7 10166.9 10230.9 10242.8 10333.1 380170.0 386343.0 388953.0 394189.0 397706.0 63990.7 64712.0 64773.7 65356.7 66210.0 886.2 909.8 920.3 933.1 938.8 15476.0 15752.6 15755.0 15786.5 16226.5 33051.5 34491.5 34521.5 34594.8 35503.8 43528.6 45550.1 46354.5 47945.7 49597.0 7827.0 7883.5 7889.4 7889.7 7979.2 11827.7 12034.8 12056.9 12131.3 12160.1 5041.2 6395.9 9953.5 10595.3 10775.3 10735.0 10792.1 10804.9 10820.1 10826.8 10725.9 10821.0 10869.2 10899.1 11056.3 7732.6 7774.5 7784.7 7958.5 7973.7 10468.1 10528.0 10556.5 10640.9 10782.7 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#3] mootools.html Cycles:180 Average:5165.73 Median:5255.19 stddev:2977.48 (56.7%) stddev-sans-first:2972.10 02:05:44 INFO - PROCESS | 21718 | Values: 1360.4 1387.1 1414.7 1539.8 1547.3 7001.0 7445.5 7682.3 7958.9 7988.0 7954.7 7972.5 8032.8 8038.5 8047.7 2185.4 2203.1 2219.3 2223.3 2224.7 1941.4 1977.6 2025.9 2033.8 2036.7 2167.6 2170.9 2178.2 2185.6 2228.2 2057.7 2057.9 2062.6 2062.7 2066.0 2068.3 2116.8 2129.0 2136.2 2136.8 7910.5 8018.2 8043.2 8128.9 8146.8 4337.4 4416.0 4428.7 4441.2 4444.1 2810.2 2871.3 2886.5 2900.9 2908.8 894.9 918.4 920.9 927.4 928.5 10973.6 10998.1 11027.9 11032.2 11078.2 4120.9 4139.6 4247.7 4247.8 4297.0 9264.0 9313.6 9330.3 9340.3 9359.1 4458.0 4476.9 4492.3 4492.6 4499.0 3524.3 3904.4 3911.8 3984.8 4025.8 3649.3 3673.1 3765.5 3776.1 3788.0 1187.3 1201.7 1206.9 1208.3 1209.5 684.4 802.5 816.8 827.8 833.0 5030.2 5144.7 5156.4 5235.2 5275.2 390.1 855.8 856.0 868.6 923.0 3172.3 3325.6 3351.4 3355.9 3380.5 9656.6 9666.3 9796.6 9837.7 9911.8 9518.0 9699.8 9713.7 9724.7 9809.1 7098.7 7285.4 7408.3 7417.3 7488.1 5230.5 5450.7 5486.5 5491.1 5516.4 9093.5 9195.7 9215.7 9290.3 9306.3 9034.7 9350.2 9361.3 9412.7 9461.1 6629.5 6630.0 6862.8 6926.5 6932.5 7478.7 7579.9 7588.2 7611.1 7616.5 6680.7 6892.8 6893.1 6941.3 6948.2 6634.8 6729.5 6831.5 6846.8 6942.6 6175.8 6250.2 6255.8 6260.4 6279.6 4470.8 4561.4 4576.2 4584.2 4587.7 4415.3 4517.7 4525.8 4583.0 4620.7 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#4] prototype.html Cycles:180 Average:4276.89 Median:4610.38 stddev:1242.30 (26.9%) stddev-sans-first:1208.95 02:05:44 INFO - PROCESS | 21718 | Values: 276.2 287.1 288.0 289.8 293.8 4934.5 5023.9 5071.8 5097.1 5172.7 5044.8 5061.2 5061.8 5079.9 5080.5 3967.7 3967.8 3968.2 3975.3 3986.1 3915.4 3945.4 3978.1 3980.2 4013.2 3903.9 3912.3 3924.0 3931.5 3944.6 3964.6 3980.4 3987.6 4001.1 4004.4 3497.9 3530.4 3531.8 3532.5 3549.9 4922.7 4973.6 4973.9 4982.9 5048.2 4444.4 4526.0 4572.6 4585.3 4601.0 5374.3 5384.9 5396.5 5414.0 5421.7 3747.4 3799.2 3824.6 3830.6 3841.8 5656.9 5657.5 5671.4 5673.2 5673.6 3907.3 3947.5 3952.4 3953.5 3968.8 3805.4 3962.9 4025.6 4028.2 4030.4 4490.2 4499.6 4502.6 4505.6 4575.4 5341.9 5349.8 5383.2 5388.4 5424.7 1271.6 1349.7 1368.8 1377.7 1378.3 863.2 877.6 882.5 882.7 888.8 4154.2 4180.5 4202.3 4229.2 4262.7 4842.4 4857.3 4908.3 4915.4 4947.7 4254.8 4255.6 4258.1 4274.6 4296.7 2463.0 2639.8 2641.8 2644.2 2661.7 4561.0 4575.8 4584.6 4632.6 4646.0 4988.7 4993.4 5005.4 5011.7 5016.4 4281.8 4579.7 4599.8 4604.3 4629.6 4861.7 4896.2 4931.6 4937.4 4989.3 4816.2 4830.5 4857.2 4901.5 4924.3 4303.7 4585.3 4594.5 4599.7 4616.5 3549.6 3560.9 3564.8 3573.5 3587.9 4860.3 4872.4 4921.0 4939.5 5290.3 5259.5 5338.2 5353.3 5401.4 5404.2 5347.7 5356.8 5447.6 5475.3 5495.1 5111.9 5227.7 5229.9 5276.0 5284.7 5389.0 5389.2 5397.5 5429.3 5441.8 5281.9 5333.9 5337.7 5359.3 5364.3 02:05:44 INFO - PROCESS | 21718 | 02:05:44 INFO - PROCESS | 21718 | [#5] yui.html Cycles:180 Average:16295.88 Median:462.85 stddev:22786.44 (4923.1%) stddev-sans-first:22819.91 02:05:44 INFO - PROCESS | 21718 | Values: 608.8 615.4 650.5 711.0 756.9 12283.9 12828.0 12847.1 13372.3 13382.5 13106.5 14056.0 14611.3 14639.1 15289.2 623.9 773.4 789.9 790.8 796.3 790.6 799.4 801.3 801.4 803.6 840.4 841.0 841.3 845.2 845.5 822.6 827.4 833.6 833.9 834.6 611.7 611.9 612.0 612.3 613.8 12766.3 12797.8 12842.8 12872.2 12906.7 13721.6 13743.7 13976.4 14221.1 14293.7 10536.1 10672.4 10849.9 10900.3 11153.9 3280.5 3393.1 3446.3 3452.5 3552.8 45733.0 46604.5 55494.4 59437.0 59491.7 10439.8 10715.5 10756.8 10794.9 10836.6 19747.7 19867.2 19974.6 20007.0 20079.4 6534.1 6725.3 6886.0 6935.4 7056.2 3530.7 3667.3 3682.4 3732.8 3734.3 2768.8 2865.7 2866.4 2875.0 2878.3 535.7 564.6 574.7 578.1 580.8 459.9 462.8 462.9 463.4 469.6 7572.3 7593.4 7725.6 7764.2 7832.7 392.1 413.4 423.2 466.7 477.8 3432.6 3566.4 3630.5 3650.3 3764.4 91120.0 91386.5 94384.5 95161.0 95484.5 48239.8 48696.8 49110.8 79360.0 80783.6 73971.6 75229.6 76033.6 76937.0 78594.2 7030.5 7080.2 7120.2 7129.4 7219.0 36074.5 36951.3 38211.4 41653.0 43710.6 40340.2 48518.0 57443.0 57981.4 58798.7 10755.2 10771.5 10779.3 10955.3 11045.8 11655.2 11903.9 11997.6 12284.4 12533.5 10889.2 10895.8 11082.9 11182.0 11659.4 9998.6 10063.6 10085.0 10274.1 10401.9 10868.7 10968.8 11131.6 11324.3 11481.3 8671.3 8697.7 8806.0 8963.7 9053.9 9301.3 9502.1 9507.6 9510.2 9587.3 02:05:44 INFO - PROCESS | 21718 | -------- Summary: end -------- 02:05:44 INFO - PROCESS | 21718 | 02:05:45 INFO - TEST-INFO | 21718: exit 0 02:05:45 INFO - TEST-OK | dromaeo_css | took 1126080ms 02:05:45 INFO - TEST-START | kraken 02:05:45 INFO - operating with platform_type : linux_ 02:05:45 INFO - Initialising browser for kraken test... 02:05:45 INFO - TEST-INFO | started process 21954 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsxD1r/profile http://localhost:54182/getInfo.html) 02:05:53 INFO - PROCESS | 21954 | __metrics Screen width/height:1600/1200 02:05:53 INFO - PROCESS | 21954 | colorDepth:24 02:05:53 INFO - PROCESS | 21954 | Browser inner width/height: 1024/697 02:05:53 INFO - PROCESS | 21954 | __metrics 02:05:54 ERROR - PROCESS | 21954 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:05:55 INFO - TEST-INFO | 21954: exit 0 02:05:55 INFO - Browser initialized. 02:05:55 INFO - Running cycle 1/1 for kraken test... 02:05:55 INFO - TEST-INFO | started process 22072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEsxD1r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:07 INFO - PROCESS | 22072 | RSS: Main: 186884096 02:06:07 INFO - PROCESS | 22072 | 02:06:10 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:11 INFO - PROCESS | 22072 | RSS: Main: 191381504 02:06:11 INFO - PROCESS | 22072 | 02:06:14 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-dft) 02:06:15 INFO - PROCESS | 22072 | RSS: Main: 191229952 02:06:15 INFO - PROCESS | 22072 | 02:06:17 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-fft) 02:06:18 INFO - PROCESS | 22072 | RSS: Main: 187174912 02:06:18 INFO - PROCESS | 22072 | 02:06:20 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54182/tests/kraken/driver.html?testName=audio-oscillator) 02:06:21 INFO - PROCESS | 22072 | RSS: Main: 187478016 02:06:21 INFO - PROCESS | 22072 | 02:06:23 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:24 INFO - PROCESS | 22072 | RSS: Main: 187719680 02:06:24 INFO - PROCESS | 22072 | 02:06:27 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:28 INFO - PROCESS | 22072 | RSS: Main: 187953152 02:06:28 INFO - PROCESS | 22072 | 02:06:31 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54182/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:32 INFO - PROCESS | 22072 | RSS: Main: 185253888 02:06:32 INFO - PROCESS | 22072 | 02:06:35 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54182/tests/kraken/driver.html?testName=json-parse-financial) 02:06:35 INFO - PROCESS | 22072 | RSS: Main: 186343424 02:06:35 INFO - PROCESS | 22072 | 02:06:37 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54182/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:38 INFO - PROCESS | 22072 | RSS: Main: 186781696 02:06:38 INFO - PROCESS | 22072 | 02:06:40 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:40 INFO - PROCESS | 22072 | RSS: Main: 186929152 02:06:40 INFO - PROCESS | 22072 | 02:06:43 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:06:43 INFO - PROCESS | 22072 | RSS: Main: 187490304 02:06:43 INFO - PROCESS | 22072 | 02:06:46 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:06:47 INFO - PROCESS | 22072 | RSS: Main: 188436480 02:06:47 INFO - PROCESS | 22072 | 02:06:50 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:06:50 INFO - PROCESS | 22072 | RSS: Main: 187719680 02:06:50 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | Cycle 1(1): loaded http://localhost:54182/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54182/tests/kraken/driver.html?testName=ai-astar) 02:06:52 INFO - PROCESS | 22072 | RSS: Main: 189194240 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | __start_tp_report 02:06:52 INFO - PROCESS | 22072 | _x_x_mozilla_page_load 02:06:52 INFO - PROCESS | 22072 | _x_x_mozilla_page_load_details 02:06:52 INFO - PROCESS | 22072 | |i|pagename|runs| 02:06:52 INFO - PROCESS | 22072 | |0;ai-astar;115;111;116;113;113;113;112;115;118;119 02:06:52 INFO - PROCESS | 22072 | |1;audio-beat-detection;174;134;162;189;135;159;160;137;198;133 02:06:52 INFO - PROCESS | 22072 | |2;audio-dft;164;176;164;165;165;165;163;163;161;161 02:06:52 INFO - PROCESS | 22072 | |3;audio-fft;77;77;76;162;76;77;75;77;159;76 02:06:52 INFO - PROCESS | 22072 | |4;audio-oscillator;87;87;140;87;87;86;148;89;86;144 02:06:52 INFO - PROCESS | 22072 | |5;imaging-gaussian-blur;117;118;118;118;118;119;117;118;118;117 02:06:52 INFO - PROCESS | 22072 | |6;imaging-darkroom;147;151;147;148;149;148;150;151;151;147 02:06:52 INFO - PROCESS | 22072 | |7;imaging-desaturate;96;96;99;96;95;95;95;95;96;96 02:06:52 INFO - PROCESS | 22072 | |8;json-parse-financial;64;64;66;64;65;64;70;64;64;64 02:06:52 INFO - PROCESS | 22072 | |9;json-stringify-tinderbox;66;66;66;66;66;65;65;66;67;65 02:06:52 INFO - PROCESS | 22072 | |10;stanford-crypto-aes;92;83;91;85;85;91;86;86;111;92 02:06:52 INFO - PROCESS | 22072 | |11;stanford-crypto-ccm;148;155;142;131;136;133;131;136;149;137 02:06:52 INFO - PROCESS | 22072 | |12;stanford-crypto-pbkdf2;175;171;180;170;172;171;173;174;176;171 02:06:52 INFO - PROCESS | 22072 | |13;stanford-crypto-sha256-iterative;72;83;68;69;67;67;67;69;67;67 02:06:52 INFO - PROCESS | 22072 | __end_tp_report 02:06:52 INFO - PROCESS | 22072 | __start_cc_report 02:06:52 INFO - PROCESS | 22072 | _x_x_mozilla_cycle_collect,970 02:06:52 INFO - PROCESS | 22072 | __end_cc_report 02:06:52 INFO - PROCESS | 22072 | __startTimestamp1466068012837__endTimestamp 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | ------- Summary: start ------- 02:06:52 INFO - PROCESS | 22072 | Number of tests: 14 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.59 (2.3%) stddev-sans-first:2.74 02:06:52 INFO - PROCESS | 22072 | Values: 115.0 111.0 116.0 113.0 113.0 113.0 112.0 115.0 118.0 119.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#1] audio-beat-detection Cycles:10 Average:158.10 Median:161.00 stddev:23.59 (14.7%) stddev-sans-first:24.31 02:06:52 INFO - PROCESS | 22072 | Values: 174.0 134.0 162.0 189.0 135.0 159.0 160.0 137.0 198.0 133.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:4.24 (2.6%) stddev-sans-first:4.49 02:06:52 INFO - PROCESS | 22072 | Values: 164.0 176.0 164.0 165.0 165.0 165.0 163.0 163.0 161.0 161.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.50 stddev:35.48 (46.4%) stddev-sans-first:37.15 02:06:52 INFO - PROCESS | 22072 | Values: 77.0 77.0 76.0 162.0 76.0 77.0 75.0 77.0 159.0 76.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:87.00 stddev:27.61 (31.7%) stddev-sans-first:28.58 02:06:52 INFO - PROCESS | 22072 | Values: 87.0 87.0 140.0 87.0 87.0 86.0 148.0 89.0 86.0 144.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 02:06:52 INFO - PROCESS | 22072 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 117.0 118.0 118.0 117.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.50 stddev:1.73 (1.2%) stddev-sans-first:1.69 02:06:52 INFO - PROCESS | 22072 | Values: 147.0 151.0 147.0 148.0 149.0 148.0 150.0 151.0 151.0 147.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:1.20 (1.2%) stddev-sans-first:1.27 02:06:52 INFO - PROCESS | 22072 | Values: 96.0 96.0 99.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.00 stddev:1.91 (3.0%) stddev-sans-first:2.00 02:06:52 INFO - PROCESS | 22072 | Values: 64.0 64.0 66.0 64.0 65.0 64.0 70.0 64.0 64.0 64.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 02:06:52 INFO - PROCESS | 22072 | Values: 66.0 66.0 66.0 66.0 66.0 65.0 65.0 66.0 67.0 65.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:88.50 stddev:8.04 (9.1%) stddev-sans-first:8.50 02:06:52 INFO - PROCESS | 22072 | Values: 92.0 83.0 91.0 85.0 85.0 91.0 86.0 86.0 111.0 92.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.50 stddev:8.34 (6.0%) stddev-sans-first:8.30 02:06:52 INFO - PROCESS | 22072 | Values: 148.0 155.0 142.0 131.0 136.0 133.0 131.0 136.0 149.0 137.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:173.50 stddev:3.06 (1.8%) stddev-sans-first:3.18 02:06:52 INFO - PROCESS | 22072 | Values: 175.0 171.0 180.0 170.0 172.0 171.0 173.0 174.0 176.0 171.0 02:06:52 INFO - PROCESS | 22072 | 02:06:52 INFO - PROCESS | 22072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:68.50 stddev:4.97 (7.3%) stddev-sans-first:5.20 02:06:52 INFO - PROCESS | 22072 | Values: 72.0 83.0 68.0 69.0 67.0 67.0 67.0 69.0 67.0 67.0 02:06:52 INFO - PROCESS | 22072 | -------- Summary: end -------- 02:06:52 INFO - PROCESS | 22072 | 02:06:53 INFO - TEST-INFO | 22072: exit 0 02:06:54 INFO - TEST-OK | kraken | took 68112ms 02:06:54 INFO - SUITE-END | took 1194s 02:06:54 INFO - Completed test suite (00:19:54) 02:06:54 INFO - javascript benchmark 02:06:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6403.008082428627, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.986710066449, 2687.3684684099244, 2694.7439993200614, 2698.4603079384106, 2716.0629582793954, 4778.426588809339, 4902.852914412573, 4924.581410580096, 4938.604911607072, 4948.059868624968, 4784.78468468918, 5023.120953833083, 5066.290719299301, 5078.619103567229, 5125.2055931330515, 4583.885402864922, 4689.9765501172615, 4690.765461726917, 4693.319468677039, 4706.882327941795, 4479.776011199459, 4500.324951257305, 4502.8198872045405, 4524.411826462571, 4618.930716039262, 4487.551244875519, 4493.393391892118, 4493.775311234458, 4543.40935678363, 4553.726776393427, 4564.7717614119165, 4570.200214962369, 4571.337156112379, 4577.473590537097, 4620.745858977755, 4464.486584042812, 4509.0, 4547.749873756942, 4549.886252843672, 4551.5676010778925, 4930.137225985474, 4951.603871690256, 4962.826301079481, 4974.10466116099, 5007.073691367073, 5309.362876454811, 5342.385625653022, 5363.570914326844, 5366.517013468807, 5375.489328513785, 5348.545373643245, 5400.567954563626, 5405.054115529767, 5424.891502170013, 5431.701256430855, 4991.126552853236, 5025.095482813055, 5031.4465408805, 5037.29477873098, 5093.490650934877, 5332.493413125747, 5457.863553411196, 5493.972530137324, 5535.086710692691, 5542.057850165482, 5292.52367286946, 5308.867278318073, 5326.866828329323, 5330.120530112488, 5368.624196306299, 5396.91904621431, 5407.78368865241, 5408.513233808976, 5417.918731219035, 5463.644863083887, 5182.585393168612, 5207.479252074838, 5228.686278823283, 5231.110711179109, 5367.704776237344, 5188.0, 5254.264402983586, 5266.420693723688, 5288.656237344637, 5298.81454149103, 4509.413776209138, 4511.436070491189, 4511.70673906195, 4517.164324599959, 4553.089382123589, 3912.158885839558, 3913.1391093959282, 3922.4508568800393, 3945.349017412095, 3969.285528604879, 4598.333241679938, 4643.976780116145, 4645.256758918625, 4649.256119020941, 4691.0, 5353.116735738559, 5376.354837419534, 5386.407495175527, 5391.595630327741, 5477.20580515823, 4444.866654000385, 4547.15877562652, 4568.086382723469, 4614.077184563033, 4622.560856718606, 4826.831060912851, 4831.0096430231715, 4840.975795121002, 4885.5847252983185, 4905.926411103907, 5017.698938063728, 5022.246663000579, 5023.296738456546, 5027.271045698426, 5028.019536190408, 5140.074786538309, 5338.813141540028, 5350.678959262456, 5397.568194544506, 5409.377921539073, 5025.748712564284, 5029.497050294941, 5034.899302014012, 5038.319826823332, 5083.0, 5311.468853114658, 5317.867053323543, 5320.946790532045, 5343.5457986071615, 5352.839414817562, 5250.737463126905, 5254.5533629641905, 5275.155975043975, 5275.577953763766, 5282.709450980233, 5155.43290238066, 5160.071187186342, 5178.663386879841, 5186.533212010937, 5221.660592061504, 5064.518870707277, 5122.103631864484, 5156.484351564814, 5162.148245539444, 5176.145935920682, 5081.110805609078, 5136.0, 5140.254663073908, 5140.357455318085, 5163.896722065462, 5276.20856871457, 5302.602304827076, 5312.1766126250495, 5319.228711836685, 5357.812476563302, 5002.674826136289, 5043.596512278936, 5098.872528186825, 5126.128558145049, 5179.300794392709], "value": 4892.66639232178, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.590770768043, 572.6564061563062, 590.8138936235085, 594.2898236607253, 604.5309896950414, 34209.82895085524, 37678.24643507132, 37686.17353698473, 37746.62253377465, 38337.0, 38279.617203827955, 38536.80731596345, 38952.0, 38960.22079558407, 39088.80455597725, 7702.499337543056, 7790.259925307087, 7810.1408845027, 7832.746760518318, 7896.012998375203, 7725.420593455485, 7728.420368472359, 7746.0, 7784.338331241823, 7793.688252469923, 7771.689132434724, 7792.3376512996465, 7829.373650108007, 7865.606719664022, 7891.960540197291, 7750.534967901944, 7770.922290777076, 7821.843563128734, 7855.096663883669, 7858.371330293591, 7727.111382191064, 7802.219778022152, 7813.804654883674, 7820.061592608867, 7829.608519573999, 36384.818075909716, 36412.81793591015, 36609.45085823715, 36614.45078323827, 36825.63174368249, 2956.586077949089, 3057.6942305769467, 3178.570892929471, 3243.043302225849, 3436.9484457733156, 29486.852565737034, 29661.110166695034, 29693.554596681068, 30065.398692026254, 30110.69889301101, 3447.7760395059895, 3472.1666799967825, 3502.1944952660774, 3508.561429821272, 3565.1978304881454, 239887.0, 240431.0, 240547.0, 241394.0, 242869.0, 50485.495145048815, 50548.24177637338, 50619.0, 50626.49373506291, 50763.746181268856, 32102.839485802422, 32993.835030825176, 33085.338293234, 35158.29683406318, 35310.47034294488, 12486.375681215903, 12503.56237531682, 12625.431855566521, 12665.556705515262, 12714.554990575285, 9174.311926605531, 9313.720588382359, 9356.812863742687, 9362.719118426457, 9365.157135857806, 17561.0, 17629.55926101832, 17704.55738606545, 17758.11209439523, 17810.19854106568, 6668.699908504129, 6831.9658401707675, 6974.163100427981, 7044.92955070453, 7130.358267755927, 793.6626933553332, 923.736735030513, 931.5932941258748, 974.8294048541477, 979.407458487619, 27351.316217094733, 27980.44039119247, 28336.43327133487, 28663.57004644932, 28778.136655900358, 883.8762573239752, 931.5575101826713, 952.7237101240563, 975.1370037516849, 1060.6234786650782, 14207.431702731776, 14400.639984000274, 14577.344019519147, 14633.341499632543, 14769.483068092564, 395091.0, 398011.0, 399269.0, 400041.0, 400109.0, 48789.5121048785, 49090.50909490931, 49517.257241141415, 49670.006599868524, 49818.75090624524, 1144.5307423956137, 1173.2549830857467, 1203.8916497515265, 1205.2406983600276, 1209.0750575809514, 26108.216753496665, 27285.727142729113, 27442.5883611742, 27514.724852751217, 27749.445011099262, 40590.79704601458, 40626.593734062284, 40961.795191023855, 41005.38491922564, 41063.794681026404, 332045.0, 334886.0, 335034.0, 335288.0, 336030.0, 24581.87709061443, 24803.751962480866, 24920.875395622905, 25176.622350665122, 25248.873755631103, 40911.1817763649, 41555.37666935059, 42359.7882010588, 42652.78673606612, 42749.786251068545, 34084.31831363309, 36421.45367819432, 36603.26793464062, 36892.63107368892, 37007.07482312964, 35538.289234215685, 36180.45729314115, 36260.274794503435, 36554.0, 36737.26525469422, 33742.32515349728, 35846.10384740298, 36341.27317453689, 36652.45021324736, 36855.07862303464, 32154.90993085442, 33414.49878251877, 33557.496637549964, 33592.66407335895, 33646.495302569994, 25174.24477265685, 25421.87289063543, 25649.102281420062, 25675.614865776653, 26048.0], "value": 17070.379648648464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.9818009099546, 365.56132640831004, 367.845504887947, 376.3864900212653, 383.58189573365024, 15711.607209819746, 16306.184690765458, 17348.21933013014, 17365.652686946287, 17391.21739521723, 14819.77770333446, 15328.233588320596, 15596.766048509253, 15697.764533532007, 15724.842751572509, 4995.825146119886, 5252.290940723011, 5272.499112584298, 5280.1815718563685, 5298.7350632468415, 5155.252488389181, 5184.792608295683, 5248.186531087687, 5257.842264732064, 5270.525652691257, 5129.871753206163, 5180.197069454241, 5201.115810312256, 5209.869753256161, 5215.58275337972, 5000.549950504472, 5085.644004919657, 5101.770420331094, 5165.431802501722, 5184.248283998799, 4493.303537951622, 4629.675922685414, 4651.372064771246, 4651.906961860744, 4660.184467718136, 19838.40484785459, 20453.488662783402, 21136.260230891847, 21141.788582114135, 21240.362789116196, 2098.0768461876723, 2128.0, 2360.0087963055385, 2536.5941449368197, 2569.370504226458, 13240.933795330962, 13524.661883452894, 13805.723885522333, 13810.93094534521, 13851.584452466443, 1744.9040302783342, 1748.8513476354526, 1749.3265092939182, 1786.4372722592473, 1835.2750663487848, 65574.3442565573, 65926.34073659297, 66064.0, 66877.3312266876, 66906.0, 9860.408375497493, 9941.701748947544, 10016.14862736661, 10053.849192262122, 10089.0, 13556.93221533886, 13583.117097388638, 13631.931840340932, 13640.249786261851, 13678.931605342108, 6577.901331480031, 6616.801495955129, 6771.424428923597, 6805.421539169226, 6916.100906882174, 6103.6948152592195, 6154.261488621304, 6269.686515674198, 6391.041343798374, 6488.31872653374, 5400.216968539618, 6085.604435711664, 6285.465735412449, 6372.490200783926, 6374.139491168726, 1711.9828801711824, 1775.5028591994262, 1794.1298470241923, 1796.2006906926292, 1837.2742766607116, 850.7873031742065, 879.564615515324, 884.9292056635454, 918.169057003413, 924.4222361024359, 15198.772018419733, 17072.2317495713, 17487.38794142199, 17681.292748289925, 18092.457226283233, 855.8373908957278, 865.1089377940731, 898.5148020069089, 904.9411788233743, 906.0305473143804, 9813.656522021694, 10166.898331016742, 10230.897691022994, 10242.846357304647, 10333.121684656739, 380170.0, 386343.0, 388953.0, 394189.0, 397706.0, 63990.6800466004, 64712.0, 64773.67613161904, 65356.673216633615, 66210.0, 886.2245535156737, 909.8089401225817, 920.3373571028849, 933.1368484152132, 938.7606160429184, 15476.0, 15752.606184845012, 15755.0, 15786.526404207892, 16226.513204603882, 33051.504227436126, 34491.4826277601, 34521.48217776786, 34594.789182378496, 35503.82248088743, 43528.586984084766, 45550.08899822051, 46354.536454635025, 47945.716574055135, 49597.0, 7826.960865195638, 7883.526988380716, 7889.408294377829, 7889.684412623431, 7979.202079792207, 11827.704307392383, 12034.75930481403, 12056.939715301718, 12131.272123672608, 12160.148789584644, 5041.2438134280155, 6395.8720825582295, 9953.452560109263, 10595.258331916692, 10775.299605525615, 10735.0, 10792.082672972885, 10804.891951080388, 10820.134389248999, 10826.813913199816, 10725.946370268099, 10820.97200765926, 10869.184811139037, 10899.073578745896, 11056.281341712764, 7732.574708391093, 7774.545130129266, 7784.727534536264, 7958.482698624803, 7973.681052757825, 10468.110210632181, 10528.0, 10556.472176391304, 10640.946795265974, 10782.67651970442], "value": 8256.963632772802, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.4218207261915, 1387.1399732166055, 1414.6816966182603, 1539.830618631951, 1547.2982061104822, 7000.96499517503, 7445.516041457308, 7682.347000504949, 7958.92041079589, 7988.0, 7954.681812727484, 7972.481788683732, 8032.835238890358, 8038.477498962563, 8047.678092876293, 2185.442712108414, 2203.063697928374, 2219.3120132758895, 2223.2663221136986, 2224.655178447343, 1941.4369832748487, 1977.6044791041777, 2025.9262590826886, 2033.7864524224965, 2036.674132138858, 2167.6206663833764, 2170.934871953836, 2178.194068194762, 2185.584738899612, 2228.1644383356243, 2057.732494775677, 2057.897105144737, 2062.5668609592003, 2062.742157230346, 2066.018641145459, 2068.2761033638258, 2116.8200702940267, 2129.031290762715, 2136.198925402974, 2136.8076873081495, 7910.52536847791, 8018.158093400168, 8043.155468675764, 8128.918710812875, 8146.796330091795, 4337.436133302682, 4416.00639856033, 4428.734275943421, 4441.15618032576, 4444.088961762831, 2810.18504633656, 2871.253474096729, 2886.480433521965, 2900.941981160365, 2908.8109272897404, 894.9373543851933, 918.3709159225951, 920.8987011428737, 927.4110939553365, 928.4800511713462, 10973.615923442641, 10998.12015038795, 11027.944860275727, 11032.172587055922, 11078.224524283303, 4120.876373708794, 4139.586041395896, 4247.660187185018, 4247.787610619456, 4297.011687311936, 9264.0, 9313.627454901729, 9330.300227482965, 9340.299477539213, 9359.110884465965, 4458.041521072985, 4476.932846007313, 4492.348609451611, 4492.640588752892, 4499.032707967803, 3524.347995620767, 3904.4338570907626, 3911.7848518331766, 3984.7609143451486, 4025.8389664413094, 3649.3248748981523, 3673.0633688409284, 3765.548134223911, 3776.055986003499, 3787.981060094682, 1187.2757617853104, 1201.741625550511, 1206.927584344942, 1208.2629595946466, 1209.5161935225804, 684.4319215051495, 802.4543310548883, 816.8202995341135, 827.7971896885181, 832.98334033319, 5030.245463180552, 5144.717040562805, 5156.432792392834, 5235.162374020215, 5275.20871869215, 390.11638638483856, 855.8074433252593, 855.9700410485727, 868.5657171414293, 923.0063063782198, 3172.3020935394175, 3325.617553981275, 3351.4135026370286, 3355.9328813423595, 3380.4591265397416, 9656.613735450645, 9666.323357364918, 9796.559154838049, 9837.704868853945, 9911.801763964824, 9517.952410237904, 9699.806003880023, 9713.70858874235, 9724.659636912816, 9809.068138526829, 7098.716051357991, 7285.4171666266575, 7408.296211859864, 7417.332440080419, 7488.138864030706, 5230.503102205284, 5450.700211488248, 5486.533644640251, 5491.0939694951485, 5516.365617953987, 9093.4998575079, 9195.724128276162, 9215.677451289173, 9290.256779457492, 9306.302027347841, 9034.683786067457, 9350.205232555038, 9361.251099912128, 9412.67055653049, 9461.148496635336, 6629.46964242869, 6629.966850165718, 6862.828429289308, 6926.515143939876, 6932.549384290005, 7478.738244161428, 7579.924200757921, 7588.241175882367, 7611.086669599684, 7616.504927179715, 6680.665966701743, 6892.758753443605, 6893.103896493424, 6941.271166527442, 6948.166220053626, 6634.800955971328, 6729.528932974645, 6831.453483721191, 6846.7945961621235, 6942.618156001468, 6175.752969881154, 6250.249970003629, 6255.812325630239, 6260.373962603703, 6279.560430769802, 4470.821167153277, 4561.429821272341, 4576.222042252758, 4584.243599805995, 4587.72473651582, 4415.27148020573, 4517.6837621366185, 4525.818967241274, 4582.9541704582525, 4620.653450991122], "value": 4110.806253193207, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.1687321163298, 287.0627401533992, 288.04369493282303, 289.8246560830696, 293.83985727778366, 4934.506549345064, 5023.874403139924, 5071.771770270338, 5097.082525145473, 5172.689638621685, 5044.772985215665, 5061.16490779021, 5061.772220250088, 5079.898402031957, 5080.542751152396, 3967.662748666367, 3967.7817720025387, 3968.2063587282514, 3975.3241948868763, 3986.123052928351, 3915.414257225814, 3945.3884647879627, 3978.124812541251, 3980.2039592081555, 4013.1973605279063, 3903.882883513499, 3912.2762288976487, 3923.9607603924023, 3931.5282166140105, 3944.566097729262, 3964.623360780721, 3980.4228386883883, 3987.5813039631003, 4001.099752555681, 4004.379321205218, 3497.877574284888, 3530.382183117944, 3531.823408829574, 3532.4877892705413, 3549.893503194908, 4922.729249891255, 4973.577245934064, 4973.925391119136, 4982.87542811429, 5048.242763585455, 4444.35556844259, 4526.0, 4572.634189264851, 4585.28928016158, 4600.953990460086, 5374.3013408256675, 5384.946150538483, 5396.487333703292, 5414.0, 5421.728913554307, 3747.419150031722, 3799.2401519696173, 3824.598417166213, 3830.578636349999, 3841.769493830379, 5656.8969051035065, 5657.4908258256955, 5671.432856714337, 5673.177389278531, 5673.574481913873, 3907.27715372657, 3947.526296844397, 3952.387379956054, 3953.466282051944, 3968.7817170055346, 3805.3911374179997, 3962.9405558916637, 4025.5571887092397, 4028.1540876415693, 4030.395440683862, 4490.191765482245, 4499.572540608637, 4502.57225563571, 4505.639548836085, 4575.359449677047, 5341.946580534222, 5349.786008559614, 5383.246345511631, 5388.407275199725, 5424.728763561806, 1271.6121582917115, 1349.7030653256268, 1368.7809950407886, 1377.6831328794233, 1378.2970684950747, 863.2101627011215, 877.5612193903048, 882.4969767232616, 882.7219425880827, 888.8488956877346, 4154.231467178582, 4180.498340199135, 4202.348635961431, 4229.175310814423, 4262.680298977527, 4842.370491836039, 4857.295692124622, 4908.263760435963, 4915.377925284647, 4947.6536642434685, 4254.808533615995, 4255.638270747021, 4258.148370325947, 4274.572542745763, 4296.677749168824, 2462.9507409851703, 2639.775619072362, 2641.775449086849, 2644.206737978637, 2661.7471340222646, 4560.996580752296, 4575.839845605387, 4584.601696482605, 4632.587060946444, 4645.953540464619, 4988.6757360771435, 4993.375828021497, 5005.4483110235215, 5011.674241174312, 5016.398032236155, 4281.807318670667, 4579.702319349165, 4599.839005634787, 4604.250384853868, 4629.629629629621, 4861.7326047066335, 4896.2410826321975, 4931.605471562339, 4937.382827146606, 4989.301497790239, 4816.182533218107, 4830.516948305141, 4857.222844344888, 4901.460839307744, 4924.340855937753, 4303.741775493355, 4585.266357382803, 4594.540545945379, 4599.747013914267, 4616.515265897033, 3549.6095429502216, 3560.8575656974467, 3564.821758912096, 3573.4997100405444, 3587.9103022424647, 4860.30253209458, 4872.3909511311085, 4920.957802511917, 4939.53074457926, 5290.280658785987, 5259.47405259471, 5338.172583249602, 5353.330833645794, 5401.432849550741, 5404.216388623706, 5347.679139251657, 5356.78572857097, 5447.591430642797, 5475.288212532345, 5495.148252020943, 5111.87220319495, 5227.660202086852, 5229.895402092013, 5276.0, 5284.656497327662, 5389.0, 5389.194619802253, 5397.514223719884, 5429.294191755204, 5441.755121019484, 5281.853744810305, 5333.879885223992, 5337.653052551572, 5359.27649767292, 5364.329458817648], "value": 3877.912647578573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.8386577556945, 615.375393975115, 650.4796163069544, 710.9857802843943, 756.8637645223861, 12283.938580307096, 12828.0, 12847.100702950796, 13372.331383430837, 13382.531611393602, 13106.541271055516, 14056.0, 14611.269436528184, 14639.121652700846, 15289.159096249701, 623.8689875126229, 773.3697036914924, 789.940754443419, 790.7825348029295, 796.3390385979623, 790.5612385126252, 799.4324029938722, 801.3308887079296, 801.3669201330971, 803.5540275147291, 840.3949156607264, 841.0286119531951, 841.272299460965, 845.2350622686448, 845.471580262336, 822.6298165825402, 827.437342607027, 833.5915401453275, 833.8582440985047, 834.5952213176605, 611.703323887914, 611.9235095613049, 611.9785807496717, 612.2744547710932, 613.772904025509, 12766.297853618047, 12797.808032879515, 12842.807357889638, 12872.163309384954, 12906.677333066655, 13721.588352349445, 13743.656408589764, 13976.371063302176, 14221.146731196059, 14293.714125717532, 10536.104431123364, 10672.359658420519, 10849.891501084967, 10900.291481053706, 11153.944230278797, 3280.491523813813, 3393.117789374756, 3446.327966046622, 3452.482127680843, 3552.786832790041, 45733.0, 46604.5339546607, 55494.44505554933, 59437.0, 59491.70254148745, 10439.843402348972, 10715.517801698943, 10756.78486430267, 10794.892051079545, 10836.566537338576, 19747.703784443245, 19867.205311787366, 19974.60050798976, 20007.0, 20079.39761807148, 6534.085228068075, 6725.327467253333, 6886.0, 6935.375816176467, 7056.15326160864, 3530.6822385985383, 3667.284879448482, 3682.355587772183, 3732.794696291676, 3734.3464893643504, 2768.8338699678084, 2865.6561212654615, 2866.412385461017, 2874.956875646867, 2878.337982264091, 535.6893002058797, 564.5850300029475, 574.6552068758712, 578.1039388947115, 580.7734983356494, 459.9421330938894, 462.780179414782, 462.9166749984968, 463.43229543808565, 469.577380357674, 7572.280633339824, 7593.430492713069, 7725.613719314012, 7764.22357764219, 7832.725854595175, 392.1236037456283, 413.3881854854832, 423.1853681662787, 466.7013111608573, 477.8255936583122, 3432.5537680101925, 3566.3937130687327, 3630.5280313559597, 3650.3429382711365, 3764.416515440111, 91120.0, 91386.54306728423, 94384.52807736055, 95161.0, 95484.52257738667, 48239.75880120577, 48696.75651621719, 49110.75444622754, 79360.0, 80783.59608201921, 73971.63014184787, 75229.62385188039, 76033.6198319016, 76937.0, 78594.21405785983, 7030.50786444944, 7080.185778635317, 7120.2167761547225, 7129.39400150993, 7219.0, 36074.45888311625, 36951.26097477982, 38211.42682859815, 41653.0, 43710.56289437065, 40340.193196135326, 48518.0, 57443.0, 57981.42018579929, 58798.70600646969, 10755.171620824322, 10771.51528181218, 10779.299345542515, 10955.34267943926, 11045.779084418105, 11655.18413711066, 11903.940480297542, 11997.644781094392, 12284.447199876206, 12533.51872082637, 10889.183311251529, 10895.782084358427, 11082.944585277022, 11182.0, 11659.358735269641, 9998.600055997678, 10063.647772327933, 10085.0, 10274.075333220046, 10401.94799026, 10868.67393978182, 10968.780624387307, 11131.55473781072, 11324.263922844988, 11481.311121332747, 8671.306295496472, 8697.739067827975, 8806.0, 8963.686270980485, 9053.864192037256, 9301.302402319989, 9502.144806967406, 9507.572159252712, 9510.191633711212, 9587.280953928623], "value": 6267.918731651797, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1600.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 116.0, 113.0, 113.0, 113.0, 112.0, 115.0, 118.0, 119.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 134.0, 162.0, 189.0, 135.0, 159.0, 160.0, 137.0, 198.0, 133.0], "value": 158.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 176.0, 164.0, 165.0, 165.0, 165.0, 163.0, 163.0, 161.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 162.0, 76.0, 77.0, 75.0, 77.0, 159.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 140.0, 87.0, 87.0, 86.0, 148.0, 89.0, 86.0, 144.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 118.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 147.0, 148.0, 149.0, 148.0, 150.0, 151.0, 151.0, 147.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 99.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 65.0, 64.0, 70.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 67.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 83.0, 91.0, 85.0, 85.0, 91.0, 86.0, 86.0, 111.0, 92.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 155.0, 142.0, 131.0, 136.0, 133.0, 131.0, 136.0, 149.0, 137.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 180.0, 170.0, 172.0, 171.0, 173.0, 174.0, 176.0, 171.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 83.0, 68.0, 69.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0], "value": 69.6, "unit": "score"}]}]} 02:06:54 INFO - Return code: 0 02:06:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:06:54 ERROR - # TBPL SUCCESS # 02:06:54 INFO - Running post-action listener: _resource_record_post_action 02:06:54 INFO - ##### 02:06:54 INFO - ##### Finished run-tests step (success) 02:06:54 INFO - ##### 02:06:54 INFO - Running post-run listener: _resource_record_post_run 02:06:54 INFO - Total resource usage - Wall time: 1222s; CPU: 14.0%; Read bytes: 0; Write bytes: 539303936; Read time: 0; Write time: 3647824 02:06:54 INFO - TinderboxPrint: CPU usage
14.0% 02:06:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:06:54 INFO - TinderboxPrint: I/O write bytes / time
539,303,936 / 3,647,824 02:06:54 INFO - TinderboxPrint: CPU idle
8,387.6 (86.0%) 02:06:54 INFO - TinderboxPrint: CPU user
1,241.9 (12.7%) 02:06:54 INFO - TinderboxPrint: Swap in / out
0 / 0 02:06:54 INFO - install - Wall time: 20s; CPU: 24.0%; Read bytes: 0; Write bytes: 221810688; Read time: 0; Write time: 1605756 02:06:54 INFO - run-tests - Wall time: 1202s; CPU: 14.0%; Read bytes: 0; Write bytes: 301494272; Read time: 0; Write time: 1856836 02:06:55 INFO - Running post-run listener: _upload_blobber_files 02:06:55 INFO - Blob upload gear active. 02:06:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:06:55 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 02:06:55 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:06:55 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:06:55 INFO - (blobuploader) - INFO - Open directory for files ... 02:06:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:06:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:06:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:07:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:01 INFO - (blobuploader) - INFO - Done attempting. 02:07:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:07:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:07:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:02 INFO - (blobuploader) - INFO - Done attempting. 02:07:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:07:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:07:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:03 INFO - (blobuploader) - INFO - Done attempting. 02:07:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:03 INFO - Return code: 0 02:07:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:07:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee479e38a48baff30a43e0b73dbc9f5c2b821ee12a6f532f3a37577984c90acc3ca26579ebbfa441a39280b8c67313d2ba78a66d5cc68418a5a95531893687c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/161d4c8f6849d991dcc3b2758d94da01978931e81e92aebec680677077d0a7689bb242e2baf1dfcb861b5673d44ca1b99c5f957a55eb34f0e8047858223fdac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec307f41730bc3c1acd7adabce19d0add448c0492316926cf40f031c5706711ac710d05a5b6bfff0af22ddf3ff90540e30eb14d509f1ef8272ae0d20b317752"} 02:07:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:07:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:07:03 INFO - Contents: 02:07:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee479e38a48baff30a43e0b73dbc9f5c2b821ee12a6f532f3a37577984c90acc3ca26579ebbfa441a39280b8c67313d2ba78a66d5cc68418a5a95531893687c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/161d4c8f6849d991dcc3b2758d94da01978931e81e92aebec680677077d0a7689bb242e2baf1dfcb861b5673d44ca1b99c5f957a55eb34f0e8047858223fdac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec307f41730bc3c1acd7adabce19d0add448c0492316926cf40f031c5706711ac710d05a5b6bfff0af22ddf3ff90540e30eb14d509f1ef8272ae0d20b317752"} 02:07:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:07:03 INFO - Copying logs to upload dir... 02:07:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:07:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.307810 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-16 02:07:02.022826) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:07:02.026017) ========= 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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 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/Firefox-Non-PGO/sha512/dee479e38a48baff30a43e0b73dbc9f5c2b821ee12a6f532f3a37577984c90acc3ca26579ebbfa441a39280b8c67313d2ba78a66d5cc68418a5a95531893687c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/161d4c8f6849d991dcc3b2758d94da01978931e81e92aebec680677077d0a7689bb242e2baf1dfcb861b5673d44ca1b99c5f957a55eb34f0e8047858223fdac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec307f41730bc3c1acd7adabce19d0add448c0492316926cf40f031c5706711ac710d05a5b6bfff0af22ddf3ff90540e30eb14d509f1ef8272ae0d20b317752"} build_url:https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/a7cOERq2SqScMsUye78oMg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dee479e38a48baff30a43e0b73dbc9f5c2b821ee12a6f532f3a37577984c90acc3ca26579ebbfa441a39280b8c67313d2ba78a66d5cc68418a5a95531893687c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/161d4c8f6849d991dcc3b2758d94da01978931e81e92aebec680677077d0a7689bb242e2baf1dfcb861b5673d44ca1b99c5f957a55eb34f0e8047858223fdac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bec307f41730bc3c1acd7adabce19d0add448c0492316926cf40f031c5706711ac710d05a5b6bfff0af22ddf3ff90540e30eb14d509f1ef8272ae0d20b317752"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 02:07:02.051313) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:07:02.051703) ========= 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=33d5923976266a1c518c4bf7000001ab-1466066753.338555-1545157371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 02:07:02.137580) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:07:02.137966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 02:07:02.138375) ========= ========= Total master_lag: 0.17 =========