builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1493913759.51 results: success (0) revision: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.505969) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.506414) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.506706) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.527833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.528331) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 09:02:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-05-04 09:02:40 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.682684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.683022) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018364 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.739007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:39.739336) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a --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 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a --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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 09:02:40,946 truncating revision to first 12 chars 2017-05-04 09:02:40,946 Setting DEBUG logging. 2017-05-04 09:02:40,946 attempt 1/10 2017-05-04 09:02:40,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6d4525b5aaa8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 09:02:41,210 unpacking tar archive at: mozilla-central-6d4525b5aaa8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571347 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.324531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.324846) ========= script_repo_revision: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.325202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.325473) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 09:02:40.334954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-04 09:02:40.335283) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:41 INFO - MultiFileLogger online at 20170504 09:02:41 in /builds/slave/test 09:02:41 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 09:02:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:41 INFO - {'append_to_log': False, 09:02:41 INFO - 'base_work_dir': '/builds/slave/test', 09:02:41 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:02:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:41 INFO - 'branch': 'Firefox-Non-PGO', 09:02:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:41 INFO - 'config_files': ('talos/linux_config.py',), 09:02:41 INFO - 'default_actions': ('clobber', 09:02:41 INFO - 'read-buildbot-config', 09:02:41 INFO - 'download-and-extract', 09:02:41 INFO - 'populate-webroot', 09:02:41 INFO - 'create-virtualenv', 09:02:41 INFO - 'install', 09:02:41 INFO - 'run-tests'), 09:02:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:41 INFO - 'download_minidump_stackwalk': True, 09:02:41 INFO - 'download_symbols': 'ondemand', 09:02:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:41 INFO - 'gecko_profile': False, 09:02:41 INFO - 'gecko_profile_interval': 0, 09:02:41 INFO - 'installer_path': 'installer.exe', 09:02:41 INFO - 'log_level': 'info', 09:02:41 INFO - 'log_name': 'talos', 09:02:41 INFO - 'log_to_console': True, 09:02:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:41 INFO - 'opt_config_files': (), 09:02:41 INFO - 'pip_index': False, 09:02:41 INFO - 'suite': 'dromaeojs-e10s', 09:02:41 INFO - 'system_bits': '32', 09:02:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:41 INFO - 'title': 'talos-linux64-ix-064', 09:02:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:41 INFO - 'use_talos_json': True, 09:02:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:41 INFO - 'work_dir': 'build'} 09:02:41 INFO - [mozharness: 2017-05-04 16:02:41.644807Z] Running clobber step. 09:02:41 INFO - Running pre-action listener: _resource_record_pre_action 09:02:41 INFO - Running main action method: clobber 09:02:41 INFO - rmtree: /builds/slave/test/build 09:02:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:42 INFO - Running post-action listener: _resource_record_post_action 09:02:42 INFO - [mozharness: 2017-05-04 16:02:42.580521Z] Finished clobber step (success) 09:02:42 INFO - [mozharness: 2017-05-04 16:02:42.580620Z] Running read-buildbot-config step. 09:02:42 INFO - Running pre-action listener: _resource_record_pre_action 09:02:42 INFO - Running main action method: read_buildbot_config 09:02:42 INFO - Using buildbot properties: 09:02:42 INFO - { 09:02:42 INFO - "project": "", 09:02:42 INFO - "product": "firefox", 09:02:42 INFO - "who": "ffxbld@noreply.mozilla.org", 09:02:42 INFO - "installer_path": "public/build/target.tar.bz2", 09:02:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:02:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:02:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:02:42 INFO - "stage_platform": "linux64", 09:02:42 INFO - "basedir": "/builds/slave/test", 09:02:42 INFO - "buildnumber": 851, 09:02:42 INFO - "platform": "ubuntu64_hw", 09:02:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:02:42 INFO - "slavebuilddir": "test", 09:02:42 INFO - "taskId": "NhSmkhaHTPmhOmk4-0kDxA", 09:02:42 INFO - "branch": "mozilla-central", 09:02:42 INFO - "script_repo_revision": "production", 09:02:42 INFO - "revision": "6d4525b5aaa834ea4db8d8eab8087d86e34cf57a", 09:02:42 INFO - "slavename": "talos-linux64-ix-064", 09:02:42 INFO - "repo_path": "mozilla-central" 09:02:42 INFO - } 09:02:42 INFO - Finding installer, test and symbols from parent task. 09:02:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NhSmkhaHTPmhOmk4-0kDxA'}, attempt #1 09:02:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NhSmkhaHTPmhOmk4-0kDxA'}, attempt #1 09:02:43 INFO - Task dependencies: ZtpNGFJsTKe8QtQepxpBZQ 09:02:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ'}, attempt #1 09:02:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:02:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/test_packages.json 09:02:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip 09:02:43 INFO - Running post-action listener: _resource_record_post_action 09:02:43 INFO - [mozharness: 2017-05-04 16:02:43.952272Z] Finished read-buildbot-config step (success) 09:02:43 INFO - [mozharness: 2017-05-04 16:02:43.952489Z] Running download-and-extract step. 09:02:43 INFO - Running pre-action listener: _resource_record_pre_action 09:02:43 INFO - Running main action method: download_and_extract 09:02:43 INFO - mkdir: /builds/slave/test/build/tests 09:02: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')]} 09:02:43 INFO - trying https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json 09:02:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:02:44 INFO - Downloaded 986 bytes. 09:02:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:02:44 INFO - Using the following test package requirements: 09:02:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:02:44 INFO - u'common': [u'target.common.tests.zip'], 09:02:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:02:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:02:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:02:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:02:44 INFO - u'mozbase': [u'target.common.tests.zip'], 09:02:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:02:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:02:44 INFO - u'web-platform': [u'target.common.tests.zip', 09:02:44 INFO - u'target.web-platform.tests.zip'], 09:02:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:02:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:02:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip 09:02:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:02:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip into memory 09:02:45 INFO - Content-Length response header: 58436280 09:02:45 INFO - Bytes received: 58436280 09:02:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:02:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip 09:02:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:02:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.common.tests.zip into memory 09:02:56 INFO - Content-Length response header: 58436280 09:02:56 INFO - Bytes received: 58436280 09:03:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip 09:03:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:03:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.talos.tests.zip into memory 09:03:07 INFO - Content-Length response header: 14408809 09:03:07 INFO - Bytes received: 14408809 09:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:07 INFO - trying https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:03:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:03:08 INFO - Downloaded 58413936 bytes. 09:03:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:08 INFO - mkdir: /builds/slave/test/properties 09:03:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:08 INFO - Contents: 09:03:08 INFO - build_url:https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 09:03:08 INFO - Running post-action listener: _resource_record_post_action 09:03:08 INFO - Running post-action listener: set_extra_try_arguments 09:03:08 INFO - [mozharness: 2017-05-04 16:03:08.907081Z] Finished download-and-extract step (success) 09:03:08 INFO - [mozharness: 2017-05-04 16:03:08.907177Z] Running populate-webroot step. 09:03:08 INFO - Running pre-action listener: _resource_record_pre_action 09:03:08 INFO - Running main action method: populate_webroot 09:03:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:08 INFO - '--tppagecycles', 09:03:08 INFO - '7'], 09:03:08 INFO - 'tests': ['tsvgm']}}, 09:03:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['damp', 'tps']}, 09:03:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'tests': ['damp', 'tps']}, 09:03:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['dromaeo_dom']}, 09:03:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:03:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:03:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['a11yr', 09:03:08 INFO - 'ts_paint', 09:03:08 INFO - 'tpaint', 09:03:08 INFO - 'sessionrestore', 09:03:08 INFO - 'sessionrestore_no_auto_restore', 09:03:08 INFO - 'tabpaint']}, 09:03:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:03:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:03:08 INFO - 'bloom_basic_ref']}, 09:03:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['tsvgx', 09:03:08 INFO - 'tsvgr_opacity', 09:03:08 INFO - 'tart', 09:03:08 INFO - 'tscrollx', 09:03:08 INFO - 'cart', 09:03:08 INFO - 'tsvg_static']}, 09:03:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:08 INFO - 'tsvgr_opacity', 09:03:08 INFO - 'tart', 09:03:08 INFO - 'tscrollx', 09:03:08 INFO - 'cart', 09:03:08 INFO - 'tsvg_static']}, 09:03:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'talos_options': ['--disable-e10s'], 09:03:08 INFO - 'tests': ['tp5o']}, 09:03:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:03:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'talos_options': ['--disable-e10s', 09:03:08 INFO - '--xperf_path', 09:03:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:08 INFO - 'tests': ['tp5n']}, 09:03:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:03:08 INFO - 'talos_options': ['--xperf_path', 09:03:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:08 INFO - 'tests': ['tp5n']}}, 09:03:08 INFO - 'talos.zip': {'path': '', 09:03:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:08 INFO - Running post-action listener: _resource_record_post_action 09:03:08 INFO - [mozharness: 2017-05-04 16:03:08.920951Z] Finished populate-webroot step (success) 09:03:08 INFO - [mozharness: 2017-05-04 16:03:08.921040Z] Running create-virtualenv step. 09:03:08 INFO - Running pre-action listener: _resource_record_pre_action 09:03:08 INFO - Running main action method: create_virtualenv 09:03:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:03:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:09 INFO - Using real prefix '/usr' 09:03:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:11 INFO - Installing pip.................done. 09:03:11 INFO - Return code: 0 09:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:11 INFO - Reading from file tmpfile_stdout 09:03:11 INFO - Output received: 09:03:11 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) 09:03:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:11 INFO - Using env: {'DISPLAY': ':0', 09:03:11 INFO - 'HOME': '/home/cltbld', 09:03:11 INFO - 'LANG': 'en_US.UTF-8', 09:03:11 INFO - 'LANGUAGE': 'en_US:en', 09:03:11 INFO - 'LOGNAME': 'cltbld', 09:03:11 INFO - 'MAIL': '/var/mail/cltbld', 09:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:11 INFO - 'MOZ_NO_REMOTE': '1', 09:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:11 INFO - 'NO_EM_RESTART': '1', 09:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:11 INFO - 'PWD': '/builds/slave/test', 09:03:11 INFO - 'SHELL': '/bin/bash', 09:03:11 INFO - 'SHLVL': '1', 09:03:11 INFO - 'TERM': 'linux', 09:03:11 INFO - 'TMOUT': '86400', 09:03:11 INFO - 'USER': 'cltbld', 09:03:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:11 INFO - '_': '/tools/buildbot/bin/python'} 09:03:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:03:11 INFO - Cleaning up... 09:03:11 INFO - Return code: 0 09:03:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:11 INFO - Using env: {'DISPLAY': ':0', 09:03:11 INFO - 'HOME': '/home/cltbld', 09:03:11 INFO - 'LANG': 'en_US.UTF-8', 09:03:11 INFO - 'LANGUAGE': 'en_US:en', 09:03:11 INFO - 'LOGNAME': 'cltbld', 09:03:11 INFO - 'MAIL': '/var/mail/cltbld', 09:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:11 INFO - 'MOZ_NO_REMOTE': '1', 09:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:11 INFO - 'NO_EM_RESTART': '1', 09:03:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:11 INFO - 'PWD': '/builds/slave/test', 09:03:11 INFO - 'SHELL': '/bin/bash', 09:03:11 INFO - 'SHLVL': '1', 09:03:11 INFO - 'TERM': 'linux', 09:03:11 INFO - 'TMOUT': '86400', 09:03:11 INFO - 'USER': 'cltbld', 09:03:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:11 INFO - '_': '/tools/buildbot/bin/python'} 09:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:12 INFO - Downloading/unpacking psutil>=3.1.1 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:13 INFO - Installing collected packages: psutil 09:03:13 INFO - Running setup.py install for psutil 09:03:13 INFO - building 'psutil._psutil_linux' extension 09:03:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:03:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:03:13 INFO - building 'psutil._psutil_posix' extension 09:03:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:03:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:03:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:13 INFO - Successfully installed psutil 09:03:13 INFO - Cleaning up... 09:03:13 INFO - Return code: 0 09:03:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:03:13 INFO - Using env: {'DISPLAY': ':0', 09:03:13 INFO - 'HOME': '/home/cltbld', 09:03:13 INFO - 'LANG': 'en_US.UTF-8', 09:03:13 INFO - 'LANGUAGE': 'en_US:en', 09:03:13 INFO - 'LOGNAME': 'cltbld', 09:03:13 INFO - 'MAIL': '/var/mail/cltbld', 09:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:13 INFO - 'MOZ_NO_REMOTE': '1', 09:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:13 INFO - 'NO_EM_RESTART': '1', 09:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:13 INFO - 'PWD': '/builds/slave/test', 09:03:13 INFO - 'SHELL': '/bin/bash', 09:03:13 INFO - 'SHLVL': '1', 09:03:13 INFO - 'TERM': 'linux', 09:03:13 INFO - 'TMOUT': '86400', 09:03:13 INFO - 'USER': 'cltbld', 09:03:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:13 INFO - '_': '/tools/buildbot/bin/python'} 09:03:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:15 INFO - Installing collected packages: mozsystemmonitor 09:03:15 INFO - Running setup.py install for mozsystemmonitor 09:03:15 INFO - Successfully installed mozsystemmonitor 09:03:15 INFO - Cleaning up... 09:03:15 INFO - Return code: 0 09:03:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:03:15 INFO - Using env: {'DISPLAY': ':0', 09:03:15 INFO - 'HOME': '/home/cltbld', 09:03:15 INFO - 'LANG': 'en_US.UTF-8', 09:03:15 INFO - 'LANGUAGE': 'en_US:en', 09:03:15 INFO - 'LOGNAME': 'cltbld', 09:03:15 INFO - 'MAIL': '/var/mail/cltbld', 09:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:15 INFO - 'MOZ_NO_REMOTE': '1', 09:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:15 INFO - 'NO_EM_RESTART': '1', 09:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:15 INFO - 'PWD': '/builds/slave/test', 09:03:15 INFO - 'SHELL': '/bin/bash', 09:03:15 INFO - 'SHLVL': '1', 09:03:15 INFO - 'TERM': 'linux', 09:03:15 INFO - 'TMOUT': '86400', 09:03:15 INFO - 'USER': 'cltbld', 09:03:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:15 INFO - '_': '/tools/buildbot/bin/python'} 09:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:16 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:16 INFO - warning: no files found matching '*.txt' 09:03:16 INFO - no previously-included directories found matching 'build' 09:03:16 INFO - no previously-included directories found matching 'dist' 09:03:16 INFO - no previously-included directories found matching '.git*' 09:03:16 INFO - Installing collected packages: jsonschema, functools32 09:03:16 INFO - Running setup.py install for functools32 09:03:16 INFO - warning: no files found matching '*.txt' 09:03:16 INFO - no previously-included directories found matching 'build' 09:03:16 INFO - no previously-included directories found matching 'dist' 09:03:16 INFO - no previously-included directories found matching '.git*' 09:03:16 INFO - Successfully installed jsonschema functools32 09:03:16 INFO - Cleaning up... 09:03:17 INFO - Return code: 0 09:03:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:17 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')]} 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:17 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')]} 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:17 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:17 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 09:03:17 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 09:03:17 INFO - Using env: {'DISPLAY': ':0', 09:03:17 INFO - 'HOME': '/home/cltbld', 09:03:17 INFO - 'LANG': 'en_US.UTF-8', 09:03:17 INFO - 'LANGUAGE': 'en_US:en', 09:03:17 INFO - 'LOGNAME': 'cltbld', 09:03:17 INFO - 'MAIL': '/var/mail/cltbld', 09:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:17 INFO - 'MOZ_NO_REMOTE': '1', 09:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:17 INFO - 'NO_EM_RESTART': '1', 09:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:17 INFO - 'PWD': '/builds/slave/test', 09:03:17 INFO - 'SHELL': '/bin/bash', 09:03:17 INFO - 'SHLVL': '1', 09:03:17 INFO - 'TERM': 'linux', 09:03:17 INFO - 'TMOUT': '86400', 09:03:17 INFO - 'USER': 'cltbld', 09:03:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:17 INFO - '_': '/tools/buildbot/bin/python'} 09:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:17 INFO - Cleaning up... 09:03:17 INFO - Return code: 0 09:03:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:17 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')]} 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:17 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')]} 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:17 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:17 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 09:03:17 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 09:03:17 INFO - Using env: {'DISPLAY': ':0', 09:03:17 INFO - 'HOME': '/home/cltbld', 09:03:17 INFO - 'LANG': 'en_US.UTF-8', 09:03:17 INFO - 'LANGUAGE': 'en_US:en', 09:03:17 INFO - 'LOGNAME': 'cltbld', 09:03:17 INFO - 'MAIL': '/var/mail/cltbld', 09:03:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:17 INFO - 'MOZ_NO_REMOTE': '1', 09:03:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:17 INFO - 'NO_EM_RESTART': '1', 09:03:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:17 INFO - 'PWD': '/builds/slave/test', 09:03:17 INFO - 'SHELL': '/bin/bash', 09:03:17 INFO - 'SHLVL': '1', 09:03:17 INFO - 'TERM': 'linux', 09:03:17 INFO - 'TMOUT': '86400', 09:03:17 INFO - 'USER': 'cltbld', 09:03:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:17 INFO - '_': '/tools/buildbot/bin/python'} 09:03:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:17 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:19 INFO - Downloading docopt-0.6.1.tar.gz 09:03:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:19 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:19 INFO - Running setup.py install for blobuploader 09:03:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:19 INFO - Running setup.py install for requests 09:03:19 INFO - Running setup.py install for docopt 09:03:19 INFO - Successfully installed blobuploader requests docopt 09:03:19 INFO - Cleaning up... 09:03:19 INFO - Return code: 0 09:03:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:19 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:19 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 09:03:19 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 09:03:19 INFO - Using env: {'DISPLAY': ':0', 09:03:19 INFO - 'HOME': '/home/cltbld', 09:03:19 INFO - 'LANG': 'en_US.UTF-8', 09:03:19 INFO - 'LANGUAGE': 'en_US:en', 09:03:19 INFO - 'LOGNAME': 'cltbld', 09:03:19 INFO - 'MAIL': '/var/mail/cltbld', 09:03:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:19 INFO - 'MOZ_NO_REMOTE': '1', 09:03:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:19 INFO - 'NO_EM_RESTART': '1', 09:03:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:19 INFO - 'PWD': '/builds/slave/test', 09:03:19 INFO - 'SHELL': '/bin/bash', 09:03:19 INFO - 'SHLVL': '1', 09:03:19 INFO - 'TERM': 'linux', 09:03:19 INFO - 'TMOUT': '86400', 09:03:19 INFO - 'USER': 'cltbld', 09:03:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:19 INFO - '_': '/tools/buildbot/bin/python'} 09:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:19 INFO - Running setup.py (path:/tmp/pip-NvjLVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:20 INFO - Running setup.py (path:/tmp/pip-hk7EvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:20 INFO - Running setup.py (path:/tmp/pip-CmmxlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:20 INFO - Running setup.py (path:/tmp/pip-fOxxHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:20 INFO - Running setup.py (path:/tmp/pip-MtFSHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:20 INFO - Running setup.py (path:/tmp/pip-YoxbZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:20 INFO - Running setup.py (path:/tmp/pip-tgwC5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:20 INFO - Running setup.py (path:/tmp/pip-Ayk66Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:20 INFO - Running setup.py (path:/tmp/pip-YMVdA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:20 INFO - Running setup.py (path:/tmp/pip-eSKbaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:20 INFO - Running setup.py (path:/tmp/pip-DejK14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:20 INFO - Running setup.py (path:/tmp/pip-mQYzr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:21 INFO - Running setup.py (path:/tmp/pip-YPK2sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:21 INFO - Running setup.py (path:/tmp/pip-zTr3A5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:21 INFO - Running setup.py (path:/tmp/pip-gO27pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:21 INFO - Running setup.py (path:/tmp/pip-rsPu3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:21 INFO - Running setup.py (path:/tmp/pip-ZSCuwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:21 INFO - Running setup.py install for manifestparser 09:03:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:21 INFO - Running setup.py install for mozcrash 09:03:21 INFO - Running setup.py install for mozdebug 09:03:21 INFO - Running setup.py install for mozdevice 09:03:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:21 INFO - Running setup.py install for mozfile 09:03:21 INFO - Running setup.py install for mozhttpd 09:03:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:21 INFO - Running setup.py install for mozinfo 09:03:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozInstall 09:03:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozleak 09:03:22 INFO - Running setup.py install for mozlog 09:03:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for moznetwork 09:03:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozprocess 09:03:22 INFO - Running setup.py install for mozprofile 09:03:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozrunner 09:03:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:22 INFO - Running setup.py install for mozscreenshot 09:03:22 INFO - Running setup.py install for moztest 09:03:23 INFO - Running setup.py install for mozversion 09:03:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:23 INFO - Cleaning up... 09:03:23 INFO - Return code: 0 09:03:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:23 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')]} 09:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:23 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')]} 09:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:23 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:23 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 09:03:23 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 09:03:23 INFO - Using env: {'DISPLAY': ':0', 09:03:23 INFO - 'HOME': '/home/cltbld', 09:03:23 INFO - 'LANG': 'en_US.UTF-8', 09:03:23 INFO - 'LANGUAGE': 'en_US:en', 09:03:23 INFO - 'LOGNAME': 'cltbld', 09:03:23 INFO - 'MAIL': '/var/mail/cltbld', 09:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:23 INFO - 'MOZ_NO_REMOTE': '1', 09:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:23 INFO - 'NO_EM_RESTART': '1', 09:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:23 INFO - 'PWD': '/builds/slave/test', 09:03:23 INFO - 'SHELL': '/bin/bash', 09:03:23 INFO - 'SHLVL': '1', 09:03:23 INFO - 'TERM': 'linux', 09:03:23 INFO - 'TMOUT': '86400', 09:03:23 INFO - 'USER': 'cltbld', 09:03:23 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:23 INFO - '_': '/tools/buildbot/bin/python'} 09:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:23 INFO - Running setup.py (path:/tmp/pip-56W1g8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:23 INFO - Running setup.py (path:/tmp/pip-pl_VIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:23 INFO - Running setup.py (path:/tmp/pip-w2zeX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:23 INFO - Running setup.py (path:/tmp/pip-c_AhJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:23 INFO - Running setup.py (path:/tmp/pip-dN_HI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:23 INFO - Running setup.py (path:/tmp/pip-FVFxdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:23 INFO - Running setup.py (path:/tmp/pip-RZqTB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:23 INFO - Running setup.py (path:/tmp/pip-1wdiu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:23 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)) 09:03:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:23 INFO - Running setup.py (path:/tmp/pip-A8fJ0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:24 INFO - Running setup.py (path:/tmp/pip-jK39WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:24 INFO - Running setup.py (path:/tmp/pip-PvzPdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:24 INFO - Running setup.py (path:/tmp/pip-dJTPNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:24 INFO - Running setup.py (path:/tmp/pip-VC2VkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:24 INFO - Running setup.py (path:/tmp/pip-xiiBqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:24 INFO - Running setup.py (path:/tmp/pip-Rxutjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:24 INFO - Running setup.py (path:/tmp/pip-2enil_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:24 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)) 09:03:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:24 INFO - Running setup.py (path:/tmp/pip-Dks0aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:24 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)) 09:03:24 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)) 09:03:24 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)) 09:03:24 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)) 09:03:24 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)) 09:03:24 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)) 09:03:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:24 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 09:03:24 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 09:03:24 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 09:03:24 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 09:03:24 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 09:03:24 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 09:03:25 INFO - Downloading blessings-1.6.tar.gz 09:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:25 INFO - Installing collected packages: blessings 09:03:25 INFO - Running setup.py install for blessings 09:03:25 INFO - Successfully installed blessings 09:03:25 INFO - Cleaning up... 09:03:25 INFO - Return code: 0 09:03:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:26 INFO - Reading from file tmpfile_stdout 09:03:26 INFO - Current package versions: 09:03:26 INFO - argparse == 1.2.1 09:03:26 INFO - blessings == 1.6 09:03:26 INFO - blobuploader == 1.2.4 09:03:26 INFO - docopt == 0.6.1 09:03:26 INFO - functools32 == 3.2.3-2 09:03:26 INFO - jsonschema == 2.5.1 09:03:26 INFO - manifestparser == 1.1 09:03:26 INFO - mozInstall == 1.12 09:03:26 INFO - mozcrash == 1.0 09:03:26 INFO - mozdebug == 0.1 09:03:26 INFO - mozdevice == 0.50 09:03:26 INFO - mozfile == 1.2 09:03:26 INFO - mozhttpd == 0.7 09:03:26 INFO - mozinfo == 0.9 09:03:26 INFO - mozleak == 0.1 09:03:26 INFO - mozlog == 3.4 09:03:26 INFO - moznetwork == 0.27 09:03:26 INFO - mozprocess == 0.25 09:03:26 INFO - mozprofile == 0.28 09:03:26 INFO - mozrunner == 6.13 09:03:26 INFO - mozscreenshot == 0.1 09:03:26 INFO - mozsystemmonitor == 0.3 09:03:26 INFO - moztest == 0.8 09:03:26 INFO - mozversion == 1.4 09:03:26 INFO - psutil == 3.1.1 09:03:26 INFO - requests == 1.2.3 09:03:26 INFO - wsgiref == 0.1.2 09:03:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:26 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')]} 09:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:26 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')]} 09:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:26 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:26 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 09:03:26 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 09:03:26 INFO - Using env: {'DISPLAY': ':0', 09:03:26 INFO - 'HOME': '/home/cltbld', 09:03:26 INFO - 'LANG': 'en_US.UTF-8', 09:03:26 INFO - 'LANGUAGE': 'en_US:en', 09:03:26 INFO - 'LOGNAME': 'cltbld', 09:03:26 INFO - 'MAIL': '/var/mail/cltbld', 09:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:26 INFO - 'MOZ_NO_REMOTE': '1', 09:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:26 INFO - 'NO_EM_RESTART': '1', 09:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:26 INFO - 'PWD': '/builds/slave/test', 09:03:26 INFO - 'SHELL': '/bin/bash', 09:03:26 INFO - 'SHLVL': '1', 09:03:26 INFO - 'TERM': 'linux', 09:03:26 INFO - 'TMOUT': '86400', 09:03:26 INFO - 'USER': 'cltbld', 09:03:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:26 INFO - '_': '/tools/buildbot/bin/python'} 09:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 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)) 09:03:26 INFO - Cleaning up... 09:03:26 INFO - Return code: 0 09:03:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03:26 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')]} 09:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:26 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')]} 09:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:26 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 0x24f61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2793b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', '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 09:03:26 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 09:03:26 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 09:03:26 INFO - Using env: {'DISPLAY': ':0', 09:03:26 INFO - 'HOME': '/home/cltbld', 09:03:26 INFO - 'LANG': 'en_US.UTF-8', 09:03:26 INFO - 'LANGUAGE': 'en_US:en', 09:03:26 INFO - 'LOGNAME': 'cltbld', 09:03:26 INFO - 'MAIL': '/var/mail/cltbld', 09:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:26 INFO - 'MOZ_NO_REMOTE': '1', 09:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:26 INFO - 'NO_EM_RESTART': '1', 09:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:26 INFO - 'PWD': '/builds/slave/test', 09:03:26 INFO - 'SHELL': '/bin/bash', 09:03:26 INFO - 'SHLVL': '1', 09:03:26 INFO - 'TERM': 'linux', 09:03:26 INFO - 'TMOUT': '86400', 09:03:26 INFO - 'USER': 'cltbld', 09:03:26 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:26 INFO - '_': '/tools/buildbot/bin/python'} 09:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:26 INFO - Cleaning up... 09:03:26 INFO - Return code: 0 09:03:26 INFO - Running post-action listener: _resource_record_post_action 09:03:26 INFO - Running post-action listener: _start_resource_monitoring 09:03:26 INFO - Starting resource monitoring. 09:03:26 INFO - [mozharness: 2017-05-04 16:03:26.644716Z] Finished create-virtualenv step (success) 09:03:26 INFO - [mozharness: 2017-05-04 16:03:26.645175Z] Running install step. 09:03:26 INFO - Running pre-action listener: _resource_record_pre_action 09:03:26 INFO - Running main action method: install 09:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:26 INFO - Reading from file tmpfile_stdout 09:03:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:26 INFO - Reading from file tmpfile_stdout 09:03:26 INFO - Output received: 09:03:26 INFO - Usage: mozinstall [options] installer 09:03:26 INFO - Options: 09:03:26 INFO - -h, --help show this help message and exit 09:03:26 INFO - -d DEST, --destination=DEST 09:03:26 INFO - Directory to install application into. [default: 09:03:26 INFO - "/builds/slave/test"] 09:03:26 INFO - --app=APP Application being installed. [default: firefox] 09:03:26 INFO - mkdir: /builds/slave/test/build/application 09:03:26 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'] 09:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:03:41 INFO - Reading from file tmpfile_stdout 09:03:41 INFO - Output received: 09:03:41 INFO - /builds/slave/test/build/application/firefox/firefox 09:03:41 INFO - Running post-action listener: _resource_record_post_action 09:03:41 INFO - [mozharness: 2017-05-04 16:03:41.904448Z] Finished install step (success) 09:03:41 INFO - [mozharness: 2017-05-04 16:03:41.904586Z] Running run-tests step. 09:03:41 INFO - Running pre-action listener: _resource_record_pre_action 09:03:41 INFO - Running main action method: run_tests 09:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:03:41 INFO - Python 2.7.3 09:03:41 INFO - Return code: 0 09:03:41 INFO - grabbing minidump binary from tooltool 09:03:41 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')]} 09:03:41 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 0x2791290>, '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 0x2791b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2792040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:03:41 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 09:03:41 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 09:03:41 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 09:03:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:03:41 INFO - Return code: 0 09:03:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:03:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:03:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:03:41 INFO - ENV: RUST_BACKTRACE is now 1 09:03:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:03:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:03:41 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:03:41 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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 09:03:41 INFO - Using env: {'DISPLAY': ':0', 09:03:41 INFO - 'HOME': '/home/cltbld', 09:03:41 INFO - 'LANG': 'en_US.UTF-8', 09:03:41 INFO - 'LANGUAGE': 'en_US:en', 09:03:41 INFO - 'LOGNAME': 'cltbld', 09:03:41 INFO - 'MAIL': '/var/mail/cltbld', 09:03:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:03:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:41 INFO - 'MOZ_NO_REMOTE': '1', 09:03:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:41 INFO - 'NO_EM_RESTART': '1', 09:03:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:41 INFO - 'PWD': '/builds/slave/test', 09:03:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:03:41 INFO - 'RUST_BACKTRACE': '1', 09:03:41 INFO - 'SHELL': '/bin/bash', 09:03:41 INFO - 'SHLVL': '1', 09:03:41 INFO - 'TERM': 'linux', 09:03:41 INFO - 'TMOUT': '86400', 09:03:41 INFO - 'USER': 'cltbld', 09:03:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132', 09:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:41 INFO - '_': '/tools/buildbot/bin/python'} 09:03:41 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/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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 09:03:42 INFO - mozversion application_buildid: 20170504154001 09:03:42 INFO - mozversion application_changeset: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a 09:03:42 INFO - mozversion application_display_name: Nightly 09:03:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:03:42 INFO - mozversion application_name: Firefox 09:03:42 INFO - mozversion application_remotingname: firefox 09:03:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:03:42 INFO - mozversion application_vendor: Mozilla 09:03:42 INFO - mozversion application_version: 55.0a1 09:03:42 INFO - mozversion platform_buildid: 20170504154001 09:03:42 INFO - mozversion platform_changeset: 6d4525b5aaa834ea4db8d8eab8087d86e34cf57a 09:03:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:03:42 INFO - mozversion platform_version: 55.0a1 09:03:42 INFO - using testdate: 1493913822 09:03:42 INFO - actual date: 1493913822 09:03:42 INFO - starting webserver on 'localhost:33001' 09:03:42 INFO - SUITE-START | Running 2 tests 09:03:42 INFO - TEST-START | dromaeo_css 09:03:42 INFO - operating with platform_type : linux_ 09:03:42 INFO - Initialising browser for dromaeo_css test... 09:03:42 INFO - TEST-INFO | started process 26819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGFy1yf/profile http://localhost:33001/getInfo.html) 09:03:47 INFO - PID 26819 | __metrics Screen width/height:1600/1200 09:03:47 INFO - PID 26819 | colorDepth:24 09:03:47 INFO - PID 26819 | Browser inner width/height: 1024/695 09:03:47 INFO - PID 26819 | __metrics 09:03:49 INFO - TEST-INFO | 26819: exit 0 09:03:49 INFO - Browser initialized. 09:03:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:03:49 INFO - TEST-INFO | started process 26990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGFy1yf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:01 INFO - PID 26990 | RSS: Main: 160280576 09:04:01 INFO - PID 26990 | 09:07:06 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33001/tests/dromaeo/cssquery-ext.html) 09:07:08 INFO - PID 26990 | RSS: Main: 163459072 09:07:08 INFO - PID 26990 | 09:10:10 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-ext.html (next: http://localhost:33001/tests/dromaeo/cssquery-jquery.html) 09:10:11 INFO - PID 26990 | RSS: Main: 158650368 09:10:11 INFO - PID 26990 | 09:13:12 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33001/tests/dromaeo/cssquery-mootools.html) 09:13:13 INFO - PID 26990 | RSS: Main: 166281216 09:13:13 INFO - PID 26990 | 09:16:15 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33001/tests/dromaeo/cssquery-prototype.html) 09:16:16 INFO - PID 26990 | RSS: Main: 158244864 09:16:16 INFO - PID 26990 | 09:19:18 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33001/tests/dromaeo/cssquery-yui.html) 09:19:19 INFO - PID 26990 | RSS: Main: 162869248 09:19:19 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | Cycle 1(1): loaded http://localhost:33001/tests/dromaeo/cssquery-yui.html (next: http://localhost:33001/tests/dromaeo/cssquery-dojo.html) 09:22:21 INFO - PID 26990 | RSS: Main: 164409344 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | __start_tp_report 09:22:21 INFO - PID 26990 | _x_x_mozilla_page_load 09:22:21 INFO - PID 26990 | _x_x_mozilla_page_load_details 09:22:21 INFO - PID 26990 | |i|pagename|runs| 09:22:21 INFO - PID 26990 | |0;dojo.html;2749.436365545063;2755.2009917124037;2771.1270949650857;2799.160251924422;2805.579163125531;5284.365876094874;5312.389075256347;5318.441563635821;5400.108982017962;5404.648697834638;5353.437889021655;5366.973165134169;5372.489613486712;5450.945490545093;5470.206820011096;4411.828689939235;4677.649176311773;4681.0871879983415;4697.201475749113;4703.412073490814;4757.191277482836;4766.285057241407;4795.712257264575;4796.232602783555;4810.807567697288;4676.6960147590635;4688.64835137366;4733.621310295202;4740.786664600101;4753.619710423158;4773.284007398884;4774.212254977924;4775.188218002913;4800.039992001613;4840.491748366441;4720.221163508017;4748.4539277982785;4758.95241047592;4766.475687674353;4782.713037217778;5253.737313134328;5318.574514038867;5323.068463018956;5388.865278368072;5397.78408863645;5788.363280039192;5792.247007888989;5835.766569337221;5840.211571437844;5859.29688437386;5823.388544202882;5828.096645019987;5835.5915085944;5839.620424672383;5840.445157710011;5302.602304827154;5369.812056578001;5390.460953904578;5402.216678581663;5412.783488660488;5933.554983376264;6019.849503762353;6033.849153771103;6037;6056.757729690763;5656.971715141481;5737.684427356536;5749.798757043567;5779.075347944308;5787.334456537468;5746.626469279484;5827.388124246893;5830.970845145747;5837.299524057055;5847.8245652630485;5648.322201335784;5729.88540229193;5806.65160090396;5810.1865738796605;5810.62230954995;5746.683932383759;5793.420657934257;5793.710314484259;5835.270591176103;5849.532037436995;4813.3983252092785;4831.4685384607665;4837.806487740521;4845.63657725672;4885.828995985124;4049.655779258737;4080.7959602019782;4122.2579935611875;4123.2165888481695;4167.562405947332;4923.852284431473;4927.90144197114;4973.676711013773;4982.77577509013;4995.575376093073;5888.263967004124;5892.528597712173;5924.7926322578505;5937;5943.435373639497;4947.381577302837;4954.256861470808;4957.826476073392;4967.602591792648;5001.8499445016705;5085.415177254589;5175.430702622709;5183.766730497136;5201.869953251199;5205.55752761012;5279.023380674587;5332.013577488177;5333.43998880112;5342.225377320345;5351.411344752152;5756.913646295226;5801.129830525286;5801.94198058014;5808.36108028125;5812.534997200299;5417.83746487606;5435.130379139318;5443.591730620298;5455.099908515209;5483.314585676791;5756.56825738063;5764.711764411846;5767.077267637158;5774.595778295479;5776.797812076557;5716.171155182558;5850.297964244318;5867.882642347215;5870.412958704095;5877.147813566923;5578.9163162553405;5599;5681.17622944679;5682.034054210877;5710.114932185518;5634.887302254014;5657.43425657431;5661.66030038199;5686.83419898928;5696.971515142398;5480.972595137158;5548.944510554843;5558.277423934863;5563.193336966036;5568.415316391883;5614.859628509156;5664.49019588239;5680.801171958961;5733.8566535836935;5751.194832723506;5510.641808282448;5558.305211848519;5559.694216818114;5567.916481252703;5605.663660180402 09:22:21 INFO - PID 26990 | |1;ext.html;666.1406785247032;738.4683028219681;757.371381753145;1052.9052385285322;1053.826118690416;31647.841760791194;32724.67275327246;32805;32840.83579582105;32843.014709558694;34604.65395346046;34626.653733462656;34847.65152348476;34910.82544587273;35021;6859.279775623562;6989.021536984839;7030.85938281234;7051.612161331124;7134.429245660334;7046.577205367668;7081.398081163107;7097.609631470267;7120.323569260938;7131.358177764;7034.472414568902;7073.646317684121;7117.217106118349;7144.964275178643;7167.2832716728435;7036.296370362948;7085.326893945093;7133.500654954155;7137.857242855166;7155.749548765768;6956.65216739161;6970.79087627372;7006.544574602685;7008.614526201057;7021.262767409399;32285.677143228502;32581.511277330857;32642.510362344583;32690.346193076242;32770.836145819354;2992.670806211315;3011.2020314616643;3022.0933719883947;3038.8328641924686;3048.4665183592783;24908.252752417455;24938.875305623536;25074.24777256685;25101.24696259115;25130.497390052096;2779.958300625492;2784.9303767405772;2800.4399120175844;2804.5372513535244;2806.1581525542256;148464;149985;153398;155833;156110.21944890203;40735.18529629391;40935.38596921049;40970.79514602408;41008.359665613636;41027.1794564113;41099;41306.38040429396;41355.1728965419;41530.79234603808;41598;11627.941860290814;11680.532778688927;11738.354390508604;11747.060235181165;11765.823512647317;9452.196563292197;9480.573374198178;9526.666566670134;9578.664746733832;9583.664571739955;12356.320402377776;12418.441170147365;12479.438425270884;12502.437390317458;12714.554990575285;5224.268602395668;5238.397584277781;5257;5368.516833485005;5387.649802762808;863.8747381629629;907.9228265597366;911.5396724654007;913.1918252346721;935.2891802230354;20753.27363542299;21604.783952160593;21630;21838.781612183673;21907.890460547595;973.6884197057016;977.4184360305607;992.3946392700446;1005.4014117553126;1013.8935411781657;11314.773704526027;11438.256513326607;11459.484323205475;11533.308001519936;11613.30320180792;177378;179010;179193.18471560298;179508.10245948686;180357;42349.57650423457;42360.78819605882;42804.78597607054;42842;42853.1429371417;1119.7536541960756;1175.717827721358;1177.4701384376892;1182.2138278045004;1201.2672269915345;19540.609187816448;19649.508762281057;20413;21040.57918841584;21123.78876211218;29291.121266362043;29430.117096487138;29545.55681664734;29581.26046848846;29659.851700741357;152079;152195.23902380417;152823;153090;153323.23338383235;29212.70787292185;29411.85294073516;29663.406731865674;30874;31033.37933241368;36737.26525469529;37119.257614848095;37381.439278410304;37410.6258937418;37413.43879841859;26846.865765671046;27291.317717056438;27411.177664670093;27847.30381740473;28405.43189136247;26818.463630726885;27179.184624461297;27549;27727.44545109127;28590.42819143564;30977.53533696951;31057.534136988415;31081;31085.378292434478;31127.377452451277;26517.33706657349;26611;26863;27575.172744817686;27889.302767430978;21707.674384884554;22511;22814.771852281265;22836.31491055271;22859.42851428661 09:22:21 INFO - PID 26990 | |2;jquery.html;405.28669541606763;406.2524954084484;411.0832842760645;423.9597238262364;429.2830972276298;13445.865541344609;17266.82733172668;17865.374711885088;17951.55121121971;17965.371212007583;18196.727049094276;18404.171812268447;18598.72101918469;19023.61952760944;19277.80722192778;5361.731913404334;5555.666660000393;5581.888362232753;5604.187392828037;5737.397573254811;5530.198121272413;5606.831795046155;5622.662640241578;5623.887522249553;5633.746481408347;5381.623286369956;5585.162225666162;5585.190147428621;5589.993801115797;5601.747921343549;5501.9174712379345;5558.805441809517;5561.443855614447;5562.332520097574;5568.805091821767;4831.202851529493;4980.228064649985;4988.551030407244;5036.043151801146;5041.0422019816115;21647;21819;21834.454138646503;22102.115915363367;22318.330450086523;1609.8309677483812;1634.558669159332;1671.1727694791034;1684.6209602839385;1695.8982461052376;14853.183074930874;14922.104673719503;15058.32237549313;15180.240987950558;15240.314185861664;2048.907799149027;2073.968890466644;2120.4380839077658;2133.7332833395826;2134.039682143042;84679.57660211659;86182.56908715478;86399.13600863973;86458;87952.56023719904;10722.571097156026;10899.945500272606;10918.454077296263;11049.33703977764;11108.944650258212;15061.246937653294;15231.466898658493;15283.61790955235;15289;15349.846501535065;7167.987015878853;7269.645839044958;7281.308275713799;7427.962860185665;7477.7008919643695;6521.282658907517;6592.340765923369;6745.561538499982;6765.05289259504;6812.182538095461;6830.487713421513;6896.448284137257;6980.546264492792;7015.123109611299;7103.502754807114;2038.6057214737593;2046.9181232750523;2100.4328831215485;2125.8405619578593;2126.277065797636;836.3768992100923;868.6525389843987;869.3045563549261;870.634333579898;900.4417261298037;17024.233909473856;17062.82937170637;17110.401135960183;17318.567035823955;17954.371596994042;862.2799962031648;876.5573385440312;881.1937077574077;882.4176043811182;901.0808974845621;9448;10736.516856741466;11524.308541487537;11545.36500492481;11900.285982841056;350495;365325;371199;371930;373011;74545.6272718633;74603;76878.61560692161;77235.61382193165;79502.60248698719;1064.122099268107;1094.3379255550278;1126.3354620773619;1132.824412216108;1132.932024078558;17325.65348693044;17645;18029.72955405696;19016.098390160874;19215.90392048031;38400.80799595984;39512.802435987636;39805.40291895682;40233.597664022986;40989.59010409858;46779.29831052469;47355.28967065428;48877.02245955132;49090.75454622704;49379.753101234266;8314.459560128573;8316.667333306841;8357.027568596675;8382.622781974704;8410.747677569683;12911.741765164832;12912.548060817826;13176.209427434385;13226.082218078132;13373.732525349244;10983.835242471529;11228.10175185967;11239.269447486215;11408.144389171011;11583.536658533565;10654.414007229676;10861.78276434451;10892.128629709447;10996.175286853359;11037.337759734442;11515.712107197387;11863;11885.643430697093;11953.581624643095;12289.201201921847;8314.376421768271;8372.874406884024;8379.832403351777;8486.618102185294;8817.515036673045;11441.885581144083;11477.655670329903;11555.133364997491;11607.76784464323;11974.161808673309 09:22:21 INFO - PID 26990 | |3;mootools.html;1223.4494477485132;1276.0557187681118;1280.7502537005287;1291.3865913690993;1295.96760080998;9546.377115890298;10034.147097496721;10039.397636141828;10217.28479006468;10525.473726313692;10252.692419227435;10376.533056012478;10413;10440.477976101203;10444.112250458702;2107.7576078750985;2135.540858715376;2147.5060736030723;2147.6349020666526;2148.5488047510044;2038.1236068490543;2045.7851925547827;2048.385484354688;2050.339225227563;2066.545360020793;2036.2567662803044;2042.1014753508482;2055.054674849571;2061.494933741228;2063.3191046954544;1973.1614064022876;1978.2186036515568;1984.484034151124;1990.6118306930155;1996.1316827180078;1925.4801203674929;1935.525796179931;1950.288144827142;2059.742532183477;2062.360668192865;10118.89881101187;10132.088112069949;10160.288779785418;10209;10255.897441025569;5356.866078348073;5477.972610136963;5521.641093328961;5551.361593416768;5571.8885622287735;3112.9066128016198;3319.867205311785;3373.224158443572;3385.356782211372;3396.218869659992;980.6371642492252;1000.564754331868;1015.0661391519745;1022.7954409118132;1032.4992378696327;14777.26113694311;14867.702645947129;14889.627759305995;15009.399624015026;15103.4713785017;4424.646028317727;4568.840090596879;4795.20879054959;4816.301636262722;4885.902281954341;10448.373097614167;10656.413897235727;10679.786404272027;10720.785584288271;10726.034656880918;5446.8910621787345;5487.6981766002455;5489.231507588941;5494.972525137348;5503.752331145028;4858.708477491362;4978.303037574742;4995.350604421402;5116.386033675983;5124.359455068116;3632.6185750495815;3668.596454390015;3677.1726361568435;3726.869559565402;3754.2679177560112;1034.8395998620226;1042.135027926819;1048.418127938986;1050.7740835720356;1057.360297020307;696.3245651717825;720.1753991679498;720.5748608321115;726.81466226112;736.4623824608066;5401.864953376197;5413.458654134633;5527.364353099445;5609.607327487037;5626.549876009909;537.8574677710332;542.5930552085936;547.5646860745717;556.0325034440126;564.3650892745661;3429.4855771633956;3773.4528493368307;3848.114933565296;3962.2075584882564;4022.738521996061;12492.375381230902;12717.173383730213;13231.338433078308;13292.268925209206;13330.533431329857;13079.280639564726;13187.802182967263;13193.60419187426;13202.537911173064;13361.933190333986;7534.472586918972;7545.434092443198;7785.493942893694;7789.143194248742;7819.257170568787;6045.879082418415;6187.84530386744;6239;6250.281217660027;6278.434940855345;11327.093832493216;11423.828642570534;11483.770324593628;11500.482478288664;11676.124290678063;11565.421728913689;11672.824907626222;11687.298762074302;11852.644420667393;11910.166288359731;8195.918040819515;8286.129956354496;8338.833223335621;8348.165183481604;8368.20502052304;9261;9402.200812930978;9440.575174117044;9538.904610953801;9586.089321514444;7946.960265198637;8023.358131349595;8039.477433966774;8072.152423995396;8223.09545949957;7890.763277101696;7929.365650748042;7934.135478162511;7968.521888686697;8101.473404228706;7485.962570187115;7496.7750967471065;7513.924860751541;7544.170141284345;7620.542767433972;4976.701397916137;5284.154535274338;5365.812196573102;5384.407715151408;5389.27244821944;5373.462653734595;5413.431589683027;5445.618806683494;5468.699221542854;5581.6930068846605 09:22:21 INFO - PID 26990 | |4;prototype.html;341.91793969447326;364.19149488136327;364.79936035180646;368.1257014590348;370.85536640710126;5485.780568777244;5699.572532060101;5704.515116215121;5705.4294570542925;5707.800226992056;5397.055515284829;5434.701091439969;5491.176323551469;5504.256925315081;5513.751881165347;4103.261412945669;4115.897102572437;4125.834966601333;4130.2359063573185;4142.958570414303;4075.8777236682945;4129.504459464853;4148.668106551484;4155.314373128445;4164.479440069991;4073.4500842386196;4079.5920407959266;4080.4083407905837;4088.9164371441593;4105.624615753726;4068.8982775430554;4073.714839961204;4089.672826173899;4092.2224777292217;4094.3858421236755;3543.982280088609;3561.893143205708;3571.767835090711;3575.659127827065;3582.0686621478344;5325.174597937326;5343.839684809462;5365.517103460707;5406.59450541211;5448.536874365684;4840.782164802557;4862.805487780484;4864.173090574611;4865.683730557538;4894.216925291972;5755.848830233928;5869.383714709979;5870.911936320958;5880.6765627890445;5903.734331955029;3993.341098718708;4005.8798236052676;4008.83964641414;4024.2555127301544;4034.6570541504007;6066.998945174041;6184.196054512884;6199.659018753967;6215.1609532712955;6252.6873656317;4085.7957102144774;4088.8364465421646;4092.856750013735;4100.36444351126;4100.753954762724;4137.565555616678;4142.597293569723;4148.439960605279;4151.398047283127;4160.875173744793;4720.33915251865;4766.285057241442;4812.494688057774;4812.735299558558;4834.7824347904425;5849.7952571660635;5850.5612079094235;5867.119932010147;5870.3249126350165;5886.735096920649;1416.9514559226304;1424.3193032222077;1425.180521200314;1425.5652026131922;1434.189682829198;940.6237504997919;943.8914524829732;952.4047470331043;954.160338901762;959.9856002159974;5095.97452012745;5106.336176297058;5113.360829896263;5114.897702045938;5127.948720512822;6089.472868759503;6090.878182436415;6109.14471973924;6117.755289788359;6137;4978.377702787152;5055.191169412877;5059.46875578059;5080.669756465818;5096.668716533413;3226.790258633181;3256.5929258842643;3258.9734233716304;3259.445894197992;3261.706446419786;5490.831121706903;5632.267805185382;5649.728811017489;5658.415643619793;5660.924424359358;6200.968995155085;6217.813465596039;6219.378062193744;6228.813135605939;6230.7819226326865;5624.85937851557;5656.717164141776;5668.971655141698;5672.149177623307;5689.630174038674;5944.524438044859;6062.818115456544;6072.635641861502;6096.5732398733435;6114.144019837316;5850.3857095006115;6001.699915004319;6016.4585187331595;6043.335233124265;6049.183360246487;5639.210510528611;5681.204631351697;5688.544916406595;5689.487946084872;5695.259616250027;4081.7346872453195;4104.507459104927;4107.753534787922;4111.321631930698;4126.051008268175;6012.789552365646;6146.692665366803;6183.0107182852325;6191.597546159485;6199.357170349771;5903;5952.553558483044;5959.582829201914;5967.671778052249;5985.790497332572;5804.709764511842;5954.183973888005;5964.4035596441745;5985.431384018511;5999.020323293215;5769.711514424178;5773.364929857797;5823.854403639943;5831.329397119385;5838.357780644041;5963.433473820153;6003.219581454383;6009.918214721392;6029.547783916136;6030.48740857032;5635.239242702182;5766.194311754222;5783.421657834183;5804.9709751452665;5844.503217226584 09:22:21 INFO - PID 26990 | |5;yui.html;728.6903066196865;745.6942653512059;749.0561892016061;754.2721273970617;762.3101093510373;12419.56531521397;13221.867781322184;13323;14252.928735356321;14263.358148883286;13141.54004609839;13573.321333933312;13595.456181752743;13632.113912595674;13728.382222799974;813.7355359508153;824.8185399212164;829.9585020748968;835.0772396501869;836.2766207230732;881.5944665453899;889.253027456936;894.8434024045766;895.1809094678362;895.7626229049307;906.4833045164258;910.0671811393308;919.6551293265026;919.9632014719404;923.7090316550299;907.1790030022806;914.940528865625;914.9862752058724;915.3272344826547;916.2166347772625;670.4033410264868;672.9629870357128;674.150570281449;675.1088563096714;675.6689222281096;13053.738925221442;13551.457941682322;13665.521706740217;15092.245387730569;15191.848081519154;15508.844911550854;15511.224438778128;15709.21453927299;15779.921100394424;15809.525714228477;11728.765424691544;11818.763624727457;11888.881111188864;11966.401679916056;12011.279323240633;2678.7589116979566;2679.7856171506232;2687.220705995259;2691.448253108108;2721.4421043685998;63356.68321658408;67698;67790;68205;68834.65582672054;12801.359932003363;13139.474421023053;13188.934055329662;13245.867541324656;13321.33393330349;23189.072437102328;23265.534689306118;23476.94353754085;23597.174098906456;23727.406814829767;6112.235970503687;6315.147455093595;6315.463185629181;6374.713137908805;6510.153680021567;2887.7112288771373;2945.955810662842;2946.7789915755975;2959.1566403575307;2966.777491688132;3297.5218593304317;3381.0702056934538;3384.729221662261;3387.4410722230555;3522.1546828761425;721.5490318550906;732.7362149626131;737.259054650084;745.0537816972522;745.7799949015053;607.9544034197453;621.8414304352361;628.9622622642656;629.8929182039064;652.3118110393581;9579.760505987406;9909.306348555676;10027.348222365523;10183;10446.68659940203;594.6610432053774;595.675356930474;605.6093819486495;605.6608299352376;613.7606333529927;4508.323751437245;4583.633309335245;4612.907741845144;4629.171477266461;4683.7892294846815;66180.66909665517;66809.33190668128;67566;68115.65942170356;70251.2974870255;57152.42847571554;57345;57345;58226.708866455396;60336.69831650814;52591.21113183305;53504.73247633815;53992.460075399526;54391;54826.45173548293;8855.911440885766;9127.224185944004;9158.908410915805;9398.624055037722;9601.183899368632;28235;28727.712722872504;28739.568906466;28818.567721484615;29218.561721574617;33450.49824252589;33534;33781.15547111243;33832.49251261184;35012;12108.152429329863;12185.756284874076;12340.074494413135;12399.318037508023;12533.74932501363;12951.158174718614;13091;13159.144655597738;13258.403371848097;13416.262105584286;12132.939335303266;12219.816702749644;12274.509019639114;12381.442835072623;12511.874881251071;10911.563537458413;11043.337399756041;11055.613053543088;11093.50079246452;11213.495392707184;12307.26156430617;12497.937510312753;12582.748345033231;12660.11379203447;12842.807357889453;8014.879776803236;8330.375221858507;8349.749507514784;8427.115152908857;8560;9636.036396360309;9655.710328690151;9730.610775568897;9889.604415823575;9922.751931201778 09:22:21 INFO - PID 26990 | __end_tp_report 09:22:21 INFO - PID 26990 | __start_cc_report 09:22:21 INFO - PID 26990 | _x_x_mozilla_cycle_collect,350 09:22:21 INFO - PID 26990 | __end_cc_report 09:22:21 INFO - PID 26990 | __startTimestamp1493914941455__endTimestamp 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | ------- Summary: start ------- 09:22:21 INFO - PID 26990 | Number of tests: 6 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#0] dojo.html Cycles:165 Average:5302.15 Median:5455.10 stddev:644.16 (11.8%) stddev-sans-first:614.22 09:22:21 INFO - PID 26990 | Values: 2749.4 2755.2 2771.1 2799.2 2805.6 5284.4 5312.4 5318.4 5400.1 5404.6 5353.4 5367.0 5372.5 5450.9 5470.2 4411.8 4677.6 4681.1 4697.2 4703.4 4757.2 4766.3 4795.7 4796.2 4810.8 4676.7 4688.6 4733.6 4740.8 4753.6 4773.3 4774.2 4775.2 4800.0 4840.5 4720.2 4748.5 4759.0 4766.5 4782.7 5253.7 5318.6 5323.1 5388.9 5397.8 5788.4 5792.2 5835.8 5840.2 5859.3 5823.4 5828.1 5835.6 5839.6 5840.4 5302.6 5369.8 5390.5 5402.2 5412.8 5933.6 6019.8 6033.8 6037.0 6056.8 5657.0 5737.7 5749.8 5779.1 5787.3 5746.6 5827.4 5831.0 5837.3 5847.8 5648.3 5729.9 5806.7 5810.2 5810.6 5746.7 5793.4 5793.7 5835.3 5849.5 4813.4 4831.5 4837.8 4845.6 4885.8 4049.7 4080.8 4122.3 4123.2 4167.6 4923.9 4927.9 4973.7 4982.8 4995.6 5888.3 5892.5 5924.8 5937.0 5943.4 4947.4 4954.3 4957.8 4967.6 5001.8 5085.4 5175.4 5183.8 5201.9 5205.6 5279.0 5332.0 5333.4 5342.2 5351.4 5756.9 5801.1 5801.9 5808.4 5812.5 5417.8 5435.1 5443.6 5455.1 5483.3 5756.6 5764.7 5767.1 5774.6 5776.8 5716.2 5850.3 5867.9 5870.4 5877.1 5578.9 5599.0 5681.2 5682.0 5710.1 5634.9 5657.4 5661.7 5686.8 5697.0 5481.0 5548.9 5558.3 5563.2 5568.4 5614.9 5664.5 5680.8 5733.9 5751.2 5510.6 5558.3 5559.7 5567.9 5605.7 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#1] ext.html Cycles:180 Average:30681.98 Median:3043.65 stddev:41814.28 (1373.8%) stddev-sans-first:41870.84 09:22:21 INFO - PID 26990 | Values: 666.1 738.5 757.4 1052.9 1053.8 31647.8 32724.7 32805.0 32840.8 32843.0 34604.7 34626.7 34847.7 34910.8 35021.0 6859.3 6989.0 7030.9 7051.6 7134.4 7046.6 7081.4 7097.6 7120.3 7131.4 7034.5 7073.6 7117.2 7145.0 7167.3 7036.3 7085.3 7133.5 7137.9 7155.7 6956.7 6970.8 7006.5 7008.6 7021.3 32285.7 32581.5 32642.5 32690.3 32770.8 2992.7 3011.2 3022.1 3038.8 3048.5 24908.3 24938.9 25074.2 25101.2 25130.5 2780.0 2784.9 2800.4 2804.5 2806.2 148464.0 149985.0 153398.0 155833.0 156110.2 40735.2 40935.4 40970.8 41008.4 41027.2 41099.0 41306.4 41355.2 41530.8 41598.0 11627.9 11680.5 11738.4 11747.1 11765.8 9452.2 9480.6 9526.7 9578.7 9583.7 12356.3 12418.4 12479.4 12502.4 12714.6 5224.3 5238.4 5257.0 5368.5 5387.6 863.9 907.9 911.5 913.2 935.3 20753.3 21604.8 21630.0 21838.8 21907.9 973.7 977.4 992.4 1005.4 1013.9 11314.8 11438.3 11459.5 11533.3 11613.3 177378.0 179010.0 179193.2 179508.1 180357.0 42349.6 42360.8 42804.8 42842.0 42853.1 1119.8 1175.7 1177.5 1182.2 1201.3 19540.6 19649.5 20413.0 21040.6 21123.8 29291.1 29430.1 29545.6 29581.3 29659.9 152079.0 152195.2 152823.0 153090.0 153323.2 29212.7 29411.9 29663.4 30874.0 31033.4 36737.3 37119.3 37381.4 37410.6 37413.4 26846.9 27291.3 27411.2 27847.3 28405.4 26818.5 27179.2 27549.0 27727.4 28590.4 30977.5 31057.5 31081.0 31085.4 31127.4 26517.3 26611.0 26863.0 27575.2 27889.3 21707.7 22511.0 22814.8 22836.3 22859.4 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#2] jquery.html Cycles:180 Average:24880.59 Median:368262.00 stddev:60920.37 (16.5%) stddev-sans-first:61063.55 09:22:21 INFO - PID 26990 | Values: 405.3 406.3 411.1 424.0 429.3 13445.9 17266.8 17865.4 17951.6 17965.4 18196.7 18404.2 18598.7 19023.6 19277.8 5361.7 5555.7 5581.9 5604.2 5737.4 5530.2 5606.8 5622.7 5623.9 5633.7 5381.6 5585.2 5585.2 5590.0 5601.7 5501.9 5558.8 5561.4 5562.3 5568.8 4831.2 4980.2 4988.6 5036.0 5041.0 21647.0 21819.0 21834.5 22102.1 22318.3 1609.8 1634.6 1671.2 1684.6 1695.9 14853.2 14922.1 15058.3 15180.2 15240.3 2048.9 2074.0 2120.4 2133.7 2134.0 84679.6 86182.6 86399.1 86458.0 87952.6 10722.6 10899.9 10918.5 11049.3 11108.9 15061.2 15231.5 15283.6 15289.0 15349.8 7168.0 7269.6 7281.3 7428.0 7477.7 6521.3 6592.3 6745.6 6765.1 6812.2 6830.5 6896.4 6980.5 7015.1 7103.5 2038.6 2046.9 2100.4 2125.8 2126.3 836.4 868.7 869.3 870.6 900.4 17024.2 17062.8 17110.4 17318.6 17954.4 862.3 876.6 881.2 882.4 901.1 9448.0 10736.5 11524.3 11545.4 11900.3 350495.0 365325.0 371199.0 371930.0 373011.0 74545.6 74603.0 76878.6 77235.6 79502.6 1064.1 1094.3 1126.3 1132.8 1132.9 17325.7 17645.0 18029.7 19016.1 19215.9 38400.8 39512.8 39805.4 40233.6 40989.6 46779.3 47355.3 48877.0 49090.8 49379.8 8314.5 8316.7 8357.0 8382.6 8410.7 12911.7 12912.5 13176.2 13226.1 13373.7 10983.8 11228.1 11239.3 11408.1 11583.5 10654.4 10861.8 10892.1 10996.2 11037.3 11515.7 11863.0 11885.6 11953.6 12289.2 8314.4 8372.9 8379.8 8486.6 8817.5 11441.9 11477.7 11555.1 11607.8 11974.2 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#3] mootools.html Cycles:180 Average:6206.27 Median:3672.88 stddev:4016.12 (109.3%) stddev-sans-first:4009.94 09:22:21 INFO - PID 26990 | Values: 1223.4 1276.1 1280.8 1291.4 1296.0 9546.4 10034.1 10039.4 10217.3 10525.5 10252.7 10376.5 10413.0 10440.5 10444.1 2107.8 2135.5 2147.5 2147.6 2148.5 2038.1 2045.8 2048.4 2050.3 2066.5 2036.3 2042.1 2055.1 2061.5 2063.3 1973.2 1978.2 1984.5 1990.6 1996.1 1925.5 1935.5 1950.3 2059.7 2062.4 10118.9 10132.1 10160.3 10209.0 10255.9 5356.9 5478.0 5521.6 5551.4 5571.9 3112.9 3319.9 3373.2 3385.4 3396.2 980.6 1000.6 1015.1 1022.8 1032.5 14777.3 14867.7 14889.6 15009.4 15103.5 4424.6 4568.8 4795.2 4816.3 4885.9 10448.4 10656.4 10679.8 10720.8 10726.0 5446.9 5487.7 5489.2 5495.0 5503.8 4858.7 4978.3 4995.4 5116.4 5124.4 3632.6 3668.6 3677.2 3726.9 3754.3 1034.8 1042.1 1048.4 1050.8 1057.4 696.3 720.2 720.6 726.8 736.5 5401.9 5413.5 5527.4 5609.6 5626.5 537.9 542.6 547.6 556.0 564.4 3429.5 3773.5 3848.1 3962.2 4022.7 12492.4 12717.2 13231.3 13292.3 13330.5 13079.3 13187.8 13193.6 13202.5 13361.9 7534.5 7545.4 7785.5 7789.1 7819.3 6045.9 6187.8 6239.0 6250.3 6278.4 11327.1 11423.8 11483.8 11500.5 11676.1 11565.4 11672.8 11687.3 11852.6 11910.2 8195.9 8286.1 8338.8 8348.2 8368.2 9261.0 9402.2 9440.6 9538.9 9586.1 7947.0 8023.4 8039.5 8072.2 8223.1 7890.8 7929.4 7934.1 7968.5 8101.5 7486.0 7496.8 7513.9 7544.2 7620.5 4976.7 5284.2 5365.8 5384.4 5389.3 5373.5 5413.4 5445.6 5468.7 5581.7 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#4] prototype.html Cycles:180 Average:4820.57 Median:5509.00 stddev:1461.16 (26.5%) stddev-sans-first:1426.07 09:22:21 INFO - PID 26990 | Values: 341.9 364.2 364.8 368.1 370.9 5485.8 5699.6 5704.5 5705.4 5707.8 5397.1 5434.7 5491.2 5504.3 5513.8 4103.3 4115.9 4125.8 4130.2 4143.0 4075.9 4129.5 4148.7 4155.3 4164.5 4073.5 4079.6 4080.4 4088.9 4105.6 4068.9 4073.7 4089.7 4092.2 4094.4 3544.0 3561.9 3571.8 3575.7 3582.1 5325.2 5343.8 5365.5 5406.6 5448.5 4840.8 4862.8 4864.2 4865.7 4894.2 5755.8 5869.4 5870.9 5880.7 5903.7 3993.3 4005.9 4008.8 4024.3 4034.7 6067.0 6184.2 6199.7 6215.2 6252.7 4085.8 4088.8 4092.9 4100.4 4100.8 4137.6 4142.6 4148.4 4151.4 4160.9 4720.3 4766.3 4812.5 4812.7 4834.8 5849.8 5850.6 5867.1 5870.3 5886.7 1417.0 1424.3 1425.2 1425.6 1434.2 940.6 943.9 952.4 954.2 960.0 5096.0 5106.3 5113.4 5114.9 5127.9 6089.5 6090.9 6109.1 6117.8 6137.0 4978.4 5055.2 5059.5 5080.7 5096.7 3226.8 3256.6 3259.0 3259.4 3261.7 5490.8 5632.3 5649.7 5658.4 5660.9 6201.0 6217.8 6219.4 6228.8 6230.8 5624.9 5656.7 5669.0 5672.1 5689.6 5944.5 6062.8 6072.6 6096.6 6114.1 5850.4 6001.7 6016.5 6043.3 6049.2 5639.2 5681.2 5688.5 5689.5 5695.3 4081.7 4104.5 4107.8 4111.3 4126.1 6012.8 6146.7 6183.0 6191.6 6199.4 5903.0 5952.6 5959.6 5967.7 5985.8 5804.7 5954.2 5964.4 5985.4 5999.0 5769.7 5773.4 5823.9 5831.3 5838.4 5963.4 6003.2 6009.9 6029.5 6030.5 5635.2 5766.2 5783.4 5805.0 5844.5 09:22:21 INFO - PID 26990 | 09:22:21 INFO - PID 26990 | [#5] yui.html Cycles:180 Average:15015.07 Median:4621.04 stddev:18405.89 (398.3%) stddev-sans-first:18426.26 09:22:21 INFO - PID 26990 | Values: 728.7 745.7 749.1 754.3 762.3 12419.6 13221.9 13323.0 14252.9 14263.4 13141.5 13573.3 13595.5 13632.1 13728.4 813.7 824.8 830.0 835.1 836.3 881.6 889.3 894.8 895.2 895.8 906.5 910.1 919.7 920.0 923.7 907.2 914.9 915.0 915.3 916.2 670.4 673.0 674.2 675.1 675.7 13053.7 13551.5 13665.5 15092.2 15191.8 15508.8 15511.2 15709.2 15779.9 15809.5 11728.8 11818.8 11888.9 11966.4 12011.3 2678.8 2679.8 2687.2 2691.4 2721.4 63356.7 67698.0 67790.0 68205.0 68834.7 12801.4 13139.5 13188.9 13245.9 13321.3 23189.1 23265.5 23476.9 23597.2 23727.4 6112.2 6315.1 6315.5 6374.7 6510.2 2887.7 2946.0 2946.8 2959.2 2966.8 3297.5 3381.1 3384.7 3387.4 3522.2 721.5 732.7 737.3 745.1 745.8 608.0 621.8 629.0 629.9 652.3 9579.8 9909.3 10027.3 10183.0 10446.7 594.7 595.7 605.6 605.7 613.8 4508.3 4583.6 4612.9 4629.2 4683.8 66180.7 66809.3 67566.0 68115.7 70251.3 57152.4 57345.0 57345.0 58226.7 60336.7 52591.2 53504.7 53992.5 54391.0 54826.5 8855.9 9127.2 9158.9 9398.6 9601.2 28235.0 28727.7 28739.6 28818.6 29218.6 33450.5 33534.0 33781.2 33832.5 35012.0 12108.2 12185.8 12340.1 12399.3 12533.7 12951.2 13091.0 13159.1 13258.4 13416.3 12132.9 12219.8 12274.5 12381.4 12511.9 10911.6 11043.3 11055.6 11093.5 11213.5 12307.3 12497.9 12582.7 12660.1 12842.8 8014.9 8330.4 8349.7 8427.1 8560.0 9636.0 9655.7 9730.6 9889.6 9922.8 09:22:21 INFO - PID 26990 | -------- Summary: end -------- 09:22:21 INFO - PID 26990 | 09:22:22 INFO - TEST-INFO | 26990: exit 0 09:22:22 INFO - TEST-OK | dromaeo_css | took 1120064ms 09:22:22 INFO - TEST-START | kraken 09:22:22 INFO - operating with platform_type : linux_ 09:22:22 INFO - Initialising browser for kraken test... 09:22:22 INFO - TEST-INFO | started process 27418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmposFkub/profile http://localhost:33001/getInfo.html) 09:22:27 INFO - PID 27418 | __metrics Screen width/height:1600/1200 09:22:27 INFO - PID 27418 | colorDepth:24 09:22:27 INFO - PID 27418 | Browser inner width/height: 1024/695 09:22:27 INFO - PID 27418 | __metrics 09:22:29 INFO - TEST-INFO | 27418: exit 0 09:22:29 INFO - Browser initialized. 09:22:29 INFO - Running cycle 1/1 for kraken test... 09:22:29 INFO - TEST-INFO | started process 27587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmposFkub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:41 INFO - PID 27587 | RSS: Main: 160456704 09:22:41 INFO - PID 27587 | 09:22:43 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33001/tests/kraken/driver.html?testName=audio-beat-detection) 09:22:44 INFO - PID 27587 | RSS: Main: 165920768 09:22:44 INFO - PID 27587 | 09:22:47 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33001/tests/kraken/driver.html?testName=audio-dft) 09:22:48 INFO - PID 27587 | RSS: Main: 164126720 09:22:48 INFO - PID 27587 | 09:22:51 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33001/tests/kraken/driver.html?testName=audio-fft) 09:22:51 INFO - PID 27587 | RSS: Main: 160890880 09:22:51 INFO - PID 27587 | 09:22:53 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33001/tests/kraken/driver.html?testName=audio-oscillator) 09:22:54 INFO - PID 27587 | RSS: Main: 161792000 09:22:54 INFO - PID 27587 | 09:22:56 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:22:57 INFO - PID 27587 | RSS: Main: 162070528 09:22:57 INFO - PID 27587 | 09:23:00 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33001/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:00 INFO - PID 27587 | RSS: Main: 167391232 09:23:00 INFO - PID 27587 | 09:23:04 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33001/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:05 INFO - PID 27587 | RSS: Main: 164749312 09:23:05 INFO - PID 27587 | 09:23:08 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33001/tests/kraken/driver.html?testName=json-parse-financial) 09:23:08 INFO - PID 27587 | RSS: Main: 165605376 09:23:08 INFO - PID 27587 | 09:23:10 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:10 INFO - PID 27587 | RSS: Main: 166047744 09:23:10 INFO - PID 27587 | 09:23:12 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:13 INFO - PID 27587 | RSS: Main: 166236160 09:23:13 INFO - PID 27587 | 09:23:15 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:16 INFO - PID 27587 | RSS: Main: 166412288 09:23:16 INFO - PID 27587 | 09:23:18 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:19 INFO - PID 27587 | RSS: Main: 166572032 09:23:19 INFO - PID 27587 | 09:23:22 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:23 INFO - PID 27587 | RSS: Main: 166428672 09:23:23 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | Cycle 1(1): loaded http://localhost:33001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33001/tests/kraken/driver.html?testName=ai-astar) 09:23:25 INFO - PID 27587 | RSS: Main: 168177664 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | __start_tp_report 09:23:25 INFO - PID 27587 | _x_x_mozilla_page_load 09:23:25 INFO - PID 27587 | _x_x_mozilla_page_load_details 09:23:25 INFO - PID 27587 | |i|pagename|runs| 09:23:25 INFO - PID 27587 | |0;ai-astar;104;111;112;113;113;112;112;112;113;111 09:23:25 INFO - PID 27587 | |1;audio-beat-detection;166;126;126;166;124;129;124;124;148;127 09:23:25 INFO - PID 27587 | |2;audio-dft;166;167;168;168;170;167;169;164;163;164 09:23:25 INFO - PID 27587 | |3;audio-fft;74;76;74;118;75;76;75;78;105;75 09:23:25 INFO - PID 27587 | |4;audio-oscillator;84;86;111;84;83;84;114;83;84;100 09:23:25 INFO - PID 27587 | |5;imaging-gaussian-blur;115;115;115;114;113;113;115;117;115;114 09:23:25 INFO - PID 27587 | |6;imaging-darkroom;151;150;153;152;149;150;151;150;151;151 09:23:25 INFO - PID 27587 | |7;imaging-desaturate;95;95;96;95;95;94;96;94;95;94 09:23:25 INFO - PID 27587 | |8;json-parse-financial;54;54;54;55;54;58;56;54;56;55 09:23:25 INFO - PID 27587 | |9;json-stringify-tinderbox;56;55;55;56;55;56;56;56;56;55 09:23:25 INFO - PID 27587 | |10;stanford-crypto-aes;82;81;81;82;82;83;82;82;83;80 09:23:25 INFO - PID 27587 | |11;stanford-crypto-ccm;135;133;132;129;136;130;131;131;177;129 09:23:25 INFO - PID 27587 | |12;stanford-crypto-pbkdf2;185;188;188;189;197;193;191;194;185;181 09:23:25 INFO - PID 27587 | |13;stanford-crypto-sha256-iterative;77;74;75;70;72;69;72;71;70;70 09:23:25 INFO - PID 27587 | __end_tp_report 09:23:25 INFO - PID 27587 | __start_cc_report 09:23:25 INFO - PID 27587 | _x_x_mozilla_cycle_collect,833 09:23:25 INFO - PID 27587 | __end_cc_report 09:23:25 INFO - PID 27587 | __startTimestamp1493915005351__endTimestamp 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | ------- Summary: start ------- 09:23:25 INFO - PID 27587 | Number of tests: 14 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 09:23:25 INFO - PID 27587 | Values: 104.0 111.0 112.0 113.0 113.0 112.0 112.0 112.0 113.0 111.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.00 stddev:17.34 (13.5%) stddev-sans-first:14.60 09:23:25 INFO - PID 27587 | Values: 166.0 126.0 126.0 166.0 124.0 129.0 124.0 124.0 148.0 127.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#2] audio-dft Cycles:10 Average:166.60 Median:167.50 stddev:2.32 (1.4%) stddev-sans-first:2.45 09:23:25 INFO - PID 27587 | Values: 166.0 167.0 168.0 168.0 170.0 167.0 169.0 164.0 163.0 164.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:15.58 (20.8%) stddev-sans-first:16.21 09:23:25 INFO - PID 27587 | Values: 74.0 76.0 74.0 118.0 75.0 76.0 75.0 78.0 105.0 75.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:84.00 stddev:12.28 (14.6%) stddev-sans-first:12.74 09:23:25 INFO - PID 27587 | Values: 84.0 86.0 111.0 84.0 83.0 84.0 114.0 83.0 84.0 100.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.17 (1.0%) stddev-sans-first:1.24 09:23:25 INFO - PID 27587 | Values: 115.0 115.0 115.0 114.0 113.0 113.0 115.0 117.0 115.0 114.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 09:23:25 INFO - PID 27587 | Values: 151.0 150.0 153.0 152.0 149.0 150.0 151.0 150.0 151.0 151.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 09:23:25 INFO - PID 27587 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 96.0 94.0 95.0 94.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.33 (2.4%) stddev-sans-first:1.36 09:23:25 INFO - PID 27587 | Values: 54.0 54.0 54.0 55.0 54.0 58.0 56.0 54.0 56.0 55.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 09:23:25 INFO - PID 27587 | Values: 56.0 55.0 55.0 56.0 55.0 56.0 56.0 56.0 56.0 55.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:0.92 (1.1%) stddev-sans-first:0.97 09:23:25 INFO - PID 27587 | Values: 82.0 81.0 81.0 82.0 82.0 83.0 82.0 82.0 83.0 80.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#11] stanford-crypto-ccm Cycles:10 Average:136.30 Median:132.50 stddev:14.49 (10.9%) stddev-sans-first:15.36 09:23:25 INFO - PID 27587 | Values: 135.0 133.0 132.0 129.0 136.0 130.0 131.0 131.0 177.0 129.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:190.00 stddev:4.79 (2.5%) stddev-sans-first:4.85 09:23:25 INFO - PID 27587 | Values: 185.0 188.0 188.0 189.0 197.0 193.0 191.0 194.0 185.0 181.0 09:23:25 INFO - PID 27587 | 09:23:25 INFO - PID 27587 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:2.58 (3.6%) stddev-sans-first:2.01 09:23:25 INFO - PID 27587 | Values: 77.0 74.0 75.0 70.0 72.0 69.0 72.0 71.0 70.0 70.0 09:23:25 INFO - PID 27587 | -------- Summary: end -------- 09:23:25 INFO - PID 27587 | 09:23:26 INFO - TEST-INFO | 27587: exit 0 09:23:26 INFO - TEST-OK | kraken | took 64402ms 09:23:26 INFO - SUITE-END | took 1184s 09:23:27 INFO - Completed test suite (00:19:44) 09:23:27 INFO - javascript benchmark 09:23:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6695.881095732858, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2749.436365545063, 2755.2009917124037, 2771.1270949650857, 2799.160251924422, 2805.579163125531, 5284.365876094874, 5312.389075256347, 5318.441563635821, 5400.108982017962, 5404.648697834638, 5353.437889021655, 5366.973165134169, 5372.489613486712, 5450.945490545093, 5470.206820011096, 4411.828689939235, 4677.649176311773, 4681.0871879983415, 4697.201475749113, 4703.412073490814, 4757.191277482836, 4766.285057241407, 4795.712257264575, 4796.232602783555, 4810.807567697288, 4676.6960147590635, 4688.64835137366, 4733.621310295202, 4740.786664600101, 4753.619710423158, 4773.284007398884, 4774.212254977924, 4775.188218002913, 4800.039992001613, 4840.491748366441, 4720.221163508017, 4748.4539277982785, 4758.95241047592, 4766.475687674353, 4782.713037217778, 5253.737313134328, 5318.574514038867, 5323.068463018956, 5388.865278368072, 5397.78408863645, 5788.363280039192, 5792.247007888989, 5835.766569337221, 5840.211571437844, 5859.29688437386, 5823.388544202882, 5828.096645019987, 5835.5915085944, 5839.620424672383, 5840.445157710011, 5302.602304827154, 5369.812056578001, 5390.460953904578, 5402.216678581663, 5412.783488660488, 5933.554983376264, 6019.849503762353, 6033.849153771103, 6037.0, 6056.757729690763, 5656.971715141481, 5737.684427356536, 5749.798757043567, 5779.075347944308, 5787.334456537468, 5746.626469279484, 5827.388124246893, 5830.970845145747, 5837.299524057055, 5847.8245652630485, 5648.322201335784, 5729.88540229193, 5806.65160090396, 5810.1865738796605, 5810.62230954995, 5746.683932383759, 5793.420657934257, 5793.710314484259, 5835.270591176103, 5849.532037436995, 4813.3983252092785, 4831.4685384607665, 4837.806487740521, 4845.63657725672, 4885.828995985124, 4049.655779258737, 4080.7959602019782, 4122.2579935611875, 4123.2165888481695, 4167.562405947332, 4923.852284431473, 4927.90144197114, 4973.676711013773, 4982.77577509013, 4995.575376093073, 5888.263967004124, 5892.528597712173, 5924.7926322578505, 5937.0, 5943.435373639497, 4947.381577302837, 4954.256861470808, 4957.826476073392, 4967.602591792648, 5001.8499445016705, 5085.415177254589, 5175.430702622709, 5183.766730497136, 5201.869953251199, 5205.55752761012, 5279.023380674587, 5332.013577488177, 5333.43998880112, 5342.225377320345, 5351.411344752152, 5756.913646295226, 5801.129830525286, 5801.94198058014, 5808.36108028125, 5812.534997200299, 5417.83746487606, 5435.130379139318, 5443.591730620298, 5455.099908515209, 5483.314585676791, 5756.56825738063, 5764.711764411846, 5767.077267637158, 5774.595778295479, 5776.797812076557, 5716.171155182558, 5850.297964244318, 5867.882642347215, 5870.412958704095, 5877.147813566923, 5578.9163162553405, 5599.0, 5681.17622944679, 5682.034054210877, 5710.114932185518, 5634.887302254014, 5657.43425657431, 5661.66030038199, 5686.83419898928, 5696.971515142398, 5480.972595137158, 5548.944510554843, 5558.277423934863, 5563.193336966036, 5568.415316391883, 5614.859628509156, 5664.49019588239, 5680.801171958961, 5733.8566535836935, 5751.194832723506, 5510.641808282448, 5558.305211848519, 5559.694216818114, 5567.916481252703, 5605.663660180402], "value": 5253.9260001634075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.1406785247032, 738.4683028219681, 757.371381753145, 1052.9052385285322, 1053.826118690416, 31647.841760791194, 32724.67275327246, 32805.0, 32840.83579582105, 32843.014709558694, 34604.65395346046, 34626.653733462656, 34847.65152348476, 34910.82544587273, 35021.0, 6859.279775623562, 6989.021536984839, 7030.85938281234, 7051.612161331124, 7134.429245660334, 7046.577205367668, 7081.398081163107, 7097.609631470267, 7120.323569260938, 7131.358177764, 7034.472414568902, 7073.646317684121, 7117.217106118349, 7144.964275178643, 7167.2832716728435, 7036.296370362948, 7085.326893945093, 7133.500654954155, 7137.857242855166, 7155.749548765768, 6956.65216739161, 6970.79087627372, 7006.544574602685, 7008.614526201057, 7021.262767409399, 32285.677143228502, 32581.511277330857, 32642.510362344583, 32690.346193076242, 32770.836145819354, 2992.670806211315, 3011.2020314616643, 3022.0933719883947, 3038.8328641924686, 3048.4665183592783, 24908.252752417455, 24938.875305623536, 25074.24777256685, 25101.24696259115, 25130.497390052096, 2779.958300625492, 2784.9303767405772, 2800.4399120175844, 2804.5372513535244, 2806.1581525542256, 148464.0, 149985.0, 153398.0, 155833.0, 156110.21944890203, 40735.18529629391, 40935.38596921049, 40970.79514602408, 41008.359665613636, 41027.1794564113, 41099.0, 41306.38040429396, 41355.1728965419, 41530.79234603808, 41598.0, 11627.941860290814, 11680.532778688927, 11738.354390508604, 11747.060235181165, 11765.823512647317, 9452.196563292197, 9480.573374198178, 9526.666566670134, 9578.664746733832, 9583.664571739955, 12356.320402377776, 12418.441170147365, 12479.438425270884, 12502.437390317458, 12714.554990575285, 5224.268602395668, 5238.397584277781, 5257.0, 5368.516833485005, 5387.649802762808, 863.8747381629629, 907.9228265597366, 911.5396724654007, 913.1918252346721, 935.2891802230354, 20753.27363542299, 21604.783952160593, 21630.0, 21838.781612183673, 21907.890460547595, 973.6884197057016, 977.4184360305607, 992.3946392700446, 1005.4014117553126, 1013.8935411781657, 11314.773704526027, 11438.256513326607, 11459.484323205475, 11533.308001519936, 11613.30320180792, 177378.0, 179010.0, 179193.18471560298, 179508.10245948686, 180357.0, 42349.57650423457, 42360.78819605882, 42804.78597607054, 42842.0, 42853.1429371417, 1119.7536541960756, 1175.717827721358, 1177.4701384376892, 1182.2138278045004, 1201.2672269915345, 19540.609187816448, 19649.508762281057, 20413.0, 21040.57918841584, 21123.78876211218, 29291.121266362043, 29430.117096487138, 29545.55681664734, 29581.26046848846, 29659.851700741357, 152079.0, 152195.23902380417, 152823.0, 153090.0, 153323.23338383235, 29212.70787292185, 29411.85294073516, 29663.406731865674, 30874.0, 31033.37933241368, 36737.26525469529, 37119.257614848095, 37381.439278410304, 37410.6258937418, 37413.43879841859, 26846.865765671046, 27291.317717056438, 27411.177664670093, 27847.30381740473, 28405.43189136247, 26818.463630726885, 27179.184624461297, 27549.0, 27727.44545109127, 28590.42819143564, 30977.53533696951, 31057.534136988415, 31081.0, 31085.378292434478, 31127.377452451277, 26517.33706657349, 26611.0, 26863.0, 27575.172744817686, 27889.302767430978, 21707.674384884554, 22511.0, 22814.771852281265, 22836.31491055271, 22859.42851428661], "value": 14510.293634725478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.28669541606763, 406.2524954084484, 411.0832842760645, 423.9597238262364, 429.2830972276298, 13445.865541344609, 17266.82733172668, 17865.374711885088, 17951.55121121971, 17965.371212007583, 18196.727049094276, 18404.171812268447, 18598.72101918469, 19023.61952760944, 19277.80722192778, 5361.731913404334, 5555.666660000393, 5581.888362232753, 5604.187392828037, 5737.397573254811, 5530.198121272413, 5606.831795046155, 5622.662640241578, 5623.887522249553, 5633.746481408347, 5381.623286369956, 5585.162225666162, 5585.190147428621, 5589.993801115797, 5601.747921343549, 5501.9174712379345, 5558.805441809517, 5561.443855614447, 5562.332520097574, 5568.805091821767, 4831.202851529493, 4980.228064649985, 4988.551030407244, 5036.043151801146, 5041.0422019816115, 21647.0, 21819.0, 21834.454138646503, 22102.115915363367, 22318.330450086523, 1609.8309677483812, 1634.558669159332, 1671.1727694791034, 1684.6209602839385, 1695.8982461052376, 14853.183074930874, 14922.104673719503, 15058.32237549313, 15180.240987950558, 15240.314185861664, 2048.907799149027, 2073.968890466644, 2120.4380839077658, 2133.7332833395826, 2134.039682143042, 84679.57660211659, 86182.56908715478, 86399.13600863973, 86458.0, 87952.56023719904, 10722.571097156026, 10899.945500272606, 10918.454077296263, 11049.33703977764, 11108.944650258212, 15061.246937653294, 15231.466898658493, 15283.61790955235, 15289.0, 15349.846501535065, 7167.987015878853, 7269.645839044958, 7281.308275713799, 7427.962860185665, 7477.7008919643695, 6521.282658907517, 6592.340765923369, 6745.561538499982, 6765.05289259504, 6812.182538095461, 6830.487713421513, 6896.448284137257, 6980.546264492792, 7015.123109611299, 7103.502754807114, 2038.6057214737593, 2046.9181232750523, 2100.4328831215485, 2125.8405619578593, 2126.277065797636, 836.3768992100923, 868.6525389843987, 869.3045563549261, 870.634333579898, 900.4417261298037, 17024.233909473856, 17062.82937170637, 17110.401135960183, 17318.567035823955, 17954.371596994042, 862.2799962031648, 876.5573385440312, 881.1937077574077, 882.4176043811182, 901.0808974845621, 9448.0, 10736.516856741466, 11524.308541487537, 11545.36500492481, 11900.285982841056, 350495.0, 365325.0, 371199.0, 371930.0, 373011.0, 74545.6272718633, 74603.0, 76878.61560692161, 77235.61382193165, 79502.60248698719, 1064.122099268107, 1094.3379255550278, 1126.3354620773619, 1132.824412216108, 1132.932024078558, 17325.65348693044, 17645.0, 18029.72955405696, 19016.098390160874, 19215.90392048031, 38400.80799595984, 39512.802435987636, 39805.40291895682, 40233.597664022986, 40989.59010409858, 46779.29831052469, 47355.28967065428, 48877.02245955132, 49090.75454622704, 49379.753101234266, 8314.459560128573, 8316.667333306841, 8357.027568596675, 8382.622781974704, 8410.747677569683, 12911.741765164832, 12912.548060817826, 13176.209427434385, 13226.082218078132, 13373.732525349244, 10983.835242471529, 11228.10175185967, 11239.269447486215, 11408.144389171011, 11583.536658533565, 10654.414007229676, 10861.78276434451, 10892.128629709447, 10996.175286853359, 11037.337759734442, 11515.712107197387, 11863.0, 11885.643430697093, 11953.581624643095, 12289.201201921847, 8314.376421768271, 8372.874406884024, 8379.832403351777, 8486.618102185294, 8817.515036673045, 11441.885581144083, 11477.655670329903, 11555.133364997491, 11607.76784464323, 11974.161808673309], "value": 8954.230592634678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.4494477485132, 1276.0557187681118, 1280.7502537005287, 1291.3865913690993, 1295.96760080998, 9546.377115890298, 10034.147097496721, 10039.397636141828, 10217.28479006468, 10525.473726313692, 10252.692419227435, 10376.533056012478, 10413.0, 10440.477976101203, 10444.112250458702, 2107.7576078750985, 2135.540858715376, 2147.5060736030723, 2147.6349020666526, 2148.5488047510044, 2038.1236068490543, 2045.7851925547827, 2048.385484354688, 2050.339225227563, 2066.545360020793, 2036.2567662803044, 2042.1014753508482, 2055.054674849571, 2061.494933741228, 2063.3191046954544, 1973.1614064022876, 1978.2186036515568, 1984.484034151124, 1990.6118306930155, 1996.1316827180078, 1925.4801203674929, 1935.525796179931, 1950.288144827142, 2059.742532183477, 2062.360668192865, 10118.89881101187, 10132.088112069949, 10160.288779785418, 10209.0, 10255.897441025569, 5356.866078348073, 5477.972610136963, 5521.641093328961, 5551.361593416768, 5571.8885622287735, 3112.9066128016198, 3319.867205311785, 3373.224158443572, 3385.356782211372, 3396.218869659992, 980.6371642492252, 1000.564754331868, 1015.0661391519745, 1022.7954409118132, 1032.4992378696327, 14777.26113694311, 14867.702645947129, 14889.627759305995, 15009.399624015026, 15103.4713785017, 4424.646028317727, 4568.840090596879, 4795.20879054959, 4816.301636262722, 4885.902281954341, 10448.373097614167, 10656.413897235727, 10679.786404272027, 10720.785584288271, 10726.034656880918, 5446.8910621787345, 5487.6981766002455, 5489.231507588941, 5494.972525137348, 5503.752331145028, 4858.708477491362, 4978.303037574742, 4995.350604421402, 5116.386033675983, 5124.359455068116, 3632.6185750495815, 3668.596454390015, 3677.1726361568435, 3726.869559565402, 3754.2679177560112, 1034.8395998620226, 1042.135027926819, 1048.418127938986, 1050.7740835720356, 1057.360297020307, 696.3245651717825, 720.1753991679498, 720.5748608321115, 726.81466226112, 736.4623824608066, 5401.864953376197, 5413.458654134633, 5527.364353099445, 5609.607327487037, 5626.549876009909, 537.8574677710332, 542.5930552085936, 547.5646860745717, 556.0325034440126, 564.3650892745661, 3429.4855771633956, 3773.4528493368307, 3848.114933565296, 3962.2075584882564, 4022.738521996061, 12492.375381230902, 12717.173383730213, 13231.338433078308, 13292.268925209206, 13330.533431329857, 13079.280639564726, 13187.802182967263, 13193.60419187426, 13202.537911173064, 13361.933190333986, 7534.472586918972, 7545.434092443198, 7785.493942893694, 7789.143194248742, 7819.257170568787, 6045.879082418415, 6187.84530386744, 6239.0, 6250.281217660027, 6278.434940855345, 11327.093832493216, 11423.828642570534, 11483.770324593628, 11500.482478288664, 11676.124290678063, 11565.421728913689, 11672.824907626222, 11687.298762074302, 11852.644420667393, 11910.166288359731, 8195.918040819515, 8286.129956354496, 8338.833223335621, 8348.165183481604, 8368.20502052304, 9261.0, 9402.200812930978, 9440.575174117044, 9538.904610953801, 9586.089321514444, 7946.960265198637, 8023.358131349595, 8039.477433966774, 8072.152423995396, 8223.09545949957, 7890.763277101696, 7929.365650748042, 7934.135478162511, 7968.521888686697, 8101.473404228706, 7485.962570187115, 7496.7750967471065, 7513.924860751541, 7544.170141284345, 7620.542767433972, 4976.701397916137, 5284.154535274338, 5365.812196573102, 5384.407715151408, 5389.27244821944, 5373.462653734595, 5413.431589683027, 5445.618806683494, 5468.699221542854, 5581.6930068846605], "value": 4597.336824304038, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.91793969447326, 364.19149488136327, 364.79936035180646, 368.1257014590348, 370.85536640710126, 5485.780568777244, 5699.572532060101, 5704.515116215121, 5705.4294570542925, 5707.800226992056, 5397.055515284829, 5434.701091439969, 5491.176323551469, 5504.256925315081, 5513.751881165347, 4103.261412945669, 4115.897102572437, 4125.834966601333, 4130.2359063573185, 4142.958570414303, 4075.8777236682945, 4129.504459464853, 4148.668106551484, 4155.314373128445, 4164.479440069991, 4073.4500842386196, 4079.5920407959266, 4080.4083407905837, 4088.9164371441593, 4105.624615753726, 4068.8982775430554, 4073.714839961204, 4089.672826173899, 4092.2224777292217, 4094.3858421236755, 3543.982280088609, 3561.893143205708, 3571.767835090711, 3575.659127827065, 3582.0686621478344, 5325.174597937326, 5343.839684809462, 5365.517103460707, 5406.59450541211, 5448.536874365684, 4840.782164802557, 4862.805487780484, 4864.173090574611, 4865.683730557538, 4894.216925291972, 5755.848830233928, 5869.383714709979, 5870.911936320958, 5880.6765627890445, 5903.734331955029, 3993.341098718708, 4005.8798236052676, 4008.83964641414, 4024.2555127301544, 4034.6570541504007, 6066.998945174041, 6184.196054512884, 6199.659018753967, 6215.1609532712955, 6252.6873656317, 4085.7957102144774, 4088.8364465421646, 4092.856750013735, 4100.36444351126, 4100.753954762724, 4137.565555616678, 4142.597293569723, 4148.439960605279, 4151.398047283127, 4160.875173744793, 4720.33915251865, 4766.285057241442, 4812.494688057774, 4812.735299558558, 4834.7824347904425, 5849.7952571660635, 5850.5612079094235, 5867.119932010147, 5870.3249126350165, 5886.735096920649, 1416.9514559226304, 1424.3193032222077, 1425.180521200314, 1425.5652026131922, 1434.189682829198, 940.6237504997919, 943.8914524829732, 952.4047470331043, 954.160338901762, 959.9856002159974, 5095.97452012745, 5106.336176297058, 5113.360829896263, 5114.897702045938, 5127.948720512822, 6089.472868759503, 6090.878182436415, 6109.14471973924, 6117.755289788359, 6137.0, 4978.377702787152, 5055.191169412877, 5059.46875578059, 5080.669756465818, 5096.668716533413, 3226.790258633181, 3256.5929258842643, 3258.9734233716304, 3259.445894197992, 3261.706446419786, 5490.831121706903, 5632.267805185382, 5649.728811017489, 5658.415643619793, 5660.924424359358, 6200.968995155085, 6217.813465596039, 6219.378062193744, 6228.813135605939, 6230.7819226326865, 5624.85937851557, 5656.717164141776, 5668.971655141698, 5672.149177623307, 5689.630174038674, 5944.524438044859, 6062.818115456544, 6072.635641861502, 6096.5732398733435, 6114.144019837316, 5850.3857095006115, 6001.699915004319, 6016.4585187331595, 6043.335233124265, 6049.183360246487, 5639.210510528611, 5681.204631351697, 5688.544916406595, 5689.487946084872, 5695.259616250027, 4081.7346872453195, 4104.507459104927, 4107.753534787922, 4111.321631930698, 4126.051008268175, 6012.789552365646, 6146.692665366803, 6183.0107182852325, 6191.597546159485, 6199.357170349771, 5903.0, 5952.553558483044, 5959.582829201914, 5967.671778052249, 5985.790497332572, 5804.709764511842, 5954.183973888005, 5964.4035596441745, 5985.431384018511, 5999.020323293215, 5769.711514424178, 5773.364929857797, 5823.854403639943, 5831.329397119385, 5838.357780644041, 5963.433473820153, 6003.219581454383, 6009.918214721392, 6029.547783916136, 6030.48740857032, 5635.239242702182, 5766.194311754222, 5783.421657834183, 5804.9709751452665, 5844.503217226584], "value": 4360.322858628888, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.6903066196865, 745.6942653512059, 749.0561892016061, 754.2721273970617, 762.3101093510373, 12419.56531521397, 13221.867781322184, 13323.0, 14252.928735356321, 14263.358148883286, 13141.54004609839, 13573.321333933312, 13595.456181752743, 13632.113912595674, 13728.382222799974, 813.7355359508153, 824.8185399212164, 829.9585020748968, 835.0772396501869, 836.2766207230732, 881.5944665453899, 889.253027456936, 894.8434024045766, 895.1809094678362, 895.7626229049307, 906.4833045164258, 910.0671811393308, 919.6551293265026, 919.9632014719404, 923.7090316550299, 907.1790030022806, 914.940528865625, 914.9862752058724, 915.3272344826547, 916.2166347772625, 670.4033410264868, 672.9629870357128, 674.150570281449, 675.1088563096714, 675.6689222281096, 13053.738925221442, 13551.457941682322, 13665.521706740217, 15092.245387730569, 15191.848081519154, 15508.844911550854, 15511.224438778128, 15709.21453927299, 15779.921100394424, 15809.525714228477, 11728.765424691544, 11818.763624727457, 11888.881111188864, 11966.401679916056, 12011.279323240633, 2678.7589116979566, 2679.7856171506232, 2687.220705995259, 2691.448253108108, 2721.4421043685998, 63356.68321658408, 67698.0, 67790.0, 68205.0, 68834.65582672054, 12801.359932003363, 13139.474421023053, 13188.934055329662, 13245.867541324656, 13321.33393330349, 23189.072437102328, 23265.534689306118, 23476.94353754085, 23597.174098906456, 23727.406814829767, 6112.235970503687, 6315.147455093595, 6315.463185629181, 6374.713137908805, 6510.153680021567, 2887.7112288771373, 2945.955810662842, 2946.7789915755975, 2959.1566403575307, 2966.777491688132, 3297.5218593304317, 3381.0702056934538, 3384.729221662261, 3387.4410722230555, 3522.1546828761425, 721.5490318550906, 732.7362149626131, 737.259054650084, 745.0537816972522, 745.7799949015053, 607.9544034197453, 621.8414304352361, 628.9622622642656, 629.8929182039064, 652.3118110393581, 9579.760505987406, 9909.306348555676, 10027.348222365523, 10183.0, 10446.68659940203, 594.6610432053774, 595.675356930474, 605.6093819486495, 605.6608299352376, 613.7606333529927, 4508.323751437245, 4583.633309335245, 4612.907741845144, 4629.171477266461, 4683.7892294846815, 66180.66909665517, 66809.33190668128, 67566.0, 68115.65942170356, 70251.2974870255, 57152.42847571554, 57345.0, 57345.0, 58226.708866455396, 60336.69831650814, 52591.21113183305, 53504.73247633815, 53992.460075399526, 54391.0, 54826.45173548293, 8855.911440885766, 9127.224185944004, 9158.908410915805, 9398.624055037722, 9601.183899368632, 28235.0, 28727.712722872504, 28739.568906466, 28818.567721484615, 29218.561721574617, 33450.49824252589, 33534.0, 33781.15547111243, 33832.49251261184, 35012.0, 12108.152429329863, 12185.756284874076, 12340.074494413135, 12399.318037508023, 12533.74932501363, 12951.158174718614, 13091.0, 13159.144655597738, 13258.403371848097, 13416.262105584286, 12132.939335303266, 12219.816702749644, 12274.509019639114, 12381.442835072623, 12511.874881251071, 10911.563537458413, 11043.337399756041, 11055.613053543088, 11093.50079246452, 11213.495392707184, 12307.26156430617, 12497.937510312753, 12582.748345033231, 12660.11379203447, 12842.807357889453, 8014.879776803236, 8330.375221858507, 8349.749507514784, 8427.115152908857, 8560.0, 9636.036396360309, 9655.710328690151, 9730.610775568897, 9889.604415823575, 9922.751931201778], "value": 6585.686643901536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 126.0, 126.0, 166.0, 124.0, 129.0, 124.0, 124.0, 148.0, 127.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 168.0, 168.0, 170.0, 167.0, 169.0, 164.0, 163.0, 164.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 118.0, 75.0, 76.0, 75.0, 78.0, 105.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 111.0, 84.0, 83.0, 84.0, 114.0, 83.0, 84.0, 100.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 113.0, 113.0, 115.0, 117.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 153.0, 152.0, 149.0, 150.0, 151.0, 150.0, 151.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 58.0, 56.0, 54.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0, 83.0, 80.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 132.0, 129.0, 136.0, 130.0, 131.0, 131.0, 177.0, 129.0], "value": 136.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 188.0, 188.0, 189.0, 197.0, 193.0, 191.0, 194.0, 185.0, 181.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 70.0, 72.0, 69.0, 72.0, 71.0, 70.0, 70.0], "value": 72.0, "unit": "score"}]}]} 09:23:27 INFO - Return code: 0 09:23:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:27 INFO - # TBPL SUCCESS # 09:23:27 INFO - Running post-action listener: _resource_record_post_action 09:23:27 INFO - [mozharness: 2017-05-04 16:23:27.162643Z] Finished run-tests step (success) 09:23:27 INFO - Running post-run listener: _resource_record_post_run 09:23:27 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 346013696; Read time: 324; Write time: 315748 09:23:27 INFO - TinderboxPrint: CPU usage
13.3% 09:23:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 324 09:23:27 INFO - TinderboxPrint: I/O write bytes / time
346,013,696 / 315,748 09:23:27 INFO - TinderboxPrint: CPU idle
8,302.4 (86.7%) 09:23:27 INFO - TinderboxPrint: CPU user
1,213.8 (12.7%) 09:23:27 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:27 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 81178624; Read time: 0; Write time: 66760 09:23:27 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 244162560; Read time: 304; Write time: 174100 09:23:27 INFO - Running post-run listener: _upload_blobber_files 09:23:27 INFO - Blob upload gear active. 09:23:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:27 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 09:23:27 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'] 09:23:27 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 09:23:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:23:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:29 INFO - (blobuploader) - INFO - Done attempting. 09:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:23:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:29 INFO - (blobuploader) - INFO - Done attempting. 09:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:32 INFO - (blobuploader) - INFO - Done attempting. 09:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:23:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:34 INFO - (blobuploader) - INFO - Done attempting. 09:23:34 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:34 INFO - Return code: 0 09:23:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:23:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e776828e9daa736edf0635bab611c6c999156accbae17759eddfaf85e2d0299ce33d17d91cd311f3498819b84564106f6717ed519fae7e929d467af98780f8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96fa86039489b0df6853f54003d7d2a158c52f890b5bb3a52bba49b1d9f3e6b70cf1744e5b467ebcd7f5df533d49a8b0681743f8f9dc335041f988656092be2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c97e7ad209f8f89e43e28006d23d792716a2544e11a70a4a735a6e845c6aedff26b12266cb75190535128db535d82fb2a248a8d1c2cbadc59ffa41a159251d47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c5b038cf5444655a134d7e63717be3f8125618aec2189cb3c3c0679cd36aeefc6fa9e4a9c6c00e274a633c433213140841ea71440ea0b5319a27d47dc48ddd"} 09:23:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:23:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:23:34 INFO - Contents: 09:23:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e776828e9daa736edf0635bab611c6c999156accbae17759eddfaf85e2d0299ce33d17d91cd311f3498819b84564106f6717ed519fae7e929d467af98780f8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96fa86039489b0df6853f54003d7d2a158c52f890b5bb3a52bba49b1d9f3e6b70cf1744e5b467ebcd7f5df533d49a8b0681743f8f9dc335041f988656092be2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c97e7ad209f8f89e43e28006d23d792716a2544e11a70a4a735a6e845c6aedff26b12266cb75190535128db535d82fb2a248a8d1c2cbadc59ffa41a159251d47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c5b038cf5444655a134d7e63717be3f8125618aec2189cb3c3c0679cd36aeefc6fa9e4a9c6c00e274a633c433213140841ea71440ea0b5319a27d47dc48ddd"} 09:23:34 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:34 INFO - Copying logs to upload dir... 09:23:34 INFO - mkdir: /builds/slave/test/build/upload/logs 09:23:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.639720 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-04 09:23:32.967337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:32.972997) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 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/5e776828e9daa736edf0635bab611c6c999156accbae17759eddfaf85e2d0299ce33d17d91cd311f3498819b84564106f6717ed519fae7e929d467af98780f8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96fa86039489b0df6853f54003d7d2a158c52f890b5bb3a52bba49b1d9f3e6b70cf1744e5b467ebcd7f5df533d49a8b0681743f8f9dc335041f988656092be2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c97e7ad209f8f89e43e28006d23d792716a2544e11a70a4a735a6e845c6aedff26b12266cb75190535128db535d82fb2a248a8d1c2cbadc59ffa41a159251d47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c5b038cf5444655a134d7e63717be3f8125618aec2189cb3c3c0679cd36aeefc6fa9e4a9c6c00e274a633c433213140841ea71440ea0b5319a27d47dc48ddd"} build_url:https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/ZtpNGFJsTKe8QtQepxpBZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e776828e9daa736edf0635bab611c6c999156accbae17759eddfaf85e2d0299ce33d17d91cd311f3498819b84564106f6717ed519fae7e929d467af98780f8d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/96fa86039489b0df6853f54003d7d2a158c52f890b5bb3a52bba49b1d9f3e6b70cf1744e5b467ebcd7f5df533d49a8b0681743f8f9dc335041f988656092be2f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c97e7ad209f8f89e43e28006d23d792716a2544e11a70a4a735a6e845c6aedff26b12266cb75190535128db535d82fb2a248a8d1c2cbadc59ffa41a159251d47", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b9c5b038cf5444655a134d7e63717be3f8125618aec2189cb3c3c0679cd36aeefc6fa9e4a9c6c00e274a633c433213140841ea71440ea0b5319a27d47dc48ddd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:32.998782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:32.999108) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1493906151.684292-965971132 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 09:23:33.084306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:23:33.084627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 09:23:33.084938) ========= ========= Total master_lag: 0.16 =========