builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1494171055.02 results: success (0) revision: 17d8a1e278a9c54a6fdda9d390abce4077e55b20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.018936) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.019289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.019546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.117571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.121046) ========= 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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-07 08:30:55-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-05-07 08:30:55 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150457 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.320109) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.320388) ========= 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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.370167) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:55.370453) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 17d8a1e278a9c54a6fdda9d390abce4077e55b20 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 17d8a1e278a9c54a6fdda9d390abce4077e55b20 --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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-07 08:30:55,407 truncating revision to first 12 chars 2017-05-07 08:30:55,407 Setting DEBUG logging. 2017-05-07 08:30:55,407 attempt 1/10 2017-05-07 08:30:55,407 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/17d8a1e278a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-07 08:30:55,833 unpacking tar archive at: mozilla-central-17d8a1e278a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.746917 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:56.138016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:56.138278) ========= script_repo_revision: 17d8a1e278a9c54a6fdda9d390abce4077e55b20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:56.138599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:56.138861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-07 08:30:56.159498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-07 08:30:56.159801) ========= /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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:30:56 INFO - MultiFileLogger online at 20170507 08:30:56 in /builds/slave/test 08:30:56 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 08:30:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:30:56 INFO - {'append_to_log': False, 08:30:56 INFO - 'base_work_dir': '/builds/slave/test', 08:30:56 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:30:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:30:56 INFO - 'branch': 'Firefox-Non-PGO', 08:30:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:30:56 INFO - 'config_files': ('talos/linux_config.py',), 08:30:56 INFO - 'default_actions': ('clobber', 08:30:56 INFO - 'read-buildbot-config', 08:30:56 INFO - 'download-and-extract', 08:30:56 INFO - 'populate-webroot', 08:30:56 INFO - 'create-virtualenv', 08:30:56 INFO - 'install', 08:30:56 INFO - 'run-tests'), 08:30:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:30:56 INFO - 'download_minidump_stackwalk': True, 08:30:56 INFO - 'download_symbols': 'ondemand', 08:30:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:30:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:30:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:30:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:30:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:30:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:30:56 INFO - 'gecko_profile': False, 08:30:56 INFO - 'gecko_profile_interval': 0, 08:30:56 INFO - 'installer_path': 'installer.exe', 08:30:56 INFO - 'log_level': 'info', 08:30:56 INFO - 'log_name': 'talos', 08:30:56 INFO - 'log_to_console': True, 08:30:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:30:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:30:56 INFO - 'opt_config_files': (), 08:30:56 INFO - 'pip_index': False, 08:30:56 INFO - 'suite': 'dromaeojs-e10s', 08:30:56 INFO - 'system_bits': '32', 08:30:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:30:56 INFO - 'title': 'talos-linux64-ix-052', 08:30:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:30:56 INFO - 'use_talos_json': True, 08:30:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:30:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:30:56 INFO - 'work_dir': 'build'} 08:30:56 INFO - [mozharness: 2017-05-07 15:30:56.302919Z] Running clobber step. 08:30:56 INFO - Running pre-action listener: _resource_record_pre_action 08:30:56 INFO - Running main action method: clobber 08:30:56 INFO - rmtree: /builds/slave/test/build 08:30:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:30:57 INFO - Running post-action listener: _resource_record_post_action 08:30:57 INFO - [mozharness: 2017-05-07 15:30:57.732363Z] Finished clobber step (success) 08:30:57 INFO - [mozharness: 2017-05-07 15:30:57.732461Z] Running read-buildbot-config step. 08:30:57 INFO - Running pre-action listener: _resource_record_pre_action 08:30:57 INFO - Running main action method: read_buildbot_config 08:30:57 INFO - Using buildbot properties: 08:30:57 INFO - { 08:30:57 INFO - "project": "", 08:30:57 INFO - "product": "firefox", 08:30:57 INFO - "who": "ffxbld@noreply.mozilla.org", 08:30:57 INFO - "installer_path": "public/build/target.tar.bz2", 08:30:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:30:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:30:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:30:57 INFO - "stage_platform": "linux64", 08:30:57 INFO - "basedir": "/builds/slave/test", 08:30:57 INFO - "buildnumber": 584, 08:30:57 INFO - "platform": "ubuntu64_hw", 08:30:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:30:57 INFO - "slavebuilddir": "test", 08:30:57 INFO - "taskId": "DF-QmCQ1ST6Ahhf_g38ZEA", 08:30:57 INFO - "branch": "mozilla-central", 08:30:57 INFO - "script_repo_revision": "production", 08:30:57 INFO - "revision": "17d8a1e278a9c54a6fdda9d390abce4077e55b20", 08:30:57 INFO - "slavename": "talos-linux64-ix-052", 08:30:57 INFO - "repo_path": "mozilla-central" 08:30:57 INFO - } 08:30:57 INFO - Finding installer, test and symbols from parent task. 08:30:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DF-QmCQ1ST6Ahhf_g38ZEA'}, attempt #1 08:30:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DF-QmCQ1ST6Ahhf_g38ZEA'}, attempt #1 08:30:58 INFO - Task dependencies: TnmOe61uTsGv_v39-sqbQg 08:30:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg'}, attempt #1 08:30:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 08:30:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/test_packages.json 08:30:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.crashreporter-symbols.zip 08:30:59 INFO - Running post-action listener: _resource_record_post_action 08:30:59 INFO - [mozharness: 2017-05-07 15:30:59.130160Z] Finished read-buildbot-config step (success) 08:30:59 INFO - [mozharness: 2017-05-07 15:30:59.130381Z] Running download-and-extract step. 08:30:59 INFO - Running pre-action listener: _resource_record_pre_action 08:30:59 INFO - Running main action method: download_and_extract 08:30:59 INFO - mkdir: /builds/slave/test/build/tests 08:30: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:30:59 INFO - trying https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.test_packages.json 08:30:59 INFO - Downloading https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:30:59 INFO - Downloaded 986 bytes. 08:30:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:30:59 INFO - Using the following test package requirements: 08:30:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:30:59 INFO - u'common': [u'target.common.tests.zip'], 08:30:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:30:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:30:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:30:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:30:59 INFO - u'mozbase': [u'target.common.tests.zip'], 08:30:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:30:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:30:59 INFO - u'web-platform': [u'target.common.tests.zip', 08:30:59 INFO - u'target.web-platform.tests.zip'], 08:30:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:30:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:30:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip 08:30:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:30:59 INFO - Fetch https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip into memory 08:31:01 INFO - Content-Length response header: 58438272 08:31:01 INFO - Bytes received: 58438272 08:31:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:31:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip 08:31:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:31:11 INFO - Fetch https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.common.tests.zip into memory 08:31:12 INFO - Content-Length response header: 58438272 08:31:12 INFO - Bytes received: 58438272 08:31:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.talos.tests.zip 08:31:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:31:23 INFO - Fetch https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.talos.tests.zip into memory 08:31:24 INFO - Content-Length response header: 14408697 08:31:24 INFO - Bytes received: 14408697 08:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:25 INFO - trying https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 08:31:25 INFO - Downloading https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:31:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:31:29 INFO - Downloaded 58413047 bytes. 08:31:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 08:31:29 INFO - mkdir: /builds/slave/test/properties 08:31:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:31:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:31:29 INFO - Contents: 08:31:29 INFO - build_url:https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 08:31:29 INFO - Running post-action listener: _resource_record_post_action 08:31:29 INFO - Running post-action listener: set_extra_try_arguments 08:31:29 INFO - [mozharness: 2017-05-07 15:31:29.958284Z] Finished download-and-extract step (success) 08:31:29 INFO - [mozharness: 2017-05-07 15:31:29.958473Z] Running populate-webroot step. 08:31:29 INFO - Running pre-action listener: _resource_record_pre_action 08:31:29 INFO - Running main action method: populate_webroot 08:31:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:29 INFO - '--tppagecycles', 08:31:29 INFO - '7'], 08:31:29 INFO - 'tests': ['tsvgm']}}, 08:31:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:31:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:31:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:31:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['damp', 'tps']}, 08:31:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'tests': ['damp', 'tps']}, 08:31:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['dromaeo_dom']}, 08:31:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:31:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:31:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'other-e10s': {'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['a11yr', 08:31:29 INFO - 'ts_paint', 08:31:29 INFO - 'tpaint', 08:31:29 INFO - 'sessionrestore', 08:31:29 INFO - 'sessionrestore_no_auto_restore', 08:31:29 INFO - 'tabpaint']}, 08:31:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:31:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:31:29 INFO - 'bloom_basic_ref']}, 08:31:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['tsvgx', 08:31:29 INFO - 'tsvgr_opacity', 08:31:29 INFO - 'tart', 08:31:29 INFO - 'tscrollx', 08:31:29 INFO - 'cart', 08:31:29 INFO - 'tsvg_static']}, 08:31:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:31:29 INFO - 'tsvgr_opacity', 08:31:29 INFO - 'tart', 08:31:29 INFO - 'tscrollx', 08:31:29 INFO - 'cart', 08:31:29 INFO - 'tsvg_static']}, 08:31:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'talos_options': ['--disable-e10s'], 08:31:29 INFO - 'tests': ['tp5o']}, 08:31:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:31:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'talos_options': ['--disable-e10s', 08:31:29 INFO - '--xperf_path', 08:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:29 INFO - 'tests': ['tp5n']}, 08:31:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:31:29 INFO - 'talos_options': ['--xperf_path', 08:31:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:29 INFO - 'tests': ['tp5n']}}, 08:31:29 INFO - 'talos.zip': {'path': '', 08:31:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:29 INFO - Running post-action listener: _resource_record_post_action 08:31:29 INFO - [mozharness: 2017-05-07 15:31:29.978133Z] Finished populate-webroot step (success) 08:31:29 INFO - [mozharness: 2017-05-07 15:31:29.978223Z] Running create-virtualenv step. 08:31:29 INFO - Running pre-action listener: _resource_record_pre_action 08:31:29 INFO - Running main action method: create_virtualenv 08:31:29 INFO - Creating virtualenv /builds/slave/test/build/venv 08:31:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:31:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:31:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:30 INFO - Using real prefix '/usr' 08:31:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:32 INFO - Installing pip.................done. 08:31:32 INFO - Return code: 0 08:31:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:31:32 INFO - Reading from file tmpfile_stdout 08:31:32 INFO - Output received: 08:31:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:31:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:32 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:31:32 INFO - Using env: {'DISPLAY': ':0', 08:31:32 INFO - 'HOME': '/home/cltbld', 08:31:32 INFO - 'LANG': 'en_US.UTF-8', 08:31:32 INFO - 'LANGUAGE': 'en_US:en', 08:31:32 INFO - 'LOGNAME': 'cltbld', 08:31:32 INFO - 'MAIL': '/var/mail/cltbld', 08:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:32 INFO - 'MOZ_NO_REMOTE': '1', 08:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:32 INFO - 'NO_EM_RESTART': '1', 08:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:32 INFO - 'PWD': '/builds/slave/test', 08:31:32 INFO - 'SHELL': '/bin/bash', 08:31:32 INFO - 'SHLVL': '1', 08:31:32 INFO - 'TERM': 'linux', 08:31:32 INFO - 'TMOUT': '86400', 08:31:32 INFO - 'USER': 'cltbld', 08:31:32 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:32 INFO - '_': '/tools/buildbot/bin/python'} 08:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:31:32 INFO - Cleaning up... 08:31:32 INFO - Return code: 0 08:31:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:32 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:31:33 INFO - Using env: {'DISPLAY': ':0', 08:31:33 INFO - 'HOME': '/home/cltbld', 08:31:33 INFO - 'LANG': 'en_US.UTF-8', 08:31:33 INFO - 'LANGUAGE': 'en_US:en', 08:31:33 INFO - 'LOGNAME': 'cltbld', 08:31:33 INFO - 'MAIL': '/var/mail/cltbld', 08:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:33 INFO - 'MOZ_NO_REMOTE': '1', 08:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:33 INFO - 'NO_EM_RESTART': '1', 08:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:33 INFO - 'PWD': '/builds/slave/test', 08:31:33 INFO - 'SHELL': '/bin/bash', 08:31:33 INFO - 'SHLVL': '1', 08:31:33 INFO - 'TERM': 'linux', 08:31:33 INFO - 'TMOUT': '86400', 08:31:33 INFO - 'USER': 'cltbld', 08:31:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:33 INFO - '_': '/tools/buildbot/bin/python'} 08:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:33 INFO - Downloading/unpacking psutil>=3.1.1 08:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:34 INFO - Installing collected packages: psutil 08:31:34 INFO - Running setup.py install for psutil 08:31:34 INFO - building 'psutil._psutil_linux' extension 08:31:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:31:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:31:34 INFO - building 'psutil._psutil_posix' extension 08:31:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:31:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:34 INFO - Successfully installed psutil 08:31:34 INFO - Cleaning up... 08:31:34 INFO - Return code: 0 08:31:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:34 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:31:34 INFO - Using env: {'DISPLAY': ':0', 08:31:34 INFO - 'HOME': '/home/cltbld', 08:31:34 INFO - 'LANG': 'en_US.UTF-8', 08:31:34 INFO - 'LANGUAGE': 'en_US:en', 08:31:34 INFO - 'LOGNAME': 'cltbld', 08:31:34 INFO - 'MAIL': '/var/mail/cltbld', 08:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:34 INFO - 'MOZ_NO_REMOTE': '1', 08:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:34 INFO - 'NO_EM_RESTART': '1', 08:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:34 INFO - 'PWD': '/builds/slave/test', 08:31:34 INFO - 'SHELL': '/bin/bash', 08:31:34 INFO - 'SHLVL': '1', 08:31:34 INFO - 'TERM': 'linux', 08:31:34 INFO - 'TMOUT': '86400', 08:31:34 INFO - 'USER': 'cltbld', 08:31:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:34 INFO - '_': '/tools/buildbot/bin/python'} 08:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:31:36 INFO - Installing collected packages: mozsystemmonitor 08:31:36 INFO - Running setup.py install for mozsystemmonitor 08:31:36 INFO - Successfully installed mozsystemmonitor 08:31:36 INFO - Cleaning up... 08:31:36 INFO - Return code: 0 08:31:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:31:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:36 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:36 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:31:36 INFO - Using env: {'DISPLAY': ':0', 08:31:36 INFO - 'HOME': '/home/cltbld', 08:31:36 INFO - 'LANG': 'en_US.UTF-8', 08:31:36 INFO - 'LANGUAGE': 'en_US:en', 08:31:36 INFO - 'LOGNAME': 'cltbld', 08:31:36 INFO - 'MAIL': '/var/mail/cltbld', 08:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:36 INFO - 'MOZ_NO_REMOTE': '1', 08:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:36 INFO - 'NO_EM_RESTART': '1', 08:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:36 INFO - 'PWD': '/builds/slave/test', 08:31:36 INFO - 'SHELL': '/bin/bash', 08:31:36 INFO - 'SHLVL': '1', 08:31:36 INFO - 'TERM': 'linux', 08:31:36 INFO - 'TMOUT': '86400', 08:31:36 INFO - 'USER': 'cltbld', 08:31:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:36 INFO - '_': '/tools/buildbot/bin/python'} 08:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:31:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:31:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:31:37 INFO - warning: no files found matching '*.txt' 08:31:37 INFO - no previously-included directories found matching 'build' 08:31:37 INFO - no previously-included directories found matching 'dist' 08:31:37 INFO - no previously-included directories found matching '.git*' 08:31:37 INFO - Installing collected packages: jsonschema, functools32 08:31:37 INFO - Running setup.py install for functools32 08:31:37 INFO - warning: no files found matching '*.txt' 08:31:37 INFO - no previously-included directories found matching 'build' 08:31:37 INFO - no previously-included directories found matching 'dist' 08:31:37 INFO - no previously-included directories found matching '.git*' 08:31:37 INFO - Successfully installed jsonschema functools32 08:31:37 INFO - Cleaning up... 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:31:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:38 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:31:38 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 functools32==3.2.3-2 08:31:38 INFO - Using env: {'DISPLAY': ':0', 08:31:38 INFO - 'HOME': '/home/cltbld', 08:31:38 INFO - 'LANG': 'en_US.UTF-8', 08:31:38 INFO - 'LANGUAGE': 'en_US:en', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MAIL': '/var/mail/cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SHLVL': '1', 08:31:38 INFO - 'TERM': 'linux', 08:31:38 INFO - 'TMOUT': '86400', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - '_': '/tools/buildbot/bin/python'} 08:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:31:38 INFO - Cleaning up... 08:31:38 INFO - Return code: 0 08:31:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:31:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:38 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:31:38 INFO - Using env: {'DISPLAY': ':0', 08:31:38 INFO - 'HOME': '/home/cltbld', 08:31:38 INFO - 'LANG': 'en_US.UTF-8', 08:31:38 INFO - 'LANGUAGE': 'en_US:en', 08:31:38 INFO - 'LOGNAME': 'cltbld', 08:31:38 INFO - 'MAIL': '/var/mail/cltbld', 08:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:38 INFO - 'MOZ_NO_REMOTE': '1', 08:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:38 INFO - 'NO_EM_RESTART': '1', 08:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:38 INFO - 'PWD': '/builds/slave/test', 08:31:38 INFO - 'SHELL': '/bin/bash', 08:31:38 INFO - 'SHLVL': '1', 08:31:38 INFO - 'TERM': 'linux', 08:31:38 INFO - 'TMOUT': '86400', 08:31:38 INFO - 'USER': 'cltbld', 08:31:38 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:38 INFO - '_': '/tools/buildbot/bin/python'} 08:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:31:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:40 INFO - Downloading docopt-0.6.1.tar.gz 08:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:31:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:31:40 INFO - Running setup.py install for blobuploader 08:31:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:31:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:31:40 INFO - Running setup.py install for requests 08:31:40 INFO - Running setup.py install for docopt 08:31:40 INFO - Successfully installed blobuploader requests docopt 08:31:40 INFO - Cleaning up... 08:31:40 INFO - Return code: 0 08:31:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:40 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:40 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:40 INFO - Using env: {'DISPLAY': ':0', 08:31:40 INFO - 'HOME': '/home/cltbld', 08:31:40 INFO - 'LANG': 'en_US.UTF-8', 08:31:40 INFO - 'LANGUAGE': 'en_US:en', 08:31:40 INFO - 'LOGNAME': 'cltbld', 08:31:40 INFO - 'MAIL': '/var/mail/cltbld', 08:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:40 INFO - 'MOZ_NO_REMOTE': '1', 08:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:40 INFO - 'NO_EM_RESTART': '1', 08:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:40 INFO - 'PWD': '/builds/slave/test', 08:31:40 INFO - 'SHELL': '/bin/bash', 08:31:40 INFO - 'SHLVL': '1', 08:31:40 INFO - 'TERM': 'linux', 08:31:40 INFO - 'TMOUT': '86400', 08:31:40 INFO - 'USER': 'cltbld', 08:31:40 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:40 INFO - '_': '/tools/buildbot/bin/python'} 08:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:40 INFO - Running setup.py (path:/tmp/pip-HL21fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:41 INFO - Running setup.py (path:/tmp/pip-n4UFyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:41 INFO - Running setup.py (path:/tmp/pip-2wERyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:41 INFO - Running setup.py (path:/tmp/pip-A4oGtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:41 INFO - Running setup.py (path:/tmp/pip-Pudyvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:41 INFO - Running setup.py (path:/tmp/pip-ewN5tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:41 INFO - Running setup.py (path:/tmp/pip-B9iLfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:41 INFO - Running setup.py (path:/tmp/pip-_kF07X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:41 INFO - Running setup.py (path:/tmp/pip-LqFBX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:41 INFO - Running setup.py (path:/tmp/pip-w5lW4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:41 INFO - Running setup.py (path:/tmp/pip-zPy0_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:41 INFO - Running setup.py (path:/tmp/pip-oxH6bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:41 INFO - Running setup.py (path:/tmp/pip-n_qOrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:41 INFO - Running setup.py (path:/tmp/pip-qeg0WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:41 INFO - Running setup.py (path:/tmp/pip-af_Hnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:42 INFO - Running setup.py (path:/tmp/pip-1_Emtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:42 INFO - Running setup.py (path:/tmp/pip-O8YTyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:31:42 INFO - Running setup.py install for manifestparser 08:31:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozcrash 08:31:42 INFO - Running setup.py install for mozdebug 08:31:42 INFO - Running setup.py install for mozdevice 08:31:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozfile 08:31:42 INFO - Running setup.py install for mozhttpd 08:31:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozinfo 08:31:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozInstall 08:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:31:42 INFO - Running setup.py install for mozleak 08:31:43 INFO - Running setup.py install for mozlog 08:31:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for moznetwork 08:31:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for mozprocess 08:31:43 INFO - Running setup.py install for mozprofile 08:31:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for mozrunner 08:31:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Running setup.py install for mozscreenshot 08:31:43 INFO - Running setup.py install for moztest 08:31:43 INFO - Running setup.py install for mozversion 08:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:31:43 INFO - Cleaning up... 08:31:43 INFO - Return code: 0 08:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:43 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:43 INFO - Using env: {'DISPLAY': ':0', 08:31:43 INFO - 'HOME': '/home/cltbld', 08:31:43 INFO - 'LANG': 'en_US.UTF-8', 08:31:43 INFO - 'LANGUAGE': 'en_US:en', 08:31:43 INFO - 'LOGNAME': 'cltbld', 08:31:43 INFO - 'MAIL': '/var/mail/cltbld', 08:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:43 INFO - 'MOZ_NO_REMOTE': '1', 08:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:43 INFO - 'NO_EM_RESTART': '1', 08:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:43 INFO - 'PWD': '/builds/slave/test', 08:31:43 INFO - 'SHELL': '/bin/bash', 08:31:43 INFO - 'SHLVL': '1', 08:31:43 INFO - 'TERM': 'linux', 08:31:43 INFO - 'TMOUT': '86400', 08:31:43 INFO - 'USER': 'cltbld', 08:31:43 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:43 INFO - '_': '/tools/buildbot/bin/python'} 08:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:31:44 INFO - Running setup.py (path:/tmp/pip-zq3QHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:31:44 INFO - Running setup.py (path:/tmp/pip-haKxkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:31:44 INFO - Running setup.py (path:/tmp/pip-jJ2dkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:31:44 INFO - Running setup.py (path:/tmp/pip-ng2g6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:31:44 INFO - Running setup.py (path:/tmp/pip-3AhKLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:31:44 INFO - Running setup.py (path:/tmp/pip-ht7hXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:31:44 INFO - Running setup.py (path:/tmp/pip-82SqAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:31:44 INFO - Running setup.py (path:/tmp/pip-2rQ0kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:31:44 INFO - Running setup.py (path:/tmp/pip-k91x_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:31:44 INFO - Running setup.py (path:/tmp/pip-JARt5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:31:44 INFO - Running setup.py (path:/tmp/pip-oI8jyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:31:44 INFO - Running setup.py (path:/tmp/pip-XTRVSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:31:45 INFO - Running setup.py (path:/tmp/pip-dSfrYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:31:45 INFO - Running setup.py (path:/tmp/pip-aPJUUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:45 INFO - Running setup.py (path:/tmp/pip-Mgvbfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:31:45 INFO - Running setup.py (path:/tmp/pip-dVLNy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:31:45 INFO - Running setup.py (path:/tmp/pip-KoQJYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:31:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:31:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:46 INFO - Downloading blessings-1.6.tar.gz 08:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:31:46 INFO - Installing collected packages: blessings 08:31:46 INFO - Running setup.py install for blessings 08:31:46 INFO - Successfully installed blessings 08:31:46 INFO - Cleaning up... 08:31:46 INFO - Return code: 0 08:31:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:31:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:46 INFO - Reading from file tmpfile_stdout 08:31:46 INFO - Current package versions: 08:31:46 INFO - argparse == 1.2.1 08:31:46 INFO - blessings == 1.6 08:31:46 INFO - blobuploader == 1.2.4 08:31:46 INFO - docopt == 0.6.1 08:31:46 INFO - functools32 == 3.2.3-2 08:31:46 INFO - jsonschema == 2.5.1 08:31:46 INFO - manifestparser == 1.1 08:31:46 INFO - mozInstall == 1.12 08:31:46 INFO - mozcrash == 1.0 08:31:46 INFO - mozdebug == 0.1 08:31:46 INFO - mozdevice == 0.50 08:31:46 INFO - mozfile == 1.2 08:31:46 INFO - mozhttpd == 0.7 08:31:46 INFO - mozinfo == 0.9 08:31:46 INFO - mozleak == 0.1 08:31:46 INFO - mozlog == 3.4 08:31:46 INFO - moznetwork == 0.27 08:31:46 INFO - mozprocess == 0.25 08:31:46 INFO - mozprofile == 0.28 08:31:46 INFO - mozrunner == 6.13 08:31:46 INFO - mozscreenshot == 0.1 08:31:46 INFO - mozsystemmonitor == 0.3 08:31:46 INFO - moztest == 0.8 08:31:46 INFO - mozversion == 1.4 08:31:46 INFO - psutil == 3.1.1 08:31:46 INFO - requests == 1.2.3 08:31:46 INFO - wsgiref == 0.1.2 08:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:46 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:31:46 INFO - Using env: {'DISPLAY': ':0', 08:31:46 INFO - 'HOME': '/home/cltbld', 08:31:46 INFO - 'LANG': 'en_US.UTF-8', 08:31:46 INFO - 'LANGUAGE': 'en_US:en', 08:31:46 INFO - 'LOGNAME': 'cltbld', 08:31:46 INFO - 'MAIL': '/var/mail/cltbld', 08:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:46 INFO - 'MOZ_NO_REMOTE': '1', 08:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:46 INFO - 'NO_EM_RESTART': '1', 08:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:46 INFO - 'PWD': '/builds/slave/test', 08:31:46 INFO - 'SHELL': '/bin/bash', 08:31:46 INFO - 'SHLVL': '1', 08:31:46 INFO - 'TERM': 'linux', 08:31:46 INFO - 'TMOUT': '86400', 08:31:46 INFO - 'USER': 'cltbld', 08:31:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:46 INFO - '_': '/tools/buildbot/bin/python'} 08:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:31:47 INFO - Cleaning up... 08:31:47 INFO - Return code: 0 08:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:47 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 0x1dce1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206bb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, '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': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:31:47 INFO - Using env: {'DISPLAY': ':0', 08:31:47 INFO - 'HOME': '/home/cltbld', 08:31:47 INFO - 'LANG': 'en_US.UTF-8', 08:31:47 INFO - 'LANGUAGE': 'en_US:en', 08:31:47 INFO - 'LOGNAME': 'cltbld', 08:31:47 INFO - 'MAIL': '/var/mail/cltbld', 08:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:47 INFO - 'MOZ_NO_REMOTE': '1', 08:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:47 INFO - 'NO_EM_RESTART': '1', 08:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:47 INFO - 'PWD': '/builds/slave/test', 08:31:47 INFO - 'SHELL': '/bin/bash', 08:31:47 INFO - 'SHLVL': '1', 08:31:47 INFO - 'TERM': 'linux', 08:31:47 INFO - 'TMOUT': '86400', 08:31:47 INFO - 'USER': 'cltbld', 08:31:47 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:47 INFO - '_': '/tools/buildbot/bin/python'} 08:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:31:47 INFO - Cleaning up... 08:31:47 INFO - Return code: 0 08:31:47 INFO - Running post-action listener: _resource_record_post_action 08:31:47 INFO - Running post-action listener: _start_resource_monitoring 08:31:47 INFO - Starting resource monitoring. 08:31:47 INFO - [mozharness: 2017-05-07 15:31:47.419717Z] Finished create-virtualenv step (success) 08:31:47 INFO - [mozharness: 2017-05-07 15:31:47.420179Z] Running install step. 08:31:47 INFO - Running pre-action listener: _resource_record_pre_action 08:31:47 INFO - Running main action method: install 08:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:31:47 INFO - Reading from file tmpfile_stdout 08:31:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:31:47 INFO - Reading from file tmpfile_stdout 08:31:47 INFO - Output received: 08:31:47 INFO - Usage: mozinstall [options] installer 08:31:47 INFO - Options: 08:31:47 INFO - -h, --help show this help message and exit 08:31:47 INFO - -d DEST, --destination=DEST 08:31:47 INFO - Directory to install application into. [default: 08:31:47 INFO - "/builds/slave/test"] 08:31:47 INFO - --app=APP Application being installed. [default: firefox] 08:31:47 INFO - mkdir: /builds/slave/test/build/application 08:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:32:02 INFO - Reading from file tmpfile_stdout 08:32:02 INFO - Output received: 08:32:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:32:02 INFO - Running post-action listener: _resource_record_post_action 08:32:02 INFO - [mozharness: 2017-05-07 15:32:02.596010Z] Finished install step (success) 08:32:02 INFO - [mozharness: 2017-05-07 15:32:02.596284Z] Running run-tests step. 08:32:02 INFO - Running pre-action listener: _resource_record_pre_action 08:32:02 INFO - Running main action method: run_tests 08:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:32:02 INFO - Python 2.7.3 08:32:02 INFO - Return code: 0 08:32:02 INFO - grabbing minidump binary from tooltool 08:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:02 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 0x2069290>, '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 0x2069b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206a040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:32:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:32:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:32:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:32:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:02 INFO - Return code: 0 08:32:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:32:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:32:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:32:02 INFO - ENV: RUST_BACKTRACE is now 1 08:32:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:32:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:32:02 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/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:32:02 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/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:32:02 INFO - Using env: {'DISPLAY': ':0', 08:32:02 INFO - 'HOME': '/home/cltbld', 08:32:02 INFO - 'LANG': 'en_US.UTF-8', 08:32:02 INFO - 'LANGUAGE': 'en_US:en', 08:32:02 INFO - 'LOGNAME': 'cltbld', 08:32:02 INFO - 'MAIL': '/var/mail/cltbld', 08:32:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:32:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:02 INFO - 'MOZ_NO_REMOTE': '1', 08:32:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:02 INFO - 'NO_EM_RESTART': '1', 08:32:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:02 INFO - 'PWD': '/builds/slave/test', 08:32:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:32:02 INFO - 'RUST_BACKTRACE': '1', 08:32:02 INFO - 'SHELL': '/bin/bash', 08:32:02 INFO - 'SHLVL': '1', 08:32:02 INFO - 'TERM': 'linux', 08:32:02 INFO - 'TMOUT': '86400', 08:32:02 INFO - 'USER': 'cltbld', 08:32:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239', 08:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:02 INFO - '_': '/tools/buildbot/bin/python'} 08:32:02 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/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:32:02 INFO - mozversion application_buildid: 20170507150206 08:32:02 INFO - mozversion application_changeset: 17d8a1e278a9c54a6fdda9d390abce4077e55b20 08:32:02 INFO - mozversion application_display_name: Nightly 08:32:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:02 INFO - mozversion application_name: Firefox 08:32:02 INFO - mozversion application_remotingname: firefox 08:32:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:32:02 INFO - mozversion application_vendor: Mozilla 08:32:02 INFO - mozversion application_version: 55.0a1 08:32:02 INFO - mozversion platform_buildid: 20170507150206 08:32:02 INFO - mozversion platform_changeset: 17d8a1e278a9c54a6fdda9d390abce4077e55b20 08:32:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:32:02 INFO - mozversion platform_version: 55.0a1 08:32:02 INFO - using testdate: 1494171122 08:32:02 INFO - actual date: 1494171122 08:32:02 INFO - starting webserver on 'localhost:50831' 08:32:02 INFO - SUITE-START | Running 2 tests 08:32:02 INFO - TEST-START | dromaeo_css 08:32:02 INFO - operating with platform_type : linux_ 08:32:02 INFO - Initialising browser for dromaeo_css test... 08:32:02 INFO - TEST-INFO | started process 32581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemYM7j/profile http://localhost:50831/getInfo.html) 08:32:06 INFO - PID 32581 | __metrics Screen width/height:1600/1200 08:32:06 INFO - PID 32581 | colorDepth:24 08:32:06 INFO - PID 32581 | Browser inner width/height: 1024/695 08:32:06 INFO - PID 32581 | __metrics 08:32:09 INFO - TEST-INFO | 32581: exit 0 08:32:09 INFO - Browser initialized. 08:32:09 INFO - Running cycle 1/1 for dromaeo_css test... 08:32:09 INFO - TEST-INFO | started process 32751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemYM7j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:21 INFO - PID 32751 | RSS: Main: 159621120 08:32:21 INFO - PID 32751 | 08:35:26 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50831/tests/dromaeo/cssquery-ext.html) 08:35:29 INFO - PID 32751 | RSS: Main: 162689024 08:35:29 INFO - PID 32751 | 08:38:31 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-ext.html (next: http://localhost:50831/tests/dromaeo/cssquery-jquery.html) 08:38:31 INFO - PID 32751 | RSS: Main: 159055872 08:38:31 INFO - PID 32751 | 08:41:33 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50831/tests/dromaeo/cssquery-mootools.html) 08:41:34 INFO - PID 32751 | RSS: Main: 165666816 08:41:34 INFO - PID 32751 | 08:44:36 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50831/tests/dromaeo/cssquery-prototype.html) 08:44:36 INFO - PID 32751 | RSS: Main: 158449664 08:44:36 INFO - PID 32751 | 08:47:39 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50831/tests/dromaeo/cssquery-yui.html) 08:47:40 INFO - PID 32751 | RSS: Main: 162619392 08:47:40 INFO - PID 32751 | 08:50:41 INFO - PID 32751 | Cycle 1(1): loaded http://localhost:50831/tests/dromaeo/cssquery-yui.html (next: http://localhost:50831/tests/dromaeo/cssquery-dojo.html) 08:50:42 INFO - PID 32751 | RSS: Main: 166195200 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | __start_tp_report 08:50:42 INFO - PID 32751 | _x_x_mozilla_page_load 08:50:42 INFO - PID 32751 | _x_x_mozilla_page_load_details 08:50:42 INFO - PID 32751 | |i|pagename|runs| 08:50:42 INFO - PID 32751 | |0;dojo.html;2742.9039983600574;2743.3827388837503;2751.944961100778;2784.3735159589082;2788.2750484873927;5233.084210263199;5340.759665815038;5374.543163831074;5413.864653383657;5437.211604317376;5336.252924590561;5351.438098999607;5352.652077614952;5438.483344082316;5482.451754824516;4375.212461756899;4710.114408312318;4768.618510519167;4773.260144677572;4803.61571074315;4808.495108013661;4849.102915960559;4873.707577545341;4878.365812444377;4924.753762311888;4686.507916668735;4759.143354196243;4770.8330208442885;4791.568758811689;4792.712437253741;4805.063012712522;4821.204501257288;4826.1795494765975;4837.32277481153;4845.9030819383415;4746.928796068062;4750.358701575277;4777.092352453057;4787.257975013878;4816.373871396731;5230.581553475713;5309.309789727349;5410.810621628263;5413.53984911283;5465.59008074396;5701.258836351248;5702.6293290935955;5709.457601527848;5717.571182161355;5728.369879313273;5714.914276285859;5720.08478643415;5722.256106706143;5727.455891690324;5753.626014309057;5311.070562651521;5350.759215835296;5359.490848369399;5362.302900622972;5363.06146424378;5830.82507524775;5848.707564621752;5872.559558033165;5888.587798854039;5891.3814049525035;5592.2730045094695;5592.636478628876;5697.888911662269;5785.971070144622;5806.535477161817;5806.44838740319;5808.825735227865;5821.912671309934;5844.824655260349;5886;5746.569007324468;5755.625884317506;5766.077427611562;5766.452187042224;5780.942190578125;5628.296462942132;5719.857003574861;5725.627834190765;5731.570132240098;5776.855578610568;4774.665773395898;4806.519348065235;4808.230683090689;4808.735519546459;4809.398825146856;4114.670826333886;4170.436991006236;4170.645495132948;4232.217039847638;4250.978745106255;4969.577585905238;4971.055499455092;4973.726445045557;4982.078315511642;5011.498850114959;5856.414358564195;5896.587238893322;5901.468867801918;5919.704014799243;5953.880922381528;4847.151748444078;4901.117798796251;4945.752712364368;4964.826231081895;5006.123928312531;5235.502627250406;5243.632945693841;5244.527992480619;5249.553787927993;5300.92048619271;5464.098423760035;5464.863378415572;5470.261514695465;5476.808311709071;5477.20580515831;5694.117411801178;5784.971075144597;5789.710514474344;5903.114532820111;5915.940840591539;5335.573154147736;5339.626226164131;5341.35903691544;5351.732413379394;5358.651687640291;5624;5641.858953526031;5657.349404818498;5657.4059723728415;5675.858103547444;5649.915251271316;5749.166370876116;5754.798582049776;5765.365809761007;5774.9133762994425;5492.670439773627;5549.306336707911;5569.053260945568;5585.162225666182;5590.664560126405;5493.697846618475;5562.388137304974;5565.693886836263;5569.415211402745;5585.3297604287745;5426.186072089218;5531.474509921551;5642.097264437671;5671.461211184931;5713.342965559014;5709.20071190042;5715.171300161536;5720.74256658443;5726.112452569859;5726.828195154152;5431.619786614899;5516.696581688046;5543.223948647274;5560.110382338807;5571.164325351229 08:50:42 INFO - PID 32751 | |1;ext.html;729.8138974561487;746.2574738135554;1031.798799234149;1049.8215303398422;1093.338530189235;31331.843340783293;32358.602346753603;32367.352652946927;32376.352472950526;32382.19044523888;29740.85129574349;29801.105966820975;30062.699373006264;30216.697833021717;30295.09114726562;6304.716287767062;6386.968065159667;6508.9023664645065;6965.164180298371;6978.616176110312;6805.115335006467;6828.385445309921;6851.657417129149;6868.793936181923;6889.5521791083665;6848.3494068063455;6894.345037221481;6896;6909.550879192861;6935.306469353075;6884.105066341369;6888.311168883121;6897.931020689779;6908.654567271667;6917.55035922666;6810.353016463428;6904.4131248843905;6906.930930690679;6908.516403851682;6921.134858142732;30530.084097477113;30628;30809.07572772798;30830;30919.690803091908;2940.5148150555133;2952.7785416093666;2977.151511819121;2977.985110074457;2978.225661328049;23882.880585596962;23965.640515392282;24033.27900162998;24045.27864164078;24056;2747.148384000966;2755.531559634867;2774.334159801653;2788.442311537701;2794.315392728774;145015;145088.2745586276;145745;146188;146834;36256.91229263126;38834.417483737765;38948.610513895066;38969.41545876814;40146.19707605831;39937.600623993385;40042.399364009565;40101.799491002355;43092.35361469581;43958.42810651892;10724;10831.67504974852;10837.18721095921;10847.728806779895;10852.077573406192;8341.708040218564;8345.290650294794;8398.580070996426;8424.705135320357;8443.240108390151;12652.683682908;12662.746745065047;12686.429110690042;12762.170458920325;12910.9354453229;5294.811085136587;5299.258103865462;5325.813596524181;5364.597655175878;5463.606780271006;876.3514998900768;905.4341036851968;911.1480765484293;911.4850109688005;935.2845073518764;19578.412647620593;21106.683399749018;21205.893970530047;21402.357929262147;21457.46356341073;944.8535477001076;962.4417837654144;963.7879666473365;966.6085235479642;986.2849434160177;10539.57841686324;11097.1677124216;11187.216894817448;11196.832047519294;11201.775964480828;181974;182519;183089;183449;183534;40163.59836401657;40408.39387409191;40447.393289100684;40567.59432405697;40587.59412405838;1172.3376292394769;1201.759648070407;1202.6452196602024;1205.873383294759;1215.1979693402488;19495.317663881695;19596.118174681887;20154.596908061463;20974.58050838944;21108.894455527625;29969.70030299669;30008;30021.69978300189;30063.398732025675;30132;144300.51942987563;144357;145213.27393362965;145257;145408;27678.308042299104;28596.142115736562;28736.856315718287;29052.128436146948;29087;35296.647033529334;35325.470117947734;35428.64571354356;35452.64547354494;35546.11134721652;26452;26762.31659459548;27287.317817054733;27641.723582763916;28330.43339133247;26478.86760566185;27291.376547924;27341.179764607095;27503.31241718973;28073.438531228854;29368.706312936596;29412;29494;29586.704132959258;29612.703872960996;25376.74623253744;25978.220653380427;26327.34181645474;26342;26681.7331826687;19848.40454786359;21562.13751449987;21618.13527458884;21658.458538536663;21729.565408692055 08:50:42 INFO - PID 32751 | |2;jquery.html;420.8190478094418;425.4192928629542;431.35727765629224;443.142519225299;447.92161371759954;16678.916605416973;16876.0718160501;17360.652786944283;17493.91253043733;17647.823521764778;18300.54248643781;18327.90836045818;18413.263469461206;18466.153384661528;18498.445046648587;5353.973230133854;5440.564754819605;5508.394076651565;5548.306461692288;5559.249501317331;5408.188771684259;5461.508464238238;5485.573750824794;5495.972520137394;5496.203050557687;5287;5454.509094181523;5474.808381706641;5483.341998960111;5505.614606977513;5342.91985620216;5380.704061276648;5393.6763794172275;5408.35099788024;5429.4570542945785;4710.929336059962;4906.31311616374;4915.901681966377;4959.752012399365;4975.278584605248;20497.38507844752;20916;20979.790202097935;21052.947352632305;21196.682049769264;1558.345494892148;1566.9736322708643;1569.3330334607747;1587.5078725595104;1591.0851260525244;14167.929160354131;14592.489262875748;14623.415063397451;14656.560303190921;14795.038322509003;2029.3201777404588;2040.2349119080345;2093.8534302598823;2098.26560703754;2105.357865850915;90061.54969225178;92056;92204.53897730468;92378;93179.53410232974;10687.198460115522;10904.400257985728;10958.945205273923;10999.450027498593;11116.55533778656;15222.847771522365;15238.390464381522;15266.542003739905;15276.770848437282;15279.694406111816;6312.8421789454715;6433.260175079832;6560.3111673273615;6637.734490620418;6651.301613330627;5627.212190293362;5657.886842263131;5766.163906233573;5774.393688662714;5792.855178620568;6690.163729533809;6760.391564759097;6875.3812156906115;6932.896006559805;6935.549189302679;1998.280618977167;2013.959720805605;2023.9392818215476;2030.0357330268005;2117.2272120676153;844.3371953016853;881.1012766977647;881.6561540999015;884.8318819424288;906.7325139083986;16128.596785080232;16197.919010405109;16483.258253378626;16825.15874206285;16909.83090169107;854.5001174313096;872.445996792029;885.0795173020116;897.8473659477904;900.1808354397467;8652.610632521551;9089.181973622406;9225.630974760934;9264.7683807904;9337.626494940127;340989;344278;358570;359414;361116;74362.62818685872;74379.62810185914;78027.60986195033;79462;80185.19814801894;1016.3089099412471;1031.896810318962;1056.1497994114811;1061.1616822709973;1063.723431907694;14099.577012689635;14121.152730836182;14295.57113286603;14318.498852540111;14959.40162393492;37051.81474092612;37120;37601;37654.62345376511;37917;48991.26513102378;49069.263961041324;49187.75406122946;49502;49843.50156498534;8002.479838810459;8121.4721043132;8125.79685507867;8260;8337.83324333522;12567.560135395583;12617.873821262037;12705.42825572833;12728.490860365482;12894.548690795777;10304.484775761332;10416.32293900894;10767.569297228023;10799.67600971972;10806.405647689453;10177.796444071226;10633.096186824207;10688.625898093529;10776;10954.178436617127;11061.170412219277;11122.777544449227;11159.442027898735;11361.4887330072;11695.473703683525;8001.079875814123;8031.116577176623;8073.111957684532;8128.715494957648;8179.263866252066;10111.24165687591;10703.143748500257;10751.301165424222;10777.46112694378;11034 08:50:42 INFO - PID 32751 | |3;mootools.html;1234.333459931637;1301.5509649171038;1305.8237137986368;1305.9412326445306;1307;9110.134537218963;9338.486383248919;9492.382995105321;9575.473348965812;9943.850842237354;9614.615415383376;9812.264080193978;9836.50817459126;9837.704868853927;9844.40933543988;2156.417767202858;2197;2200.7689192634784;2202.2072054060527;2208.436848603612;2003.5692326149874;2071.1508281604547;2074.802893725094;2076.262926661036;2080.6670932650704;2163.697082408464;2180.9563808723815;2207.2164381644448;2209.8784566848817;2222.9777702223014;2072.585482903418;2102.7161333219974;2107.2729908181655;2116.555523340093;2131.531063166101;1953.6581098307881;2001.4996250937265;2030.6446371885008;2168.0243890249294;2177.9782202178094;9692.46691431971;9737.172340351079;9788.608455661764;9804.852927206097;9815.165710914582;5357.892842143136;5559.555235581184;5580;5580.190872323531;5594.552435805126;3241.773075884689;3470.288590838872;3484.6689564491335;3550.6449355064547;3574.2315402188656;1023.96416125436;1050.8371202463554;1090.7818436312689;1102.5589764094345;1107.7119948813368;13304.467821287233;13338.599842004756;13445;13551.59345219645;13563.050586458952;4484.349769283435;4484.955150448453;4727;4889.657723959289;4903.730294833818;10084.142847857867;10093.192544596415;10130.98690130981;10138.493075346203;10166.339187952759;5178.689278643294;5181.378234611795;5184.844454666366;5185.377754669464;5194.220866869924;4787.497312782108;4819.469858315582;4850.175470170079;4866.099771542205;4945.3571035765835;3695.131644063643;3808.447775072654;3833.3866581347406;3893.299206142865;3915.0603855075146;1119.1494464207099;1119.3843386137755;1122.405125283601;1128.8983991440646;1134.6142311614092;711.1075600121814;739.3530660671912;743.3384287983699;744.151667099507;751.9473636845369;5530.087535556669;5570.3315602128005;5641.069223578145;5674.631148975303;5737.942620573741;533.8718707510247;552.9447055294519;553.720371212535;555.2781384200523;557.8981511514726;3323.1858194742445;3336.3994480993656;3426.7087297579487;3658.2683463307444;3932.075962148893;12027.639170824714;12331.445084971198;12353.258804471761;12599.118061735773;12628.179168354027;11844.348560829238;12280;12317;12331.69170770738;12350.320732359627;7191.280871912767;7291.4531410144455;7400.148982866932;7458.850822983619;7480.139783924918;5700.287464066992;5761.337446193574;5782.797602083907;5971.970140149271;5983.431574000463;10941.726456838644;11004.614838480615;11061.668149955514;11125.721856953642;11145.665630031112;11139.665810025712;11267.323960562393;11368.886311136783;11465.656030319104;11583.957443830095;7201.13586369618;7345.926540734525;7351.742689005859;7368.115826100902;7388.704451822082;9056.230220431336;9184.448933064037;9240.983491816029;9245.445273283625;9255.074492550692;7536.171021187555;7659.234076592519;7700.730474433368;7807.843843123219;8030.558319292495;7814.882776758467;7859.960700196462;7883.487573307717;7944.404169687181;7957.681692732457;7038.2609825969585;7163.10461192351;7175.784726458214;7210.459215558749;7214.314640109181;5109.693418394908;5387.81142660005;5389.622726409114;5542.3626282977975;5668.291463567054;5252.107141785982;5265.420803711512;5347.919781203363;5508.752106155152;5536.252605898313 08:50:42 INFO - PID 32751 | |4;prototype.html;359.1434428887105;374.0032812554542;378.4229050697684;386.19671084144983;387.95538513071;5531.225628412026;5635.126555383912;5696.857578560538;5730.885382292352;5735.340435849873;5457.699826509541;5545.750441230144;5549.417311182328;5550.888982220364;5560.833175004746;4151.522574903887;4156.667466602665;4158.438610787535;4167.229062623424;4172.18642364739;4088.6729061674996;4147.377893316012;4150.418941348214;4184.832606695729;4194.748315101088;4121.690873184508;4126.504819421659;4142.109446469009;4148.191102734968;4156.792160391983;4144.896377590554;4168.2080404723;4180.707350485467;4181.6445602124;4183.832646694129;3562.3943929532043;3611.56661200655;3630.5824830144606;3631.328204282216;3655.3968595181764;5453.4273901240595;5458.263134476874;5470.589705772043;5483.698396588186;5528.170774383834;4885.902281954341;4928.334674818925;4930.605551555867;4931.950680493185;4951.876203094951;5793.13103034544;5855.531557475391;5918.467337939606;5957.761689532414;5963.940360596382;4060.47213862199;4066.79666016698;4073.2260870434525;4080.327385562461;4095.467589213413;6120.051392034197;6266.091416744592;6275.403836635513;6311.684415779238;6343.270523889765;4116.341385378325;4136.91726165475;4147.751134931914;4156.667466602665;4167.229062623424;4183.853565125206;4193.18232944579;4195.97902010488;4213.747175169499;4224.218519573888;4757.976210118927;4857.781399837016;4879.170541008037;4893.388326459192;4895.363602731622;5903.822885313448;5921.644701317935;5926.348101708809;5927.911081333784;5949.434803693643;1419.6025112968384;1446.9148138895828;1452.8256609206962;1453.7964684943904;1454.403694485256;956.9186619137312;969.8302797010494;1114.2089116727052;1120.3781901045;1136.9147313951487;5074.923876141861;5075.187969924795;5096.337476128079;5100.387953445536;5162.845114646567;6108.664023478751;6123.295820980644;6146.231721034871;6148.262208535004;6161.507079433634;4959.528844759742;5096.592272618182;5133.435322114565;5176.870578235499;5198.194279886624;3263.4452143135723;3264.2981758921946;3286.4905939579403;3297.7196938260035;3298.8845390411702;5505.256790333334;5695.345035320991;5713.942860571341;5738.799142030009;5784.1902133701315;6306.968465157736;6310.337414571496;6356.841078973062;6359.90460143089;6369.172007638977;5710.857228569319;5720.2849643794525;5744.626599271034;5749.511291540182;5751;5867.589268751147;6153.30801519085;6189.442950134509;6207.875842483216;6214.483134330422;5869.207656966255;6097.969510152421;6106.1146133811235;6132.141500190066;6151.138840562415;5681.545476361964;5731.188759474902;5744.856378590569;5750.942490575041;5767.769289228384;4126.401671757639;4164.8334066637;4173.52004519472;4176.60322269384;4180.080382316008;6101.328853826164;6195.752169913153;6201.782937597162;6231.813045608639;6255.78104766331;5931.822045338647;5967.164596956516;5987.6108052976415;5995.5803093783015;5997.190379298913;5862.530997520274;5924.674142922181;5952.285725712942;5987.461128498456;6020.759169633166;5800.274965629296;5805.216295800182;5852.473277404883;5853.736581853912;5865.648061116176;6023.548233882389;6024.1265016573225;6029.065494848305;6046.516278697782;6082.513398928164;5713.971430142823;5801.883962320814;5855.560832937632;5858.2677165354335;5862.325832529314 08:50:42 INFO - PID 32751 | |5;yui.html;752.1763668782681;758.2569082299347;766.8236305649704;776.4642396746248;776.941729370297;12531.624051278453;12944;13158.868411315883;13657.248851313174;13661.248631325274;15017.774733379008;15835.604109897258;15843.049417034987;15875.761863572056;15925.522234332988;875.7898104454932;902.5938327752505;902.6885724425063;903.8824952756132;906.959186836594;903.6520939438298;914.6204325205032;914.6661468563992;916.5554705967601;916.5921165081542;957.8898426680917;965.5172413793103;965.6378857928277;966.2801213096253;970.0299700299701;948.8434408322619;949.9382540134869;953.3136141977765;956.416585882611;957.8850537935457;702.9367356937901;703.9155301363818;703.9155301363818;706.5689929143218;708.5111273221461;14296.428142874272;14298.64253393663;15012.549623511311;15068.397264109532;15172.924135379362;15677;15776.368945242291;16039.358425663077;16135.596610084724;16223.594410139724;12563;12611.180273282207;12676.366181690879;12783.744325113446;12887.67780805478;2727.6726792784993;2730.0581299451655;2739.8082134250612;2744.0807329544627;2753.8623068846678;69279.65360173218;69818.3018169817;69992.65003674949;70245;71686.28313716849;11730.296182229093;12180.147389682637;12322.445489952974;12337.444814983348;12525.749485010248;22432.775672243395;23017.42456438569;23227.3031809046;23271.41821454477;23362.182323618592;6266.874662506724;6424.068510066014;6473.190851143607;6508.251551071593;6528.314526974695;2999.145243605562;3024.9546256806166;3056.2512184514935;3059.189314831571;3063.5557844112477;3661.1213308806227;3727.366347720894;3730.9440358394645;3763.1344790698295;3775.905602359963;674.1539368093012;680.5678394219706;680.9216940051858;681.8090934538337;683.4976292425064;604.9153118563405;615.4122812713847;616.6238594457377;626.2422468812697;629.8473792958874;9286.674966376144;9312.90687093134;9824.557894894748;10467.528961196764;10840.13278937683;578.6932925549465;580.9448102430347;586.2583831453215;587.5593305021234;604.7550741949517;4434.091011342667;4478.305862591304;4498.550144985541;4507.932381014221;4539.500654927955;60745.69627151924;60746.69626651927;61668.383316167165;62056.68971655203;62686.373136268965;55008.449915501136;55448;56006.719966399905;56275.71862140663;56431.71784141135;51099.48900511096;51706.74146629318;51963.48036519662;52004;52207.47792522102;8864.556772161237;9117.680881169128;9177.174054335143;9351.298652600946;9549.47477888695;28282;28658.85670571634;28691.28271793222;28790.856045719636;29361.85319073391;33263;33270.33459330751;33622.49566256557;33850.66149338475;34030.82984585061;11189.384583847966;11237.887621124011;11287.153463490107;11437.313761174357;11457;12417.31704756247;12680.112392132462;12707.809382859079;12823.230606163661;13045.608631741063;11723.589674361356;11862.406879656155;11929.821052684043;12024.579139730067;12120.515179392725;11589.768204636028;11697.532098715956;11776.352300623548;11808.055355571705;11808.645740627795;11285.21003529745;11307.660770176908;11370.94314528422;11406.657800266004;11455;9067.455952642862;9104;9121.543922803967;9648.276379271443;9687.128158465772;11370.772584548427;11909.40452977365;11930.164888457724;11941.522339106687;12030.338331391857 08:50:42 INFO - PID 32751 | __end_tp_report 08:50:42 INFO - PID 32751 | __start_cc_report 08:50:42 INFO - PID 32751 | _x_x_mozilla_cycle_collect,340 08:50:42 INFO - PID 32751 | __end_cc_report 08:50:42 INFO - PID 32751 | __startTimestamp1494172242247__endTimestamp 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | ------- Summary: start ------- 08:50:42 INFO - PID 32751 | Number of tests: 6 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#0] dojo.html Cycles:165 Average:5287.93 Median:5465.59 stddev:618.63 (11.3%) stddev-sans-first:587.43 08:50:42 INFO - PID 32751 | Values: 2742.9 2743.4 2751.9 2784.4 2788.3 5233.1 5340.8 5374.5 5413.9 5437.2 5336.3 5351.4 5352.7 5438.5 5482.5 4375.2 4710.1 4768.6 4773.3 4803.6 4808.5 4849.1 4873.7 4878.4 4924.8 4686.5 4759.1 4770.8 4791.6 4792.7 4805.1 4821.2 4826.2 4837.3 4845.9 4746.9 4750.4 4777.1 4787.3 4816.4 5230.6 5309.3 5410.8 5413.5 5465.6 5701.3 5702.6 5709.5 5717.6 5728.4 5714.9 5720.1 5722.3 5727.5 5753.6 5311.1 5350.8 5359.5 5362.3 5363.1 5830.8 5848.7 5872.6 5888.6 5891.4 5592.3 5592.6 5697.9 5786.0 5806.5 5806.4 5808.8 5821.9 5844.8 5886.0 5746.6 5755.6 5766.1 5766.5 5780.9 5628.3 5719.9 5725.6 5731.6 5776.9 4774.7 4806.5 4808.2 4808.7 4809.4 4114.7 4170.4 4170.6 4232.2 4251.0 4969.6 4971.1 4973.7 4982.1 5011.5 5856.4 5896.6 5901.5 5919.7 5953.9 4847.2 4901.1 4945.8 4964.8 5006.1 5235.5 5243.6 5244.5 5249.6 5300.9 5464.1 5464.9 5470.3 5476.8 5477.2 5694.1 5785.0 5789.7 5903.1 5915.9 5335.6 5339.6 5341.4 5351.7 5358.7 5624.0 5641.9 5657.3 5657.4 5675.9 5649.9 5749.2 5754.8 5765.4 5774.9 5492.7 5549.3 5569.1 5585.2 5590.7 5493.7 5562.4 5565.7 5569.4 5585.3 5426.2 5531.5 5642.1 5671.5 5713.3 5709.2 5715.2 5720.7 5726.1 5726.8 5431.6 5516.7 5543.2 5560.1 5571.2 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#1] ext.html Cycles:180 Average:29725.06 Median:16359.00 stddev:41035.49 (250.8%) stddev-sans-first:41092.85 08:50:42 INFO - PID 32751 | Values: 729.8 746.3 1031.8 1049.8 1093.3 31331.8 32358.6 32367.4 32376.4 32382.2 29740.9 29801.1 30062.7 30216.7 30295.1 6304.7 6387.0 6508.9 6965.2 6978.6 6805.1 6828.4 6851.7 6868.8 6889.6 6848.3 6894.3 6896.0 6909.6 6935.3 6884.1 6888.3 6897.9 6908.7 6917.6 6810.4 6904.4 6906.9 6908.5 6921.1 30530.1 30628.0 30809.1 30830.0 30919.7 2940.5 2952.8 2977.2 2978.0 2978.2 23882.9 23965.6 24033.3 24045.3 24056.0 2747.1 2755.5 2774.3 2788.4 2794.3 145015.0 145088.3 145745.0 146188.0 146834.0 36256.9 38834.4 38948.6 38969.4 40146.2 39937.6 40042.4 40101.8 43092.4 43958.4 10724.0 10831.7 10837.2 10847.7 10852.1 8341.7 8345.3 8398.6 8424.7 8443.2 12652.7 12662.7 12686.4 12762.2 12910.9 5294.8 5299.3 5325.8 5364.6 5463.6 876.4 905.4 911.1 911.5 935.3 19578.4 21106.7 21205.9 21402.4 21457.5 944.9 962.4 963.8 966.6 986.3 10539.6 11097.2 11187.2 11196.8 11201.8 181974.0 182519.0 183089.0 183449.0 183534.0 40163.6 40408.4 40447.4 40567.6 40587.6 1172.3 1201.8 1202.6 1205.9 1215.2 19495.3 19596.1 20154.6 20974.6 21108.9 29969.7 30008.0 30021.7 30063.4 30132.0 144300.5 144357.0 145213.3 145257.0 145408.0 27678.3 28596.1 28736.9 29052.1 29087.0 35296.6 35325.5 35428.6 35452.6 35546.1 26452.0 26762.3 27287.3 27641.7 28330.4 26478.9 27291.4 27341.2 27503.3 28073.4 29368.7 29412.0 29494.0 29586.7 29612.7 25376.7 25978.2 26327.3 26342.0 26681.7 19848.4 21562.1 21618.1 21658.5 21729.6 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#2] jquery.html Cycles:180 Average:24251.69 Median:37085.91 stddev:59074.13 (159.3%) stddev-sans-first:59212.75 08:50:42 INFO - PID 32751 | Values: 420.8 425.4 431.4 443.1 447.9 16678.9 16876.1 17360.7 17493.9 17647.8 18300.5 18327.9 18413.3 18466.2 18498.4 5354.0 5440.6 5508.4 5548.3 5559.2 5408.2 5461.5 5485.6 5496.0 5496.2 5287.0 5454.5 5474.8 5483.3 5505.6 5342.9 5380.7 5393.7 5408.4 5429.5 4710.9 4906.3 4915.9 4959.8 4975.3 20497.4 20916.0 20979.8 21052.9 21196.7 1558.3 1567.0 1569.3 1587.5 1591.1 14167.9 14592.5 14623.4 14656.6 14795.0 2029.3 2040.2 2093.9 2098.3 2105.4 90061.5 92056.0 92204.5 92378.0 93179.5 10687.2 10904.4 10958.9 10999.5 11116.6 15222.8 15238.4 15266.5 15276.8 15279.7 6312.8 6433.3 6560.3 6637.7 6651.3 5627.2 5657.9 5766.2 5774.4 5792.9 6690.2 6760.4 6875.4 6932.9 6935.5 1998.3 2014.0 2023.9 2030.0 2117.2 844.3 881.1 881.7 884.8 906.7 16128.6 16197.9 16483.3 16825.2 16909.8 854.5 872.4 885.1 897.8 900.2 8652.6 9089.2 9225.6 9264.8 9337.6 340989.0 344278.0 358570.0 359414.0 361116.0 74362.6 74379.6 78027.6 79462.0 80185.2 1016.3 1031.9 1056.1 1061.2 1063.7 14099.6 14121.2 14295.6 14318.5 14959.4 37051.8 37120.0 37601.0 37654.6 37917.0 48991.3 49069.3 49187.8 49502.0 49843.5 8002.5 8121.5 8125.8 8260.0 8337.8 12567.6 12617.9 12705.4 12728.5 12894.5 10304.5 10416.3 10767.6 10799.7 10806.4 10177.8 10633.1 10688.6 10776.0 10954.2 11061.2 11122.8 11159.4 11361.5 11695.5 8001.1 8031.1 8073.1 8128.7 8179.3 10111.2 10703.1 10751.3 10777.5 11034.0 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#3] mootools.html Cycles:180 Average:5975.35 Median:4858.14 stddev:3714.50 (76.5%) stddev-sans-first:3707.83 08:50:42 INFO - PID 32751 | Values: 1234.3 1301.6 1305.8 1305.9 1307.0 9110.1 9338.5 9492.4 9575.5 9943.9 9614.6 9812.3 9836.5 9837.7 9844.4 2156.4 2197.0 2200.8 2202.2 2208.4 2003.6 2071.2 2074.8 2076.3 2080.7 2163.7 2181.0 2207.2 2209.9 2223.0 2072.6 2102.7 2107.3 2116.6 2131.5 1953.7 2001.5 2030.6 2168.0 2178.0 9692.5 9737.2 9788.6 9804.9 9815.2 5357.9 5559.6 5580.0 5580.2 5594.6 3241.8 3470.3 3484.7 3550.6 3574.2 1024.0 1050.8 1090.8 1102.6 1107.7 13304.5 13338.6 13445.0 13551.6 13563.1 4484.3 4485.0 4727.0 4889.7 4903.7 10084.1 10093.2 10131.0 10138.5 10166.3 5178.7 5181.4 5184.8 5185.4 5194.2 4787.5 4819.5 4850.2 4866.1 4945.4 3695.1 3808.4 3833.4 3893.3 3915.1 1119.1 1119.4 1122.4 1128.9 1134.6 711.1 739.4 743.3 744.2 751.9 5530.1 5570.3 5641.1 5674.6 5737.9 533.9 552.9 553.7 555.3 557.9 3323.2 3336.4 3426.7 3658.3 3932.1 12027.6 12331.4 12353.3 12599.1 12628.2 11844.3 12280.0 12317.0 12331.7 12350.3 7191.3 7291.5 7400.1 7458.9 7480.1 5700.3 5761.3 5782.8 5972.0 5983.4 10941.7 11004.6 11061.7 11125.7 11145.7 11139.7 11267.3 11368.9 11465.7 11584.0 7201.1 7345.9 7351.7 7368.1 7388.7 9056.2 9184.4 9241.0 9245.4 9255.1 7536.2 7659.2 7700.7 7807.8 8030.6 7814.9 7860.0 7883.5 7944.4 7957.7 7038.3 7163.1 7175.8 7210.5 7214.3 5109.7 5387.8 5389.6 5542.4 5668.3 5252.1 5265.4 5347.9 5508.8 5536.3 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#4] prototype.html Cycles:180 Average:4872.46 Median:5538.49 stddev:1464.01 (26.4%) stddev-sans-first:1428.39 08:50:42 INFO - PID 32751 | Values: 359.1 374.0 378.4 386.2 388.0 5531.2 5635.1 5696.9 5730.9 5735.3 5457.7 5545.8 5549.4 5550.9 5560.8 4151.5 4156.7 4158.4 4167.2 4172.2 4088.7 4147.4 4150.4 4184.8 4194.7 4121.7 4126.5 4142.1 4148.2 4156.8 4144.9 4168.2 4180.7 4181.6 4183.8 3562.4 3611.6 3630.6 3631.3 3655.4 5453.4 5458.3 5470.6 5483.7 5528.2 4885.9 4928.3 4930.6 4932.0 4951.9 5793.1 5855.5 5918.5 5957.8 5963.9 4060.5 4066.8 4073.2 4080.3 4095.5 6120.1 6266.1 6275.4 6311.7 6343.3 4116.3 4136.9 4147.8 4156.7 4167.2 4183.9 4193.2 4196.0 4213.7 4224.2 4758.0 4857.8 4879.2 4893.4 4895.4 5903.8 5921.6 5926.3 5927.9 5949.4 1419.6 1446.9 1452.8 1453.8 1454.4 956.9 969.8 1114.2 1120.4 1136.9 5074.9 5075.2 5096.3 5100.4 5162.8 6108.7 6123.3 6146.2 6148.3 6161.5 4959.5 5096.6 5133.4 5176.9 5198.2 3263.4 3264.3 3286.5 3297.7 3298.9 5505.3 5695.3 5713.9 5738.8 5784.2 6307.0 6310.3 6356.8 6359.9 6369.2 5710.9 5720.3 5744.6 5749.5 5751.0 5867.6 6153.3 6189.4 6207.9 6214.5 5869.2 6098.0 6106.1 6132.1 6151.1 5681.5 5731.2 5744.9 5750.9 5767.8 4126.4 4164.8 4173.5 4176.6 4180.1 6101.3 6195.8 6201.8 6231.8 6255.8 5931.8 5967.2 5987.6 5995.6 5997.2 5862.5 5924.7 5952.3 5987.5 6020.8 5800.3 5805.2 5852.5 5853.7 5865.6 6023.5 6024.1 6029.1 6046.5 6082.5 5714.0 5801.9 5855.6 5858.3 5862.3 08:50:42 INFO - PID 32751 | 08:50:42 INFO - PID 32751 | [#5] yui.html Cycles:180 Average:14898.26 Median:3769.52 stddev:17872.24 (474.1%) stddev-sans-first:17890.80 08:50:42 INFO - PID 32751 | Values: 752.2 758.3 766.8 776.5 776.9 12531.6 12944.0 13158.9 13657.2 13661.2 15017.8 15835.6 15843.0 15875.8 15925.5 875.8 902.6 902.7 903.9 907.0 903.7 914.6 914.7 916.6 916.6 957.9 965.5 965.6 966.3 970.0 948.8 949.9 953.3 956.4 957.9 702.9 703.9 703.9 706.6 708.5 14296.4 14298.6 15012.5 15068.4 15172.9 15677.0 15776.4 16039.4 16135.6 16223.6 12563.0 12611.2 12676.4 12783.7 12887.7 2727.7 2730.1 2739.8 2744.1 2753.9 69279.7 69818.3 69992.7 70245.0 71686.3 11730.3 12180.1 12322.4 12337.4 12525.7 22432.8 23017.4 23227.3 23271.4 23362.2 6266.9 6424.1 6473.2 6508.3 6528.3 2999.1 3025.0 3056.3 3059.2 3063.6 3661.1 3727.4 3730.9 3763.1 3775.9 674.2 680.6 680.9 681.8 683.5 604.9 615.4 616.6 626.2 629.8 9286.7 9312.9 9824.6 10467.5 10840.1 578.7 580.9 586.3 587.6 604.8 4434.1 4478.3 4498.6 4507.9 4539.5 60745.7 60746.7 61668.4 62056.7 62686.4 55008.4 55448.0 56006.7 56275.7 56431.7 51099.5 51706.7 51963.5 52004.0 52207.5 8864.6 9117.7 9177.2 9351.3 9549.5 28282.0 28658.9 28691.3 28790.9 29361.9 33263.0 33270.3 33622.5 33850.7 34030.8 11189.4 11237.9 11287.2 11437.3 11457.0 12417.3 12680.1 12707.8 12823.2 13045.6 11723.6 11862.4 11929.8 12024.6 12120.5 11589.8 11697.5 11776.4 11808.1 11808.6 11285.2 11307.7 11370.9 11406.7 11455.0 9067.5 9104.0 9121.5 9648.3 9687.1 11370.8 11909.4 11930.2 11941.5 12030.3 08:50:42 INFO - PID 32751 | -------- Summary: end -------- 08:50:42 INFO - PID 32751 | 08:50:43 INFO - TEST-INFO | 32751: exit 0 08:50:43 INFO - TEST-OK | dromaeo_css | took 1120181ms 08:50:43 INFO - TEST-START | kraken 08:50:43 INFO - operating with platform_type : linux_ 08:50:43 INFO - Initialising browser for kraken test... 08:50:43 INFO - TEST-INFO | started process 708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQxdShy/profile http://localhost:50831/getInfo.html) 08:50:47 INFO - PID 708 | __metrics Screen width/height:1600/1200 08:50:47 INFO - PID 708 | colorDepth:24 08:50:47 INFO - PID 708 | Browser inner width/height: 1024/695 08:50:47 INFO - PID 708 | __metrics 08:50:49 INFO - TEST-INFO | 708: exit 0 08:50:49 INFO - Browser initialized. 08:50:49 INFO - Running cycle 1/1 for kraken test... 08:50:49 INFO - TEST-INFO | started process 885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQxdShy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:01 INFO - PID 885 | RSS: Main: 160071680 08:51:01 INFO - PID 885 | 08:51:03 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50831/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:04 INFO - PID 885 | RSS: Main: 165683200 08:51:04 INFO - PID 885 | 08:51:07 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50831/tests/kraken/driver.html?testName=audio-dft) 08:51:08 INFO - PID 885 | RSS: Main: 164487168 08:51:08 INFO - PID 885 | 08:51:11 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50831/tests/kraken/driver.html?testName=audio-fft) 08:51:11 INFO - PID 885 | RSS: Main: 160616448 08:51:11 INFO - PID 885 | 08:51:13 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50831/tests/kraken/driver.html?testName=audio-oscillator) 08:51:14 INFO - PID 885 | RSS: Main: 161894400 08:51:14 INFO - PID 885 | 08:51:16 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50831/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:17 INFO - PID 885 | RSS: Main: 162103296 08:51:17 INFO - PID 885 | 08:51:20 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50831/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:21 INFO - PID 885 | RSS: Main: 167690240 08:51:21 INFO - PID 885 | 08:51:24 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50831/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:25 INFO - PID 885 | RSS: Main: 165351424 08:51:25 INFO - PID 885 | 08:51:28 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50831/tests/kraken/driver.html?testName=json-parse-financial) 08:51:28 INFO - PID 885 | RSS: Main: 166027264 08:51:28 INFO - PID 885 | 08:51:30 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50831/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:30 INFO - PID 885 | RSS: Main: 166682624 08:51:30 INFO - PID 885 | 08:51:32 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:33 INFO - PID 885 | RSS: Main: 166432768 08:51:33 INFO - PID 885 | 08:51:35 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:51:36 INFO - PID 885 | RSS: Main: 166797312 08:51:36 INFO - PID 885 | 08:51:38 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:51:39 INFO - PID 885 | RSS: Main: 166891520 08:51:39 INFO - PID 885 | 08:51:42 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:51:43 INFO - PID 885 | RSS: Main: 167264256 08:51:43 INFO - PID 885 | 08:51:45 INFO - PID 885 | Cycle 1(1): loaded http://localhost:50831/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50831/tests/kraken/driver.html?testName=ai-astar) 08:51:45 INFO - PID 885 | RSS: Main: 168292352 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | __start_tp_report 08:51:45 INFO - PID 885 | _x_x_mozilla_page_load 08:51:45 INFO - PID 885 | _x_x_mozilla_page_load_details 08:51:45 INFO - PID 885 | |i|pagename|runs| 08:51:45 INFO - PID 885 | |0;ai-astar;104;111;111;111;111;111;112;112;112;112 08:51:45 INFO - PID 885 | |1;audio-beat-detection;153;130;135;165;129;128;123;123;147;124 08:51:45 INFO - PID 885 | |2;audio-dft;165;164;165;163;166;167;174;164;164;164 08:51:45 INFO - PID 885 | |3;audio-fft;75;77;75;118;75;80;75;75;95;76 08:51:45 INFO - PID 885 | |4;audio-oscillator;83;82;99;84;84;84;101;84;83;107 08:51:45 INFO - PID 885 | |5;imaging-gaussian-blur;115;114;115;115;114;114;113;115;115;114 08:51:45 INFO - PID 885 | |6;imaging-darkroom;150;150;150;152;151;150;150;151;150;150 08:51:45 INFO - PID 885 | |7;imaging-desaturate;94;95;95;95;94;95;94;94;94;94 08:51:45 INFO - PID 885 | |8;json-parse-financial;52;53;52;54;53;53;54;55;58;54 08:51:45 INFO - PID 885 | |9;json-stringify-tinderbox;55;56;56;56;58;57;55;57;56;56 08:51:45 INFO - PID 885 | |10;stanford-crypto-aes;82;82;82;85;90;92;83;83;83;81 08:51:45 INFO - PID 885 | |11;stanford-crypto-ccm;135;144;138;135;131;143;136;130;187;133 08:51:45 INFO - PID 885 | |12;stanford-crypto-pbkdf2;181;210;192;203;204;196;191;208;196;209 08:51:45 INFO - PID 885 | |13;stanford-crypto-sha256-iterative;77;72;74;71;72;70;75;71;72;74 08:51:45 INFO - PID 885 | __end_tp_report 08:51:45 INFO - PID 885 | __start_cc_report 08:51:45 INFO - PID 885 | _x_x_mozilla_cycle_collect,830 08:51:45 INFO - PID 885 | __end_cc_report 08:51:45 INFO - PID 885 | __startTimestamp1494172305598__endTimestamp 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | ------- Summary: start ------- 08:51:45 INFO - PID 885 | Number of tests: 14 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.41 (2.2%) stddev-sans-first:0.53 08:51:45 INFO - PID 885 | Values: 104.0 111.0 111.0 111.0 111.0 111.0 112.0 112.0 112.0 112.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:132.50 stddev:14.46 (10.9%) stddev-sans-first:13.92 08:51:45 INFO - PID 885 | Values: 153.0 130.0 135.0 165.0 129.0 128.0 123.0 123.0 147.0 124.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.17 (1.9%) stddev-sans-first:3.35 08:51:45 INFO - PID 885 | Values: 165.0 164.0 165.0 163.0 166.0 167.0 174.0 164.0 164.0 164.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:14.04 (18.6%) stddev-sans-first:14.66 08:51:45 INFO - PID 885 | Values: 75.0 77.0 75.0 118.0 75.0 80.0 75.0 75.0 95.0 76.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:84.00 stddev:9.36 (11.1%) stddev-sans-first:9.67 08:51:45 INFO - PID 885 | Values: 83.0 82.0 99.0 84.0 84.0 84.0 101.0 84.0 83.0 107.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 08:51:45 INFO - PID 885 | Values: 115.0 114.0 115.0 115.0 114.0 114.0 113.0 115.0 115.0 114.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:51:45 INFO - PID 885 | Values: 150.0 150.0 150.0 152.0 151.0 150.0 150.0 151.0 150.0 150.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:51:45 INFO - PID 885 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 94.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.75 (3.2%) stddev-sans-first:1.73 08:51:45 INFO - PID 885 | Values: 52.0 53.0 52.0 54.0 53.0 53.0 54.0 55.0 58.0 54.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.87 08:51:45 INFO - PID 885 | Values: 55.0 56.0 56.0 56.0 58.0 57.0 55.0 57.0 56.0 56.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.71 (4.5%) stddev-sans-first:3.84 08:51:45 INFO - PID 885 | Values: 82.0 82.0 82.0 85.0 90.0 92.0 83.0 83.0 83.0 81.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:137.00 stddev:16.73 (12.2%) stddev-sans-first:17.60 08:51:45 INFO - PID 885 | Values: 135.0 144.0 138.0 135.0 131.0 143.0 136.0 130.0 187.0 133.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:203.50 stddev:9.42 (4.6%) stddev-sans-first:7.40 08:51:45 INFO - PID 885 | Values: 181.0 210.0 192.0 203.0 204.0 196.0 191.0 208.0 196.0 209.0 08:51:45 INFO - PID 885 | 08:51:45 INFO - PID 885 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:2.15 (2.9%) stddev-sans-first:1.66 08:51:45 INFO - PID 885 | Values: 77.0 72.0 74.0 71.0 72.0 70.0 75.0 71.0 72.0 74.0 08:51:45 INFO - PID 885 | -------- Summary: end -------- 08:51:45 INFO - PID 885 | 08:51:46 INFO - TEST-INFO | 885: exit 0 08:51:46 INFO - TEST-OK | kraken | took 63779ms 08:51:46 INFO - SUITE-END | took 1183s 08:51:47 INFO - Completed test suite (00:19:44) 08:51:47 INFO - javascript benchmark 08:51:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6630.726065911411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2742.9039983600574, 2743.3827388837503, 2751.944961100778, 2784.3735159589082, 2788.2750484873927, 5233.084210263199, 5340.759665815038, 5374.543163831074, 5413.864653383657, 5437.211604317376, 5336.252924590561, 5351.438098999607, 5352.652077614952, 5438.483344082316, 5482.451754824516, 4375.212461756899, 4710.114408312318, 4768.618510519167, 4773.260144677572, 4803.61571074315, 4808.495108013661, 4849.102915960559, 4873.707577545341, 4878.365812444377, 4924.753762311888, 4686.507916668735, 4759.143354196243, 4770.8330208442885, 4791.568758811689, 4792.712437253741, 4805.063012712522, 4821.204501257288, 4826.1795494765975, 4837.32277481153, 4845.9030819383415, 4746.928796068062, 4750.358701575277, 4777.092352453057, 4787.257975013878, 4816.373871396731, 5230.581553475713, 5309.309789727349, 5410.810621628263, 5413.53984911283, 5465.59008074396, 5701.258836351248, 5702.6293290935955, 5709.457601527848, 5717.571182161355, 5728.369879313273, 5714.914276285859, 5720.08478643415, 5722.256106706143, 5727.455891690324, 5753.626014309057, 5311.070562651521, 5350.759215835296, 5359.490848369399, 5362.302900622972, 5363.06146424378, 5830.82507524775, 5848.707564621752, 5872.559558033165, 5888.587798854039, 5891.3814049525035, 5592.2730045094695, 5592.636478628876, 5697.888911662269, 5785.971070144622, 5806.535477161817, 5806.44838740319, 5808.825735227865, 5821.912671309934, 5844.824655260349, 5886.0, 5746.569007324468, 5755.625884317506, 5766.077427611562, 5766.452187042224, 5780.942190578125, 5628.296462942132, 5719.857003574861, 5725.627834190765, 5731.570132240098, 5776.855578610568, 4774.665773395898, 4806.519348065235, 4808.230683090689, 4808.735519546459, 4809.398825146856, 4114.670826333886, 4170.436991006236, 4170.645495132948, 4232.217039847638, 4250.978745106255, 4969.577585905238, 4971.055499455092, 4973.726445045557, 4982.078315511642, 5011.498850114959, 5856.414358564195, 5896.587238893322, 5901.468867801918, 5919.704014799243, 5953.880922381528, 4847.151748444078, 4901.117798796251, 4945.752712364368, 4964.826231081895, 5006.123928312531, 5235.502627250406, 5243.632945693841, 5244.527992480619, 5249.553787927993, 5300.92048619271, 5464.098423760035, 5464.863378415572, 5470.261514695465, 5476.808311709071, 5477.20580515831, 5694.117411801178, 5784.971075144597, 5789.710514474344, 5903.114532820111, 5915.940840591539, 5335.573154147736, 5339.626226164131, 5341.35903691544, 5351.732413379394, 5358.651687640291, 5624.0, 5641.858953526031, 5657.349404818498, 5657.4059723728415, 5675.858103547444, 5649.915251271316, 5749.166370876116, 5754.798582049776, 5765.365809761007, 5774.9133762994425, 5492.670439773627, 5549.306336707911, 5569.053260945568, 5585.162225666182, 5590.664560126405, 5493.697846618475, 5562.388137304974, 5565.693886836263, 5569.415211402745, 5585.3297604287745, 5426.186072089218, 5531.474509921551, 5642.097264437671, 5671.461211184931, 5713.342965559014, 5709.20071190042, 5715.171300161536, 5720.74256658443, 5726.112452569859, 5726.828195154152, 5431.619786614899, 5516.696581688046, 5543.223948647274, 5560.110382338807, 5571.164325351229], "value": 5242.766547729199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.8138974561487, 746.2574738135554, 1031.798799234149, 1049.8215303398422, 1093.338530189235, 31331.843340783293, 32358.602346753603, 32367.352652946927, 32376.352472950526, 32382.19044523888, 29740.85129574349, 29801.105966820975, 30062.699373006264, 30216.697833021717, 30295.09114726562, 6304.716287767062, 6386.968065159667, 6508.9023664645065, 6965.164180298371, 6978.616176110312, 6805.115335006467, 6828.385445309921, 6851.657417129149, 6868.793936181923, 6889.5521791083665, 6848.3494068063455, 6894.345037221481, 6896.0, 6909.550879192861, 6935.306469353075, 6884.105066341369, 6888.311168883121, 6897.931020689779, 6908.654567271667, 6917.55035922666, 6810.353016463428, 6904.4131248843905, 6906.930930690679, 6908.516403851682, 6921.134858142732, 30530.084097477113, 30628.0, 30809.07572772798, 30830.0, 30919.690803091908, 2940.5148150555133, 2952.7785416093666, 2977.151511819121, 2977.985110074457, 2978.225661328049, 23882.880585596962, 23965.640515392282, 24033.27900162998, 24045.27864164078, 24056.0, 2747.148384000966, 2755.531559634867, 2774.334159801653, 2788.442311537701, 2794.315392728774, 145015.0, 145088.2745586276, 145745.0, 146188.0, 146834.0, 36256.91229263126, 38834.417483737765, 38948.610513895066, 38969.41545876814, 40146.19707605831, 39937.600623993385, 40042.399364009565, 40101.799491002355, 43092.35361469581, 43958.42810651892, 10724.0, 10831.67504974852, 10837.18721095921, 10847.728806779895, 10852.077573406192, 8341.708040218564, 8345.290650294794, 8398.580070996426, 8424.705135320357, 8443.240108390151, 12652.683682908, 12662.746745065047, 12686.429110690042, 12762.170458920325, 12910.9354453229, 5294.811085136587, 5299.258103865462, 5325.813596524181, 5364.597655175878, 5463.606780271006, 876.3514998900768, 905.4341036851968, 911.1480765484293, 911.4850109688005, 935.2845073518764, 19578.412647620593, 21106.683399749018, 21205.893970530047, 21402.357929262147, 21457.46356341073, 944.8535477001076, 962.4417837654144, 963.7879666473365, 966.6085235479642, 986.2849434160177, 10539.57841686324, 11097.1677124216, 11187.216894817448, 11196.832047519294, 11201.775964480828, 181974.0, 182519.0, 183089.0, 183449.0, 183534.0, 40163.59836401657, 40408.39387409191, 40447.393289100684, 40567.59432405697, 40587.59412405838, 1172.3376292394769, 1201.759648070407, 1202.6452196602024, 1205.873383294759, 1215.1979693402488, 19495.317663881695, 19596.118174681887, 20154.596908061463, 20974.58050838944, 21108.894455527625, 29969.70030299669, 30008.0, 30021.69978300189, 30063.398732025675, 30132.0, 144300.51942987563, 144357.0, 145213.27393362965, 145257.0, 145408.0, 27678.308042299104, 28596.142115736562, 28736.856315718287, 29052.128436146948, 29087.0, 35296.647033529334, 35325.470117947734, 35428.64571354356, 35452.64547354494, 35546.11134721652, 26452.0, 26762.31659459548, 27287.317817054733, 27641.723582763916, 28330.43339133247, 26478.86760566185, 27291.376547924, 27341.179764607095, 27503.31241718973, 28073.438531228854, 29368.706312936596, 29412.0, 29494.0, 29586.704132959258, 29612.703872960996, 25376.74623253744, 25978.220653380427, 26327.34181645474, 26342.0, 26681.7331826687, 19848.40454786359, 21562.13751449987, 21618.13527458884, 21658.458538536663, 21729.565408692055], "value": 14093.021136133824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.8190478094418, 425.4192928629542, 431.35727765629224, 443.142519225299, 447.92161371759954, 16678.916605416973, 16876.0718160501, 17360.652786944283, 17493.91253043733, 17647.823521764778, 18300.54248643781, 18327.90836045818, 18413.263469461206, 18466.153384661528, 18498.445046648587, 5353.973230133854, 5440.564754819605, 5508.394076651565, 5548.306461692288, 5559.249501317331, 5408.188771684259, 5461.508464238238, 5485.573750824794, 5495.972520137394, 5496.203050557687, 5287.0, 5454.509094181523, 5474.808381706641, 5483.341998960111, 5505.614606977513, 5342.91985620216, 5380.704061276648, 5393.6763794172275, 5408.35099788024, 5429.4570542945785, 4710.929336059962, 4906.31311616374, 4915.901681966377, 4959.752012399365, 4975.278584605248, 20497.38507844752, 20916.0, 20979.790202097935, 21052.947352632305, 21196.682049769264, 1558.345494892148, 1566.9736322708643, 1569.3330334607747, 1587.5078725595104, 1591.0851260525244, 14167.929160354131, 14592.489262875748, 14623.415063397451, 14656.560303190921, 14795.038322509003, 2029.3201777404588, 2040.2349119080345, 2093.8534302598823, 2098.26560703754, 2105.357865850915, 90061.54969225178, 92056.0, 92204.53897730468, 92378.0, 93179.53410232974, 10687.198460115522, 10904.400257985728, 10958.945205273923, 10999.450027498593, 11116.55533778656, 15222.847771522365, 15238.390464381522, 15266.542003739905, 15276.770848437282, 15279.694406111816, 6312.8421789454715, 6433.260175079832, 6560.3111673273615, 6637.734490620418, 6651.301613330627, 5627.212190293362, 5657.886842263131, 5766.163906233573, 5774.393688662714, 5792.855178620568, 6690.163729533809, 6760.391564759097, 6875.3812156906115, 6932.896006559805, 6935.549189302679, 1998.280618977167, 2013.959720805605, 2023.9392818215476, 2030.0357330268005, 2117.2272120676153, 844.3371953016853, 881.1012766977647, 881.6561540999015, 884.8318819424288, 906.7325139083986, 16128.596785080232, 16197.919010405109, 16483.258253378626, 16825.15874206285, 16909.83090169107, 854.5001174313096, 872.445996792029, 885.0795173020116, 897.8473659477904, 900.1808354397467, 8652.610632521551, 9089.181973622406, 9225.630974760934, 9264.7683807904, 9337.626494940127, 340989.0, 344278.0, 358570.0, 359414.0, 361116.0, 74362.62818685872, 74379.62810185914, 78027.60986195033, 79462.0, 80185.19814801894, 1016.3089099412471, 1031.896810318962, 1056.1497994114811, 1061.1616822709973, 1063.723431907694, 14099.577012689635, 14121.152730836182, 14295.57113286603, 14318.498852540111, 14959.40162393492, 37051.81474092612, 37120.0, 37601.0, 37654.62345376511, 37917.0, 48991.26513102378, 49069.263961041324, 49187.75406122946, 49502.0, 49843.50156498534, 8002.479838810459, 8121.4721043132, 8125.79685507867, 8260.0, 8337.83324333522, 12567.560135395583, 12617.873821262037, 12705.42825572833, 12728.490860365482, 12894.548690795777, 10304.484775761332, 10416.32293900894, 10767.569297228023, 10799.67600971972, 10806.405647689453, 10177.796444071226, 10633.096186824207, 10688.625898093529, 10776.0, 10954.178436617127, 11061.170412219277, 11122.777544449227, 11159.442027898735, 11361.4887330072, 11695.473703683525, 8001.079875814123, 8031.116577176623, 8073.111957684532, 8128.715494957648, 8179.263866252066, 10111.24165687591, 10703.143748500257, 10751.301165424222, 10777.46112694378, 11034.0], "value": 8619.719176710092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.333459931637, 1301.5509649171038, 1305.8237137986368, 1305.9412326445306, 1307.0, 9110.134537218963, 9338.486383248919, 9492.382995105321, 9575.473348965812, 9943.850842237354, 9614.615415383376, 9812.264080193978, 9836.50817459126, 9837.704868853927, 9844.40933543988, 2156.417767202858, 2197.0, 2200.7689192634784, 2202.2072054060527, 2208.436848603612, 2003.5692326149874, 2071.1508281604547, 2074.802893725094, 2076.262926661036, 2080.6670932650704, 2163.697082408464, 2180.9563808723815, 2207.2164381644448, 2209.8784566848817, 2222.9777702223014, 2072.585482903418, 2102.7161333219974, 2107.2729908181655, 2116.555523340093, 2131.531063166101, 1953.6581098307881, 2001.4996250937265, 2030.6446371885008, 2168.0243890249294, 2177.9782202178094, 9692.46691431971, 9737.172340351079, 9788.608455661764, 9804.852927206097, 9815.165710914582, 5357.892842143136, 5559.555235581184, 5580.0, 5580.190872323531, 5594.552435805126, 3241.773075884689, 3470.288590838872, 3484.6689564491335, 3550.6449355064547, 3574.2315402188656, 1023.96416125436, 1050.8371202463554, 1090.7818436312689, 1102.5589764094345, 1107.7119948813368, 13304.467821287233, 13338.599842004756, 13445.0, 13551.59345219645, 13563.050586458952, 4484.349769283435, 4484.955150448453, 4727.0, 4889.657723959289, 4903.730294833818, 10084.142847857867, 10093.192544596415, 10130.98690130981, 10138.493075346203, 10166.339187952759, 5178.689278643294, 5181.378234611795, 5184.844454666366, 5185.377754669464, 5194.220866869924, 4787.497312782108, 4819.469858315582, 4850.175470170079, 4866.099771542205, 4945.3571035765835, 3695.131644063643, 3808.447775072654, 3833.3866581347406, 3893.299206142865, 3915.0603855075146, 1119.1494464207099, 1119.3843386137755, 1122.405125283601, 1128.8983991440646, 1134.6142311614092, 711.1075600121814, 739.3530660671912, 743.3384287983699, 744.151667099507, 751.9473636845369, 5530.087535556669, 5570.3315602128005, 5641.069223578145, 5674.631148975303, 5737.942620573741, 533.8718707510247, 552.9447055294519, 553.720371212535, 555.2781384200523, 557.8981511514726, 3323.1858194742445, 3336.3994480993656, 3426.7087297579487, 3658.2683463307444, 3932.075962148893, 12027.639170824714, 12331.445084971198, 12353.258804471761, 12599.118061735773, 12628.179168354027, 11844.348560829238, 12280.0, 12317.0, 12331.69170770738, 12350.320732359627, 7191.280871912767, 7291.4531410144455, 7400.148982866932, 7458.850822983619, 7480.139783924918, 5700.287464066992, 5761.337446193574, 5782.797602083907, 5971.970140149271, 5983.431574000463, 10941.726456838644, 11004.614838480615, 11061.668149955514, 11125.721856953642, 11145.665630031112, 11139.665810025712, 11267.323960562393, 11368.886311136783, 11465.656030319104, 11583.957443830095, 7201.13586369618, 7345.926540734525, 7351.742689005859, 7368.115826100902, 7388.704451822082, 9056.230220431336, 9184.448933064037, 9240.983491816029, 9245.445273283625, 9255.074492550692, 7536.171021187555, 7659.234076592519, 7700.730474433368, 7807.843843123219, 8030.558319292495, 7814.882776758467, 7859.960700196462, 7883.487573307717, 7944.404169687181, 7957.681692732457, 7038.2609825969585, 7163.10461192351, 7175.784726458214, 7210.459215558749, 7214.314640109181, 5109.693418394908, 5387.81142660005, 5389.622726409114, 5542.3626282977975, 5668.291463567054, 5252.107141785982, 5265.420803711512, 5347.919781203363, 5508.752106155152, 5536.252605898313], "value": 4529.257680752153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.1434428887105, 374.0032812554542, 378.4229050697684, 386.19671084144983, 387.95538513071, 5531.225628412026, 5635.126555383912, 5696.857578560538, 5730.885382292352, 5735.340435849873, 5457.699826509541, 5545.750441230144, 5549.417311182328, 5550.888982220364, 5560.833175004746, 4151.522574903887, 4156.667466602665, 4158.438610787535, 4167.229062623424, 4172.18642364739, 4088.6729061674996, 4147.377893316012, 4150.418941348214, 4184.832606695729, 4194.748315101088, 4121.690873184508, 4126.504819421659, 4142.109446469009, 4148.191102734968, 4156.792160391983, 4144.896377590554, 4168.2080404723, 4180.707350485467, 4181.6445602124, 4183.832646694129, 3562.3943929532043, 3611.56661200655, 3630.5824830144606, 3631.328204282216, 3655.3968595181764, 5453.4273901240595, 5458.263134476874, 5470.589705772043, 5483.698396588186, 5528.170774383834, 4885.902281954341, 4928.334674818925, 4930.605551555867, 4931.950680493185, 4951.876203094951, 5793.13103034544, 5855.531557475391, 5918.467337939606, 5957.761689532414, 5963.940360596382, 4060.47213862199, 4066.79666016698, 4073.2260870434525, 4080.327385562461, 4095.467589213413, 6120.051392034197, 6266.091416744592, 6275.403836635513, 6311.684415779238, 6343.270523889765, 4116.341385378325, 4136.91726165475, 4147.751134931914, 4156.667466602665, 4167.229062623424, 4183.853565125206, 4193.18232944579, 4195.97902010488, 4213.747175169499, 4224.218519573888, 4757.976210118927, 4857.781399837016, 4879.170541008037, 4893.388326459192, 4895.363602731622, 5903.822885313448, 5921.644701317935, 5926.348101708809, 5927.911081333784, 5949.434803693643, 1419.6025112968384, 1446.9148138895828, 1452.8256609206962, 1453.7964684943904, 1454.403694485256, 956.9186619137312, 969.8302797010494, 1114.2089116727052, 1120.3781901045, 1136.9147313951487, 5074.923876141861, 5075.187969924795, 5096.337476128079, 5100.387953445536, 5162.845114646567, 6108.664023478751, 6123.295820980644, 6146.231721034871, 6148.262208535004, 6161.507079433634, 4959.528844759742, 5096.592272618182, 5133.435322114565, 5176.870578235499, 5198.194279886624, 3263.4452143135723, 3264.2981758921946, 3286.4905939579403, 3297.7196938260035, 3298.8845390411702, 5505.256790333334, 5695.345035320991, 5713.942860571341, 5738.799142030009, 5784.1902133701315, 6306.968465157736, 6310.337414571496, 6356.841078973062, 6359.90460143089, 6369.172007638977, 5710.857228569319, 5720.2849643794525, 5744.626599271034, 5749.511291540182, 5751.0, 5867.589268751147, 6153.30801519085, 6189.442950134509, 6207.875842483216, 6214.483134330422, 5869.207656966255, 6097.969510152421, 6106.1146133811235, 6132.141500190066, 6151.138840562415, 5681.545476361964, 5731.188759474902, 5744.856378590569, 5750.942490575041, 5767.769289228384, 4126.401671757639, 4164.8334066637, 4173.52004519472, 4176.60322269384, 4180.080382316008, 6101.328853826164, 6195.752169913153, 6201.782937597162, 6231.813045608639, 6255.78104766331, 5931.822045338647, 5967.164596956516, 5987.6108052976415, 5995.5803093783015, 5997.190379298913, 5862.530997520274, 5924.674142922181, 5952.285725712942, 5987.461128498456, 6020.759169633166, 5800.274965629296, 5805.216295800182, 5852.473277404883, 5853.736581853912, 5865.648061116176, 6023.548233882389, 6024.1265016573225, 6029.065494848305, 6046.516278697782, 6082.513398928164, 5713.971430142823, 5801.883962320814, 5855.560832937632, 5858.2677165354335, 5862.325832529314], "value": 4421.682324258207, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.1763668782681, 758.2569082299347, 766.8236305649704, 776.4642396746248, 776.941729370297, 12531.624051278453, 12944.0, 13158.868411315883, 13657.248851313174, 13661.248631325274, 15017.774733379008, 15835.604109897258, 15843.049417034987, 15875.761863572056, 15925.522234332988, 875.7898104454932, 902.5938327752505, 902.6885724425063, 903.8824952756132, 906.959186836594, 903.6520939438298, 914.6204325205032, 914.6661468563992, 916.5554705967601, 916.5921165081542, 957.8898426680917, 965.5172413793103, 965.6378857928277, 966.2801213096253, 970.0299700299701, 948.8434408322619, 949.9382540134869, 953.3136141977765, 956.416585882611, 957.8850537935457, 702.9367356937901, 703.9155301363818, 703.9155301363818, 706.5689929143218, 708.5111273221461, 14296.428142874272, 14298.64253393663, 15012.549623511311, 15068.397264109532, 15172.924135379362, 15677.0, 15776.368945242291, 16039.358425663077, 16135.596610084724, 16223.594410139724, 12563.0, 12611.180273282207, 12676.366181690879, 12783.744325113446, 12887.67780805478, 2727.6726792784993, 2730.0581299451655, 2739.8082134250612, 2744.0807329544627, 2753.8623068846678, 69279.65360173218, 69818.3018169817, 69992.65003674949, 70245.0, 71686.28313716849, 11730.296182229093, 12180.147389682637, 12322.445489952974, 12337.444814983348, 12525.749485010248, 22432.775672243395, 23017.42456438569, 23227.3031809046, 23271.41821454477, 23362.182323618592, 6266.874662506724, 6424.068510066014, 6473.190851143607, 6508.251551071593, 6528.314526974695, 2999.145243605562, 3024.9546256806166, 3056.2512184514935, 3059.189314831571, 3063.5557844112477, 3661.1213308806227, 3727.366347720894, 3730.9440358394645, 3763.1344790698295, 3775.905602359963, 674.1539368093012, 680.5678394219706, 680.9216940051858, 681.8090934538337, 683.4976292425064, 604.9153118563405, 615.4122812713847, 616.6238594457377, 626.2422468812697, 629.8473792958874, 9286.674966376144, 9312.90687093134, 9824.557894894748, 10467.528961196764, 10840.13278937683, 578.6932925549465, 580.9448102430347, 586.2583831453215, 587.5593305021234, 604.7550741949517, 4434.091011342667, 4478.305862591304, 4498.550144985541, 4507.932381014221, 4539.500654927955, 60745.69627151924, 60746.69626651927, 61668.383316167165, 62056.68971655203, 62686.373136268965, 55008.449915501136, 55448.0, 56006.719966399905, 56275.71862140663, 56431.71784141135, 51099.48900511096, 51706.74146629318, 51963.48036519662, 52004.0, 52207.47792522102, 8864.556772161237, 9117.680881169128, 9177.174054335143, 9351.298652600946, 9549.47477888695, 28282.0, 28658.85670571634, 28691.28271793222, 28790.856045719636, 29361.85319073391, 33263.0, 33270.33459330751, 33622.49566256557, 33850.66149338475, 34030.82984585061, 11189.384583847966, 11237.887621124011, 11287.153463490107, 11437.313761174357, 11457.0, 12417.31704756247, 12680.112392132462, 12707.809382859079, 12823.230606163661, 13045.608631741063, 11723.589674361356, 11862.406879656155, 11929.821052684043, 12024.579139730067, 12120.515179392725, 11589.768204636028, 11697.532098715956, 11776.352300623548, 11808.055355571705, 11808.645740627795, 11285.21003529745, 11307.660770176908, 11370.94314528422, 11406.657800266004, 11455.0, 9067.455952642862, 9104.0, 9121.543922803967, 9648.276379271443, 9687.128158465772, 11370.772584548427, 11909.40452977365, 11930.164888457724, 11941.522339106687, 12030.338331391857], "value": 6662.908970386109, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1549.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 135.0, 165.0, 129.0, 128.0, 123.0, 123.0, 147.0, 124.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 163.0, 166.0, 167.0, 174.0, 164.0, 164.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 118.0, 75.0, 80.0, 75.0, 75.0, 95.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 99.0, 84.0, 84.0, 84.0, 101.0, 84.0, 83.0, 107.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 113.0, 115.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 152.0, 151.0, 150.0, 150.0, 151.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 54.0, 53.0, 53.0, 54.0, 55.0, 58.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 58.0, 57.0, 55.0, 57.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 85.0, 90.0, 92.0, 83.0, 83.0, 83.0, 81.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 144.0, 138.0, 135.0, 131.0, 143.0, 136.0, 130.0, 187.0, 133.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 210.0, 192.0, 203.0, 204.0, 196.0, 191.0, 208.0, 196.0, 209.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 72.0, 74.0, 71.0, 72.0, 70.0, 75.0, 71.0, 72.0, 74.0], "value": 72.8, "unit": "score"}]}]} 08:51:47 INFO - Return code: 0 08:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:51:47 INFO - # TBPL SUCCESS # 08:51:47 INFO - Running post-action listener: _resource_record_post_action 08:51:47 INFO - [mozharness: 2017-05-07 15:51:47.385908Z] Finished run-tests step (success) 08:51:47 INFO - Running post-run listener: _resource_record_post_run 08:51:47 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 143360; Write bytes: 350466048; Read time: 1540; Write time: 216520 08:51:47 INFO - TinderboxPrint: CPU usage
13.3% 08:51:47 INFO - TinderboxPrint: I/O read bytes / time
143,360 / 1,540 08:51:47 INFO - TinderboxPrint: I/O write bytes / time
350,466,048 / 216,520 08:51:47 INFO - TinderboxPrint: CPU idle
8,297.7 (86.7%) 08:51:47 INFO - TinderboxPrint: CPU user
1,215.8 (12.7%) 08:51:47 INFO - TinderboxPrint: Swap in / out
0 / 0 08:51:47 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 96522240; Read time: 0; Write time: 88152 08:51:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 253943808; Read time: 220; Write time: 128368 08:51:48 INFO - Running post-run listener: _upload_blobber_files 08:51:48 INFO - Blob upload gear active. 08:51:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:51:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:51:48 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'] 08:51:48 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 08:51:48 INFO - (blobuploader) - INFO - Open directory for files ... 08:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:49 INFO - (blobuploader) - INFO - Done attempting. 08:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:51:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:50 INFO - (blobuploader) - INFO - Done attempting. 08:51:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:51:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:52 INFO - (blobuploader) - INFO - Done attempting. 08:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:51:53 INFO - (blobuploader) - INFO - Done attempting. 08:51:53 INFO - (blobuploader) - INFO - Iteration through files over. 08:51:53 INFO - Return code: 0 08:51:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:51:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:51:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dbe15373fca5bd3fc2c507162b1cc933032842b2dfd330239f06db4fb9871060d74b597dfa6d16f74b070edceabcdf6dbbf62b7771088d2290ab503dbba377c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdab49672e9edd89fbf36adf97eb130d4b3688d8a50f4cdddc72aec7a36781a782974f8856da824081ba3f6ba732b7e4175321d5efeeb2fe2a6b6b494f6422bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c04724cd18c6621461d54cb19e3844ceb115df6c860c3f8b4b17025653e0c10687c055f24792a0fe4bb5d89443b0de5081a94eba05cecefcdcf038f0ec54f2eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/283f27d38cd316e06875ef8e199080a2294ec725b41aa1c2deeb7c8cfd7639c48764257ff5c7f9099dcca262ee4c0a68da777f1f72a6589d8122fc3c41fc3d6d"} 08:51:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:51:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:51:53 INFO - Contents: 08:51:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dbe15373fca5bd3fc2c507162b1cc933032842b2dfd330239f06db4fb9871060d74b597dfa6d16f74b070edceabcdf6dbbf62b7771088d2290ab503dbba377c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdab49672e9edd89fbf36adf97eb130d4b3688d8a50f4cdddc72aec7a36781a782974f8856da824081ba3f6ba732b7e4175321d5efeeb2fe2a6b6b494f6422bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c04724cd18c6621461d54cb19e3844ceb115df6c860c3f8b4b17025653e0c10687c055f24792a0fe4bb5d89443b0de5081a94eba05cecefcdcf038f0ec54f2eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/283f27d38cd316e06875ef8e199080a2294ec725b41aa1c2deeb7c8cfd7639c48764257ff5c7f9099dcca262ee4c0a68da777f1f72a6589d8122fc3c41fc3d6d"} 08:51:53 INFO - Running post-run listener: copy_logs_to_upload_dir 08:51:53 INFO - Copying logs to upload dir... 08:51:53 INFO - mkdir: /builds/slave/test/build/upload/logs 08:51:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.681929 ========= master_lag: -0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-07 08:51:53.519080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 08:51:53.524086) ========= 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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dbe15373fca5bd3fc2c507162b1cc933032842b2dfd330239f06db4fb9871060d74b597dfa6d16f74b070edceabcdf6dbbf62b7771088d2290ab503dbba377c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdab49672e9edd89fbf36adf97eb130d4b3688d8a50f4cdddc72aec7a36781a782974f8856da824081ba3f6ba732b7e4175321d5efeeb2fe2a6b6b494f6422bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c04724cd18c6621461d54cb19e3844ceb115df6c860c3f8b4b17025653e0c10687c055f24792a0fe4bb5d89443b0de5081a94eba05cecefcdcf038f0ec54f2eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/283f27d38cd316e06875ef8e199080a2294ec725b41aa1c2deeb7c8cfd7639c48764257ff5c7f9099dcca262ee4c0a68da777f1f72a6589d8122fc3c41fc3d6d"} build_url:https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/TnmOe61uTsGv_v39-sqbQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5dbe15373fca5bd3fc2c507162b1cc933032842b2dfd330239f06db4fb9871060d74b597dfa6d16f74b070edceabcdf6dbbf62b7771088d2290ab503dbba377c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdab49672e9edd89fbf36adf97eb130d4b3688d8a50f4cdddc72aec7a36781a782974f8856da824081ba3f6ba732b7e4175321d5efeeb2fe2a6b6b494f6422bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c04724cd18c6621461d54cb19e3844ceb115df6c860c3f8b4b17025653e0c10687c055f24792a0fe4bb5d89443b0de5081a94eba05cecefcdcf038f0ec54f2eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/283f27d38cd316e06875ef8e199080a2294ec725b41aa1c2deeb7c8cfd7639c48764257ff5c7f9099dcca262ee4c0a68da777f1f72a6589d8122fc3c41fc3d6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-07 08:51:53.552749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:51:53.553089) ========= 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=826874ccc97bd7bf541b4875000001d5-1494159676.793584-1566972239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-07 08:51:53.633553) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 08:51:53.636920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-07 08:51:53.637242) ========= ========= Total master_lag: -0.13 =========