builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1495874995.69 results: success (0) revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.692178) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.693048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.693311) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.770655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.770903) ========= 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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-27 01:49:56-- 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% 225M=0s 2017-05-27 01:49:56 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.180453 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:55.999912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:56.000197) ========= 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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:56.049343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 01:49:56.052643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ebad93e117700d8e2d65573b824beb18a8cc2030 --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 ebad93e117700d8e2d65573b824beb18a8cc2030 --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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-27 01:49:56,269 truncating revision to first 12 chars 2017-05-27 01:49:56,269 Setting DEBUG logging. 2017-05-27 01:49:56,269 attempt 1/10 2017-05-27 01:49:56,269 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ebad93e11770?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-27 01:49:57,655 unpacking tar archive at: mozilla-central-ebad93e11770/testing/mozharness/ program finished with exit code 0 elapsedTime=1.661919 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-27 01:49:57.726409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:57.729791) ========= script_repo_revision: ebad93e117700d8e2d65573b824beb18a8cc2030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:57.730239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:57.730499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-27 01:49:57.739379) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-27 01:49:57.739724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:49:58 INFO - MultiFileLogger online at 20170527 01:49:58 in /builds/slave/test 01:49:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:49:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:49:58 INFO - {'append_to_log': False, 01:49:58 INFO - 'base_work_dir': '/builds/slave/test', 01:49:58 INFO - 'blob_upload_branch': 'Firefox', 01:49:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:49:58 INFO - 'branch': 'Firefox', 01:49:58 INFO - 'buildbot_json_path': 'buildprops.json', 01:49:58 INFO - 'config_files': ('talos/linux_config.py',), 01:49:58 INFO - 'default_actions': ('clobber', 01:49:58 INFO - 'read-buildbot-config', 01:49:58 INFO - 'download-and-extract', 01:49:58 INFO - 'populate-webroot', 01:49:58 INFO - 'create-virtualenv', 01:49:58 INFO - 'install', 01:49:58 INFO - 'run-tests'), 01:49:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:49:58 INFO - 'download_minidump_stackwalk': True, 01:49:58 INFO - 'download_symbols': 'ondemand', 01:49:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:49:58 INFO - 'tooltool.py': '/tools/tooltool.py', 01:49:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:49:58 INFO - '/tools/misc-python/virtualenv.py')}, 01:49:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:49:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:49:58 INFO - 'gecko_profile': False, 01:49:58 INFO - 'gecko_profile_interval': 0, 01:49:58 INFO - 'installer_path': 'installer.exe', 01:49:58 INFO - 'log_level': 'info', 01:49:58 INFO - 'log_name': 'talos', 01:49:58 INFO - 'log_to_console': True, 01:49:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:49:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:49:58 INFO - 'opt_config_files': (), 01:49:58 INFO - 'pip_index': False, 01:49:58 INFO - 'suite': 'dromaeojs-e10s', 01:49:58 INFO - 'system_bits': '32', 01:49:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:49:58 INFO - 'title': 'talos-linux64-ix-003', 01:49:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:49:58 INFO - 'use_talos_json': True, 01:49:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:49:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:49:58 INFO - 'work_dir': 'build'} 01:49:58 INFO - [mozharness: 2017-05-27 08:49:58.158775Z] Running clobber step. 01:49:58 INFO - Running pre-action listener: _resource_record_pre_action 01:49:58 INFO - Running main action method: clobber 01:49:58 INFO - rmtree: /builds/slave/test/build 01:49:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:49:59 INFO - Running post-action listener: _resource_record_post_action 01:49:59 INFO - [mozharness: 2017-05-27 08:49:59.140484Z] Finished clobber step (success) 01:49:59 INFO - [mozharness: 2017-05-27 08:49:59.140584Z] Running read-buildbot-config step. 01:49:59 INFO - Running pre-action listener: _resource_record_pre_action 01:49:59 INFO - Running main action method: read_buildbot_config 01:49:59 INFO - Using buildbot properties: 01:49:59 INFO - { 01:49:59 INFO - "project": "", 01:49:59 INFO - "product": "firefox", 01:49:59 INFO - "who": "archaeopteryx@coole-files.de", 01:49:59 INFO - "installer_path": "public/build/target.tar.bz2", 01:49:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 01:49:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 01:49:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 01:49:59 INFO - "stage_platform": "linux64-stylosequential", 01:49:59 INFO - "basedir": "/builds/slave/test", 01:49:59 INFO - "buildnumber": 28, 01:49:59 INFO - "platform": "ubuntu64_hw_styloseq", 01:49:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:49:59 INFO - "slavebuilddir": "test", 01:49:59 INFO - "taskId": "M0F6heE_QwWKwIbST3mfzg", 01:49:59 INFO - "branch": "mozilla-central", 01:49:59 INFO - "script_repo_revision": "production", 01:49:59 INFO - "revision": "ebad93e117700d8e2d65573b824beb18a8cc2030", 01:49:59 INFO - "slavename": "talos-linux64-ix-003", 01:49:59 INFO - "repo_path": "mozilla-central" 01:49:59 INFO - } 01:49:59 INFO - Finding installer, test and symbols from parent task. 01:49:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0F6heE_QwWKwIbST3mfzg'}, attempt #1 01:49:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0F6heE_QwWKwIbST3mfzg'}, attempt #1 01:50:00 INFO - Task dependencies: Uq-60V7AQ9e-6gp7Ofi6fg 01:50:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg'}, attempt #1 01:50:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 01:50:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/test_packages.json 01:50:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.crashreporter-symbols.zip 01:50:00 INFO - Running post-action listener: _resource_record_post_action 01:50:00 INFO - [mozharness: 2017-05-27 08:50:00.493834Z] Finished read-buildbot-config step (success) 01:50:00 INFO - [mozharness: 2017-05-27 08:50:00.494056Z] Running download-and-extract step. 01:50:00 INFO - Running pre-action listener: _resource_record_pre_action 01:50:00 INFO - Running main action method: download_and_extract 01:50:00 INFO - mkdir: /builds/slave/test/build/tests 01:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:00 INFO - trying https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.test_packages.json 01:50:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:50:01 INFO - Downloaded 986 bytes. 01:50:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:50:01 INFO - Using the following test package requirements: 01:50:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:50:01 INFO - u'common': [u'target.common.tests.zip'], 01:50:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:50:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:50:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:50:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:50:01 INFO - u'mozbase': [u'target.common.tests.zip'], 01:50:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:50:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:50:01 INFO - u'web-platform': [u'target.common.tests.zip', 01:50:01 INFO - u'target.web-platform.tests.zip'], 01:50:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:50:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:50:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip 01:50:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:50:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip into memory 01:50:02 INFO - Content-Length response header: 63533422 01:50:02 INFO - Bytes received: 63533422 01:50:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:50:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip 01:50:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:50:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.common.tests.zip into memory 01:50:15 INFO - Content-Length response header: 63533422 01:50:15 INFO - Bytes received: 63533422 01:50:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.talos.tests.zip 01:50:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:50:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.talos.tests.zip into memory 01:50:31 INFO - Content-Length response header: 14441221 01:50:31 INFO - Bytes received: 14441221 01:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:31 INFO - trying https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 01:50:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:50:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:50:32 INFO - Downloaded 55705891 bytes. 01:50:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 01:50:32 INFO - mkdir: /builds/slave/test/properties 01:50:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:50:32 INFO - Writing to file /builds/slave/test/properties/build_url 01:50:32 INFO - Contents: 01:50:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 01:50:32 INFO - Running post-action listener: _resource_record_post_action 01:50:32 INFO - Running post-action listener: set_extra_try_arguments 01:50:32 INFO - [mozharness: 2017-05-27 08:50:32.613392Z] Finished download-and-extract step (success) 01:50:32 INFO - [mozharness: 2017-05-27 08:50:32.613489Z] Running populate-webroot step. 01:50:32 INFO - Running pre-action listener: _resource_record_pre_action 01:50:32 INFO - Running main action method: populate_webroot 01:50:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:50:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:50:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:50:32 INFO - '--tppagecycles', 01:50:32 INFO - '7'], 01:50:32 INFO - 'tests': ['tsvgm']}}, 01:50:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:50:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:50:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:50:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:50:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:50:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:50:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['damp', 'tps']}, 01:50:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'tests': ['damp', 'tps']}, 01:50:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['dromaeo_dom']}, 01:50:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:50:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:50:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:50:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:50:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'other-e10s': {'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['a11yr', 01:50:32 INFO - 'ts_paint', 01:50:32 INFO - 'tpaint', 01:50:32 INFO - 'sessionrestore', 01:50:32 INFO - 'sessionrestore_no_auto_restore', 01:50:32 INFO - 'tabpaint']}, 01:50:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:50:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:50:32 INFO - 'bloom_basic_ref']}, 01:50:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['tsvgx', 01:50:32 INFO - 'tsvgr_opacity', 01:50:32 INFO - 'tart', 01:50:32 INFO - 'tscrollx', 01:50:32 INFO - 'cart', 01:50:32 INFO - 'tsvg_static']}, 01:50:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:50:32 INFO - 'tsvgr_opacity', 01:50:32 INFO - 'tart', 01:50:32 INFO - 'tscrollx', 01:50:32 INFO - 'cart', 01:50:32 INFO - 'tsvg_static']}, 01:50:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'talos_options': ['--disable-e10s'], 01:50:32 INFO - 'tests': ['tp5o']}, 01:50:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:50:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'talos_options': ['--disable-e10s', 01:50:32 INFO - '--xperf_path', 01:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:50:32 INFO - 'tests': ['tp5n']}, 01:50:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:50:32 INFO - 'talos_options': ['--xperf_path', 01:50:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:50:32 INFO - 'tests': ['tp5n']}}, 01:50:32 INFO - 'talos.zip': {'path': '', 01:50:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:50:32 INFO - Running post-action listener: _resource_record_post_action 01:50:32 INFO - [mozharness: 2017-05-27 08:50:32.627533Z] Finished populate-webroot step (success) 01:50:32 INFO - [mozharness: 2017-05-27 08:50:32.627622Z] Running create-virtualenv step. 01:50:32 INFO - Running pre-action listener: _resource_record_pre_action 01:50:32 INFO - Running main action method: create_virtualenv 01:50:32 INFO - Creating virtualenv /builds/slave/test/build/venv 01:50:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:50:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:50:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:50:32 INFO - Using real prefix '/usr' 01:50:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:50:33 INFO - Installing distribute.............................................................................................................................................................................................done. 01:50:35 INFO - Installing pip.................done. 01:50:35 INFO - Return code: 0 01:50:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:50:35 INFO - Reading from file tmpfile_stdout 01:50:35 INFO - Output received: 01:50:35 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) 01:50:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:35 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:50:35 INFO - Using env: {'DISPLAY': ':0', 01:50:35 INFO - 'HOME': '/home/cltbld', 01:50:35 INFO - 'LANG': 'en_US.UTF-8', 01:50:35 INFO - 'LANGUAGE': 'en_US:en', 01:50:35 INFO - 'LOGNAME': 'cltbld', 01:50:35 INFO - 'MAIL': '/var/mail/cltbld', 01:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:35 INFO - 'MOZ_NO_REMOTE': '1', 01:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:35 INFO - 'NO_EM_RESTART': '1', 01:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:35 INFO - 'PWD': '/builds/slave/test', 01:50:35 INFO - 'SHELL': '/bin/bash', 01:50:35 INFO - 'SHLVL': '1', 01:50:35 INFO - 'TERM': 'linux', 01:50:35 INFO - 'TMOUT': '86400', 01:50:35 INFO - 'USER': 'cltbld', 01:50:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:35 INFO - '_': '/tools/buildbot/bin/python'} 01:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:50:35 INFO - Cleaning up... 01:50:35 INFO - Return code: 0 01:50:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:35 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:50:35 INFO - Using env: {'DISPLAY': ':0', 01:50:35 INFO - 'HOME': '/home/cltbld', 01:50:35 INFO - 'LANG': 'en_US.UTF-8', 01:50:35 INFO - 'LANGUAGE': 'en_US:en', 01:50:35 INFO - 'LOGNAME': 'cltbld', 01:50:35 INFO - 'MAIL': '/var/mail/cltbld', 01:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:35 INFO - 'MOZ_NO_REMOTE': '1', 01:50:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:35 INFO - 'NO_EM_RESTART': '1', 01:50:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:35 INFO - 'PWD': '/builds/slave/test', 01:50:35 INFO - 'SHELL': '/bin/bash', 01:50:35 INFO - 'SHLVL': '1', 01:50:35 INFO - 'TERM': 'linux', 01:50:35 INFO - 'TMOUT': '86400', 01:50:35 INFO - 'USER': 'cltbld', 01:50:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:35 INFO - '_': '/tools/buildbot/bin/python'} 01:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:36 INFO - Downloading/unpacking psutil>=3.1.1 01:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:50:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:50:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:50:37 INFO - Installing collected packages: psutil 01:50:37 INFO - Running setup.py install for psutil 01:50:37 INFO - building 'psutil._psutil_linux' extension 01:50:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:50:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:50:38 INFO - building 'psutil._psutil_posix' extension 01:50:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:50:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:50:38 INFO - Successfully installed psutil 01:50:38 INFO - Cleaning up... 01:50:39 INFO - Return code: 0 01:50:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:39 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:50:39 INFO - Using env: {'DISPLAY': ':0', 01:50:39 INFO - 'HOME': '/home/cltbld', 01:50:39 INFO - 'LANG': 'en_US.UTF-8', 01:50:39 INFO - 'LANGUAGE': 'en_US:en', 01:50:39 INFO - 'LOGNAME': 'cltbld', 01:50:39 INFO - 'MAIL': '/var/mail/cltbld', 01:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:39 INFO - 'MOZ_NO_REMOTE': '1', 01:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:39 INFO - 'NO_EM_RESTART': '1', 01:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:39 INFO - 'PWD': '/builds/slave/test', 01:50:39 INFO - 'SHELL': '/bin/bash', 01:50:39 INFO - 'SHLVL': '1', 01:50:39 INFO - 'TERM': 'linux', 01:50:39 INFO - 'TMOUT': '86400', 01:50:39 INFO - 'USER': 'cltbld', 01:50:39 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:39 INFO - '_': '/tools/buildbot/bin/python'} 01:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:50:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:50:40 INFO - Installing collected packages: mozsystemmonitor 01:50:40 INFO - Running setup.py install for mozsystemmonitor 01:50:40 INFO - Successfully installed mozsystemmonitor 01:50:40 INFO - Cleaning up... 01:50:40 INFO - Return code: 0 01:50:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:40 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:50:40 INFO - Using env: {'DISPLAY': ':0', 01:50:40 INFO - 'HOME': '/home/cltbld', 01:50:40 INFO - 'LANG': 'en_US.UTF-8', 01:50:40 INFO - 'LANGUAGE': 'en_US:en', 01:50:40 INFO - 'LOGNAME': 'cltbld', 01:50:40 INFO - 'MAIL': '/var/mail/cltbld', 01:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:40 INFO - 'MOZ_NO_REMOTE': '1', 01:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:40 INFO - 'NO_EM_RESTART': '1', 01:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:40 INFO - 'PWD': '/builds/slave/test', 01:50:40 INFO - 'SHELL': '/bin/bash', 01:50:40 INFO - 'SHLVL': '1', 01:50:40 INFO - 'TERM': 'linux', 01:50:40 INFO - 'TMOUT': '86400', 01:50:40 INFO - 'USER': 'cltbld', 01:50:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:40 INFO - '_': '/tools/buildbot/bin/python'} 01:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:40 INFO - Downloading/unpacking jsonschema==2.5.1 01:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:50:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:41 INFO - Downloading functools32-3.2.3-2.tar.gz 01:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:50:41 INFO - warning: no files found matching '*.txt' 01:50:41 INFO - no previously-included directories found matching 'build' 01:50:41 INFO - no previously-included directories found matching 'dist' 01:50:41 INFO - no previously-included directories found matching '.git*' 01:50:41 INFO - Installing collected packages: jsonschema, functools32 01:50:42 INFO - Running setup.py install for functools32 01:50:42 INFO - warning: no files found matching '*.txt' 01:50:42 INFO - no previously-included directories found matching 'build' 01:50:42 INFO - no previously-included directories found matching 'dist' 01:50:42 INFO - no previously-included directories found matching '.git*' 01:50:42 INFO - Successfully installed jsonschema functools32 01:50:42 INFO - Cleaning up... 01:50:42 INFO - Return code: 0 01:50:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:42 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 01:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:50:42 INFO - Using env: {'DISPLAY': ':0', 01:50:42 INFO - 'HOME': '/home/cltbld', 01:50:42 INFO - 'LANG': 'en_US.UTF-8', 01:50:42 INFO - 'LANGUAGE': 'en_US:en', 01:50:42 INFO - 'LOGNAME': 'cltbld', 01:50:42 INFO - 'MAIL': '/var/mail/cltbld', 01:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:42 INFO - 'MOZ_NO_REMOTE': '1', 01:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:42 INFO - 'NO_EM_RESTART': '1', 01:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:42 INFO - 'PWD': '/builds/slave/test', 01:50:42 INFO - 'SHELL': '/bin/bash', 01:50:42 INFO - 'SHLVL': '1', 01:50:42 INFO - 'TERM': 'linux', 01:50:42 INFO - 'TMOUT': '86400', 01:50:42 INFO - 'USER': 'cltbld', 01:50:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:42 INFO - '_': '/tools/buildbot/bin/python'} 01:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:50:42 INFO - Cleaning up... 01:50:42 INFO - Return code: 0 01:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:42 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:50:42 INFO - Using env: {'DISPLAY': ':0', 01:50:42 INFO - 'HOME': '/home/cltbld', 01:50:42 INFO - 'LANG': 'en_US.UTF-8', 01:50:42 INFO - 'LANGUAGE': 'en_US:en', 01:50:42 INFO - 'LOGNAME': 'cltbld', 01:50:42 INFO - 'MAIL': '/var/mail/cltbld', 01:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:42 INFO - 'MOZ_NO_REMOTE': '1', 01:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:42 INFO - 'NO_EM_RESTART': '1', 01:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:42 INFO - 'PWD': '/builds/slave/test', 01:50:42 INFO - 'SHELL': '/bin/bash', 01:50:42 INFO - 'SHLVL': '1', 01:50:42 INFO - 'TERM': 'linux', 01:50:42 INFO - 'TMOUT': '86400', 01:50:42 INFO - 'USER': 'cltbld', 01:50:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:42 INFO - '_': '/tools/buildbot/bin/python'} 01:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 01:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:43 INFO - Downloading blobuploader-1.2.4.tar.gz 01:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:50:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:44 INFO - Downloading docopt-0.6.1.tar.gz 01:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:50:44 INFO - Installing collected packages: blobuploader, requests, docopt 01:50:44 INFO - Running setup.py install for blobuploader 01:50:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:50:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:50:44 INFO - Running setup.py install for requests 01:50:44 INFO - Running setup.py install for docopt 01:50:44 INFO - Successfully installed blobuploader requests docopt 01:50:44 INFO - Cleaning up... 01:50:44 INFO - Return code: 0 01:50:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:44 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:44 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:50:44 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:50:44 INFO - Using env: {'DISPLAY': ':0', 01:50:44 INFO - 'HOME': '/home/cltbld', 01:50:44 INFO - 'LANG': 'en_US.UTF-8', 01:50:44 INFO - 'LANGUAGE': 'en_US:en', 01:50:44 INFO - 'LOGNAME': 'cltbld', 01:50:44 INFO - 'MAIL': '/var/mail/cltbld', 01:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:44 INFO - 'MOZ_NO_REMOTE': '1', 01:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:44 INFO - 'NO_EM_RESTART': '1', 01:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:44 INFO - 'PWD': '/builds/slave/test', 01:50:44 INFO - 'SHELL': '/bin/bash', 01:50:44 INFO - 'SHLVL': '1', 01:50:44 INFO - 'TERM': 'linux', 01:50:44 INFO - 'TMOUT': '86400', 01:50:44 INFO - 'USER': 'cltbld', 01:50:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:44 INFO - '_': '/tools/buildbot/bin/python'} 01:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:50:45 INFO - Running setup.py (path:/tmp/pip-XboZXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:50:45 INFO - Running setup.py (path:/tmp/pip-J0oV2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:50:45 INFO - Running setup.py (path:/tmp/pip-09GkGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:50:45 INFO - Running setup.py (path:/tmp/pip-lfn0I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:50:45 INFO - Running setup.py (path:/tmp/pip-jhUPhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:50:45 INFO - Running setup.py (path:/tmp/pip-pMJOmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:50:45 INFO - Running setup.py (path:/tmp/pip-BGVDBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:50:45 INFO - Running setup.py (path:/tmp/pip-cHfVZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:50:45 INFO - Running setup.py (path:/tmp/pip-13b__c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:50:45 INFO - Running setup.py (path:/tmp/pip-NPjVkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:50:45 INFO - Running setup.py (path:/tmp/pip-WgVgXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:50:45 INFO - Running setup.py (path:/tmp/pip-hmPT8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:50:45 INFO - Running setup.py (path:/tmp/pip-3co1B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:50:46 INFO - Running setup.py (path:/tmp/pip-ZlrJmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:50:46 INFO - Running setup.py (path:/tmp/pip-vzXjMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:50:46 INFO - Running setup.py (path:/tmp/pip-z2HG1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:50:46 INFO - Running setup.py (path:/tmp/pip-zeJwOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:50:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:50:46 INFO - Running setup.py install for manifestparser 01:50:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:50:46 INFO - Running setup.py install for mozcrash 01:50:46 INFO - Running setup.py install for mozdebug 01:50:46 INFO - Running setup.py install for mozdevice 01:50:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:50:46 INFO - Running setup.py install for mozfile 01:50:46 INFO - Running setup.py install for mozhttpd 01:50:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:50:46 INFO - Running setup.py install for mozinfo 01:50:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for mozInstall 01:50:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for mozleak 01:50:47 INFO - Running setup.py install for mozlog 01:50:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for moznetwork 01:50:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for mozprocess 01:50:47 INFO - Running setup.py install for mozprofile 01:50:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for mozrunner 01:50:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:50:47 INFO - Running setup.py install for mozscreenshot 01:50:47 INFO - Running setup.py install for moztest 01:50:47 INFO - Running setup.py install for mozversion 01:50:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:50:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:50:48 INFO - Cleaning up... 01:50:48 INFO - Return code: 0 01:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:48 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:48 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:50:48 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:50:48 INFO - Using env: {'DISPLAY': ':0', 01:50:48 INFO - 'HOME': '/home/cltbld', 01:50:48 INFO - 'LANG': 'en_US.UTF-8', 01:50:48 INFO - 'LANGUAGE': 'en_US:en', 01:50:48 INFO - 'LOGNAME': 'cltbld', 01:50:48 INFO - 'MAIL': '/var/mail/cltbld', 01:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:48 INFO - 'MOZ_NO_REMOTE': '1', 01:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:48 INFO - 'NO_EM_RESTART': '1', 01:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:48 INFO - 'PWD': '/builds/slave/test', 01:50:48 INFO - 'SHELL': '/bin/bash', 01:50:48 INFO - 'SHLVL': '1', 01:50:48 INFO - 'TERM': 'linux', 01:50:48 INFO - 'TMOUT': '86400', 01:50:48 INFO - 'USER': 'cltbld', 01:50:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:48 INFO - '_': '/tools/buildbot/bin/python'} 01:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:50:48 INFO - Running setup.py (path:/tmp/pip-EGpDu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:50:48 INFO - Running setup.py (path:/tmp/pip-Pt3ZW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:50:48 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)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:50:48 INFO - Running setup.py (path:/tmp/pip-0K7Chd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:50:48 INFO - Running setup.py (path:/tmp/pip-JMpfle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:50:48 INFO - Running setup.py (path:/tmp/pip-JSq1ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:50:48 INFO - Running setup.py (path:/tmp/pip-KHlzvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:50:48 INFO - Running setup.py (path:/tmp/pip-KuS9oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:50:48 INFO - Running setup.py (path:/tmp/pip-fCCurV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:50:48 INFO - Running setup.py (path:/tmp/pip-ypqSN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:50:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:50:48 INFO - Running setup.py (path:/tmp/pip-7cPWDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:50:49 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)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:50:49 INFO - Running setup.py (path:/tmp/pip-BtbNwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:50:49 INFO - Running setup.py (path:/tmp/pip-IAhlOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:50:49 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)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:50:49 INFO - Running setup.py (path:/tmp/pip-w6v4Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:50:49 INFO - Running setup.py (path:/tmp/pip-jYnS8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:50:49 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)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:50:49 INFO - Running setup.py (path:/tmp/pip-a1QmwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:50:49 INFO - Running setup.py (path:/tmp/pip-P64r3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:50:49 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)) 01:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:50:49 INFO - Running setup.py (path:/tmp/pip-mhCzZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:50:49 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)) 01:50:49 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)) 01:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:50:49 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:50:49 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:50:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:50 INFO - Downloading blessings-1.6.tar.gz 01:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:50:50 INFO - Installing collected packages: blessings 01:50:50 INFO - Running setup.py install for blessings 01:50:50 INFO - Successfully installed blessings 01:50:50 INFO - Cleaning up... 01:50:50 INFO - Return code: 0 01:50:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:50:51 INFO - Reading from file tmpfile_stdout 01:50:51 INFO - Current package versions: 01:50:51 INFO - argparse == 1.2.1 01:50:51 INFO - blessings == 1.6 01:50:51 INFO - blobuploader == 1.2.4 01:50:51 INFO - docopt == 0.6.1 01:50:51 INFO - functools32 == 3.2.3-2 01:50:51 INFO - jsonschema == 2.5.1 01:50:51 INFO - manifestparser == 1.1 01:50:51 INFO - mozInstall == 1.12 01:50:51 INFO - mozcrash == 1.0 01:50:51 INFO - mozdebug == 0.1 01:50:51 INFO - mozdevice == 0.51 01:50:51 INFO - mozfile == 1.2 01:50:51 INFO - mozhttpd == 0.7 01:50:51 INFO - mozinfo == 0.9 01:50:51 INFO - mozleak == 0.1 01:50:51 INFO - mozlog == 3.4 01:50:51 INFO - moznetwork == 0.27 01:50:51 INFO - mozprocess == 0.25 01:50:51 INFO - mozprofile == 0.28 01:50:51 INFO - mozrunner == 6.13 01:50:51 INFO - mozscreenshot == 0.1 01:50:51 INFO - mozsystemmonitor == 0.3 01:50:51 INFO - moztest == 0.8 01:50:51 INFO - mozversion == 1.4 01:50:51 INFO - psutil == 3.1.1 01:50:51 INFO - requests == 1.2.3 01:50:51 INFO - wsgiref == 0.1.2 01:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:51 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:51 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:50:51 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:50:51 INFO - Using env: {'DISPLAY': ':0', 01:50:51 INFO - 'HOME': '/home/cltbld', 01:50:51 INFO - 'LANG': 'en_US.UTF-8', 01:50:51 INFO - 'LANGUAGE': 'en_US:en', 01:50:51 INFO - 'LOGNAME': 'cltbld', 01:50:51 INFO - 'MAIL': '/var/mail/cltbld', 01:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:51 INFO - 'MOZ_NO_REMOTE': '1', 01:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:51 INFO - 'NO_EM_RESTART': '1', 01:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:51 INFO - 'PWD': '/builds/slave/test', 01:50:51 INFO - 'SHELL': '/bin/bash', 01:50:51 INFO - 'SHLVL': '1', 01:50:51 INFO - 'TERM': 'linux', 01:50:51 INFO - 'TMOUT': '86400', 01:50:51 INFO - 'USER': 'cltbld', 01:50:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:51 INFO - '_': '/tools/buildbot/bin/python'} 01:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:50:51 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:50:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:50:52 INFO - Downloading marionette_driver-1.4.0.tar.gz 01:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 01:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:50:52 INFO - Installing collected packages: marionette-driver 01:50:52 INFO - Running setup.py install for marionette-driver 01:50:52 INFO - Successfully installed marionette-driver 01:50:52 INFO - Cleaning up... 01:50:52 INFO - Return code: 0 01:50:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:50:52 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/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 0x19f11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d645c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, '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': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:50:52 INFO - Using env: {'DISPLAY': ':0', 01:50:52 INFO - 'HOME': '/home/cltbld', 01:50:52 INFO - 'LANG': 'en_US.UTF-8', 01:50:52 INFO - 'LANGUAGE': 'en_US:en', 01:50:52 INFO - 'LOGNAME': 'cltbld', 01:50:52 INFO - 'MAIL': '/var/mail/cltbld', 01:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:50:52 INFO - 'MOZ_NO_REMOTE': '1', 01:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:50:52 INFO - 'NO_EM_RESTART': '1', 01:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:50:52 INFO - 'PWD': '/builds/slave/test', 01:50:52 INFO - 'SHELL': '/bin/bash', 01:50:52 INFO - 'SHLVL': '1', 01:50:52 INFO - 'TERM': 'linux', 01:50:52 INFO - 'TMOUT': '86400', 01:50:52 INFO - 'USER': 'cltbld', 01:50:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:50:52 INFO - '_': '/tools/buildbot/bin/python'} 01:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:50:52 INFO - Cleaning up... 01:50:52 INFO - Return code: 0 01:50:52 INFO - Running post-action listener: _resource_record_post_action 01:50:52 INFO - Running post-action listener: _start_resource_monitoring 01:50:52 INFO - Starting resource monitoring. 01:50:52 INFO - [mozharness: 2017-05-27 08:50:52.905143Z] Finished create-virtualenv step (success) 01:50:52 INFO - [mozharness: 2017-05-27 08:50:52.906055Z] Running install step. 01:50:52 INFO - Running pre-action listener: _resource_record_pre_action 01:50:52 INFO - Running main action method: install 01:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:50:53 INFO - Reading from file tmpfile_stdout 01:50:53 INFO - Detecting whether we're running mozinstall >=1.0... 01:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:50:53 INFO - Reading from file tmpfile_stdout 01:50:53 INFO - Output received: 01:50:53 INFO - Usage: mozinstall [options] installer 01:50:53 INFO - Options: 01:50:53 INFO - -h, --help show this help message and exit 01:50:53 INFO - -d DEST, --destination=DEST 01:50:53 INFO - Directory to install application into. [default: 01:50:53 INFO - "/builds/slave/test"] 01:50:53 INFO - --app=APP Application being installed. [default: firefox] 01:50:53 INFO - mkdir: /builds/slave/test/build/application 01:50:53 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'] 01:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:51:09 INFO - Reading from file tmpfile_stdout 01:51:09 INFO - Output received: 01:51:09 INFO - /builds/slave/test/build/application/firefox/firefox 01:51:09 INFO - Running post-action listener: _resource_record_post_action 01:51:09 INFO - [mozharness: 2017-05-27 08:51:09.195875Z] Finished install step (success) 01:51:09 INFO - [mozharness: 2017-05-27 08:51:09.196153Z] Running run-tests step. 01:51:09 INFO - Running pre-action listener: _resource_record_pre_action 01:51:09 INFO - Running main action method: run_tests 01:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:51:09 INFO - Python 2.7.3 01:51:09 INFO - Return code: 0 01:51:09 INFO - grabbing minidump binary from tooltool 01:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 01:51:09 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 0x1d617a0>, '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 0x1d626a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d62b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:51:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:51:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:51:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:51:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:51:09 INFO - Return code: 0 01:51:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:51:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:51:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:51:09 INFO - ENV: RUST_BACKTRACE is now 1 01:51:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:51:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:51:09 INFO - Using env: {'DISPLAY': ':0', 01:51:09 INFO - 'HOME': '/home/cltbld', 01:51:09 INFO - 'LANG': 'en_US.UTF-8', 01:51:09 INFO - 'LANGUAGE': 'en_US:en', 01:51:09 INFO - 'LOGNAME': 'cltbld', 01:51:09 INFO - 'MAIL': '/var/mail/cltbld', 01:51:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:51:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:51:09 INFO - 'MOZ_NO_REMOTE': '1', 01:51:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:51:09 INFO - 'NO_EM_RESTART': '1', 01:51:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:51:09 INFO - 'PWD': '/builds/slave/test', 01:51:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:51:09 INFO - 'RUST_BACKTRACE': '1', 01:51:09 INFO - 'SHELL': '/bin/bash', 01:51:09 INFO - 'SHLVL': '1', 01:51:09 INFO - 'TERM': 'linux', 01:51:09 INFO - 'TMOUT': '86400', 01:51:09 INFO - 'USER': 'cltbld', 01:51:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1495858706.824648-1198610443', 01:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:51:09 INFO - '_': '/tools/buildbot/bin/python'} 01:51:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:51:09 INFO - mozversion application_buildid: 20170527080129 01:51:09 INFO - mozversion application_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 01:51:09 INFO - mozversion application_display_name: Nightly 01:51:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:51:09 INFO - mozversion application_name: Firefox 01:51:09 INFO - mozversion application_remotingname: firefox 01:51:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:51:09 INFO - mozversion application_vendor: Mozilla 01:51:09 INFO - mozversion application_version: 55.0a1 01:51:09 INFO - mozversion platform_buildid: 20170527080129 01:51:09 INFO - mozversion platform_changeset: ebad93e117700d8e2d65573b824beb18a8cc2030 01:51:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:51:09 INFO - mozversion platform_version: 55.0a1 01:51:09 INFO - using testdate: 1495875069 01:51:09 INFO - actual date: 1495875069 01:51:09 INFO - starting webserver on 'localhost:42315' 01:51:09 INFO - SUITE-START | Running 2 tests 01:51:09 INFO - TEST-START | dromaeo_css 01:51:09 INFO - operating with platform_type : linux_ 01:51:09 INFO - Initialising browser for dromaeo_css test... 01:51:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42315/getInfo.html -profile /tmp/tmpD1J3sN/profile 01:51:09 INFO - TEST-INFO | started process 3344 (/builds/slave/test/build/application/firefox/firefox http://localhost:42315/getInfo.html) 01:51:47 INFO - TEST-INFO | 3344: killed by SIGTERM 01:51:47 INFO - Browser initialized. 01:51:47 INFO - Running cycle 1/1 for dromaeo_css test... 01:51:47 INFO - TEST-INFO | started process 3567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD1J3sN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:51:59 INFO - PID 3567 | RSS: Main: 187203584 01:51:59 INFO - PID 3567 | 01:55:04 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42315/tests/dromaeo/cssquery-ext.html) 01:55:06 INFO - PID 3567 | RSS: Main: 184750080 01:55:06 INFO - PID 3567 | 01:58:08 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-ext.html (next: http://localhost:42315/tests/dromaeo/cssquery-jquery.html) 01:58:09 INFO - PID 3567 | RSS: Main: 187863040 01:58:09 INFO - PID 3567 | 02:01:10 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42315/tests/dromaeo/cssquery-mootools.html) 02:01:11 INFO - PID 3567 | RSS: Main: 184954880 02:01:11 INFO - PID 3567 | 02:04:13 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42315/tests/dromaeo/cssquery-prototype.html) 02:04:13 INFO - PID 3567 | RSS: Main: 188534784 02:04:13 INFO - PID 3567 | 02:07:16 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42315/tests/dromaeo/cssquery-yui.html) 02:07:17 INFO - PID 3567 | RSS: Main: 189014016 02:07:17 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:42315/tests/dromaeo/cssquery-yui.html (next: http://localhost:42315/tests/dromaeo/cssquery-dojo.html) 02:10:19 INFO - PID 3567 | RSS: Main: 185815040 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | __start_tp_report 02:10:19 INFO - PID 3567 | _x_x_mozilla_page_load 02:10:19 INFO - PID 3567 | _x_x_mozilla_page_load_details 02:10:19 INFO - PID 3567 | |i|pagename|runs| 02:10:19 INFO - PID 3567 | |0;dojo.html;2725.945481090378;2730.754232119109;2746.6429364182654;2782.1514438096383;2785.804993650444;5327.973360133194;5384.219288203209;5385.946140538598;5450.400455949843;5455.318085239345;5219.13884209106;5345.33183352081;5346.893062138755;5383.838484845451;5397.78408863645;4785.736784476852;4830.396200474941;4846.030793841228;4867.9269810952865;4894.143524883149;4846.0550192712435;4863.927041094386;4891.388576427947;4924.482929292427;4964.801407943678;4705.294205869112;4731.787069581877;4843.927341089887;4846.39420072491;4895.534924182215;4800.231962885921;4822.10791003662;4832.492588278215;4850.345203397532;4862.027594481083;4753.382060332169;4755.667103302771;4756.6432517561325;4759.095771803346;4787.760611969423;5319.893602127936;5322.414534401213;5345.705986170759;5354.464553544653;5355.678659280456;5660.320761508604;5684.175794509814;5725.799597014126;5733.3406658234;5756.424357564252;5851.473367396912;5872.236609240771;5878.882422351572;5950.642961422329;5951.851203719898;5407.540359069444;5435.103207970719;5438.320209973754;5446.700431476307;5450.31871016123;5884.558658100574;5965.13505541694;6010.9699451502465;6023.367546407651;6030.366811484819;5667.206591077253;5690.9146362804595;5725.1698503716725;5742.425757424307;5775.971120144456;5716.571257155647;5777.595568310262;5807.128930660435;5808.5933984621515;5845.970770146122;5661.179129026351;5767.85580360486;5791.62354446968;5793.131030345482;5793.652380857162;5734.885302293931;5780.364159942403;5825.679587622722;5842.5618078644275;5863.970680146657;4876.073546026244;4879.926801097987;4889.144399730033;4911.45973942866;4927.285543596158;4143.37849322598;4148.751074935513;4149.149424367997;4157.147784704189;4181.080162364275;4817.879553011203;4833.492483289274;4847.636427267969;4886.53577910098;4919.77860996256;5898.085796701518;5928;5930.911036334458;5939.10913362999;5953;4936.777844996984;4954;4954.133026720309;4955.900881982412;4958.628102892298;5107.208382700687;5221.921671174935;5222.817201397933;5223.634345595772;5230.738463076831;5355.062863998707;5374.785008599612;5441.183822426509;5463.945360546344;5478.972605136949;5748.655080695172;5836.678982655994;5854.765809367577;5881.73532191061;5939.07944268639;5328.467153284795;5344.518993290622;5351.411344751997;5373.946260537501;5431.972840135774;5640.746166422603;5650.915236271541;5670.404607516151;5679.8864022720145;5727.169560413633;5763.308402991668;5805.10020946754;5828.766849326149;5830.154627579062;5833.562482813891;5623.578231632562;5660.688662123623;5684.459976302244;5703.515201207943;5760.164776107525;5717.342505611908;5725.227094342211;5731.140328950691;5736;5743.540516758733;5593.328800543961;5623.578231632726;5666.376698563073;5667.858303542444;5668.631538949955;5578.944210557843;5608.551315894637;5626.634268772516;5691.686957217393;5712.200291959046;5388.46115388458;5418.972905135449;5441.455854414527;5484.698341591251;5485 02:10:19 INFO - PID 3567 | |1;ext.html;677.7695583501609;743.802892233558;768.6233745464724;1124.2186680257225;1135.2734250079945;33568.16079598008;33885.15287117823;33902.321953560946;34072.65927340729;34194.31611367771;36108.45837312436;36533.08667283319;36550.26899462009;36571.26857462849;36744;6619.966900165492;6770.5599136056;6785.76249831256;6932.410745086674;6958.478114141434;6714.731410743589;6748.595084294958;6794.558353707018;6803.7413078580375;6815.693293801766;6726.226483954334;6797.422219111381;6838.9658051709675;6839.28187540306;6850.623215723158;6750.459963202932;6768.796936091925;6798.456123510107;6807.5575087619145;6823.078884350648;6713.966430167867;6774.8983765243065;6801.4558835293055;6805.795826125224;6806.965965170192;32645.6735432645;32730.181745456317;32843.01470955875;32867;32896.83551582251;3013.773966952487;3024.2741741981768;3028.4700177469076;3029.59100521429;3031.4846476099115;24973;25012;25109.49781004388;25246;25266.24201273946;2917.6061231733656;2935.985320073386;2938.6473623165143;2947.8968236111846;2948.4840152973143;123304;125109.37445312715;136196.31901840525;144271.27864360716;145368.27315863353;41064;41361.37957930633;41383.58616413858;41466.585334146876;41494.58505414968;43083;43163.35254971178;43186.568134318884;43210;43328.6341321976;13102.344882756015;13126.212427254395;13157.342132893316;13163.078584498993;13230.07389482727;9958.751031224278;10370.688879333633;10537.42044187577;10561.102306303897;10568.10171135462;12947;13057.608271751862;13063.673408164681;13074.542391016268;13224.404901779442;5317.813876514303;5321.441248668912;5414.3232095988005;5420.214068960057;5456.454354564512;835.9414840961074;861.6165806216173;883.823235352932;902.0663613160348;912.4570880326195;20870.26954056631;21759.67360489594;26338;27553.724462755115;27747.44505109927;939.8261321655516;968.375397868385;971.2375785008876;973.8685277487449;982.4449186209769;11126.276792008493;11670.358130302746;11673.824892626617;11769.588064417705;11844.170908036354;173172;174040;174391;175003;175206;42931.570684292754;43221.78389108097;43281.13437731228;43399.13201735948;43435.34846977298;1180.4769563749883;1231.7536492701495;1236.6784635994707;1237.7586370657816;1247.021088445566;20138.59722805565;20828;21448.785512144677;21511.677324840453;21643;30953.226169345948;31163.84418077895;31213.8439307802;31237;31239.219019523785;151498;151920;152714.23642881715;153524;153851.23074384558;29483;29756.55365169481;30482.84758576193;31749.84125079452;32086.83956580202;37789.921554313674;38154;38389.80805095957;38576.03559911025;38576.80711596424;27403.17790466289;28865.567016494348;29309;30329;30617;28824.85587572049;28977.565336519547;29248.853755731085;29358.559621605265;29687.25781855471;32642.183945401554;32720.34559308848;32748.181295467803;32796.508052378755;32942.835285824374;27443.588346175224;28422.43155136927;28601.570976434952;29315.267118322212;29493.115206543836;22074.88962555177;23001;23141.148708103647;23287.18494852672;23319.067237310996 02:10:19 INFO - PID 3567 | |2;jquery.html;409.4288467587715;409.52904160215746;414.2440046914382;435.14494019252174;435.28395788927213;12560.90688291415;17375.30498780049;18014.459566213034;18158.18288177032;18179.727304090447;18983.145758440867;19046.619067618638;19386.32147874821;19570;19720.30978915738;5444.6188766786345;5461.808836690717;5589.664620122806;5671.546276297886;5682.17608446777;5431.701256430894;5547.805826796063;5551.750171242304;5556.499915007648;5556.972215138919;5352.678839269637;5455.809046683366;5492.148716948879;5507.118860982244;5544.445555444464;5429.809956651518;5456.61803673743;5459.372172200168;5475.890482190373;5480.369757477882;4884.047610715912;4910.852674419773;4926.3842019747535;4940.209566469348;4955.256711493269;21422.892885535628;21866.453338666503;22321.10715571375;22497.21259755917;22522.54954900909;1626.7234570123107;1633.7712720219179;1669.1487341455945;1669.966600667992;1674.2549565443383;14251.50119745804;14472.059316144418;14507.637309067251;14568.198749068797;14685.926570367186;1948.8440924725987;2033.5017920609546;2059.4439501334705;2067.224790703486;2086.895655217248;95541.52229238879;96987.51506242424;97559;98352.99999999929;98756;11101.333919964827;11238.606648767254;11248.26886252391;11398.544058237743;11454.942725286486;15221.923890380478;15256.847431525543;15361.769573456408;15424.614384640474;15443;7868.881966770503;8036.236557527026;8077.313428358655;8158.143394943564;8182.713605023796;7387.519811212362;7448.441366897504;7478.887816682754;7697.191794861571;7741.729039483591;6841.665875154297;7010.298970102949;7021.262767409348;7032.718691252293;7147.499675022698;1971.9014049297477;1975.614755122766;1997.1811557261453;2014.469003557307;2087.853850230469;834.5827086456771;860.2086080805674;870.3994243971766;879.305348774461;900.6307413960245;17191;17229.65540689204;17251.482455526355;17346.566335841704;17974.91012544929;885.5749240364532;888.9066648001996;890.6081324217324;891.7592250092439;911.2300106410073;9241.907580924104;9754.658586949423;9837.065478779505;9847.458389788488;9913.306068575275;326911;330403;331585;331847;332155;74766.62616686882;75956.62021689856;76862.61568692232;78424.60787696025;78587.60706196433;1012.4836333469983;1012.7164393969553;1046.9319494233002;1047.4657924458581;1053.5294733849112;14666;14941.103533788008;15046.473373431878;15227.390904364145;15776.842231577537;38523.614763852005;38742.2251554973;38824;39188.80405597954;39572.604273956895;47787.28319075147;48245.5175448255;49000.2649960258;49366.75316623537;50557.49442505675;8067.435279530377;8096.595170241582;8183.79540511492;8274.793130171794;8440.577971101544;12406.441710123247;12922.289274090015;13074.738505229652;13296.468141274627;13607.523736669169;10437.478126093512;11212.43937803123;11328.32030078198;11687.240329378903;11743.588974386197;10096.444695541522;10126.443045632266;10162.288639795144;10225.233107516817;10277.9486102572;10961;11054.502547385548;11069.667909962393;11222.55109795599;11728.272126185084;8101.189881011852;8122.390820688353;8171.591420429074;8271.090180080308;8371.874421883798;10832.133429325793;10894.875499277881;10949.56201751921;11037.503312351124;11077.556897724 02:10:19 INFO - PID 3567 | |3;mootools.html;1215.9999999999998;1279.2196759976418;1283.8395200599925;1287.5751002169286;1294.993525032375;10132.49337533123;10515.842262366052;10668.893311066888;10686.946565267173;10785.406802625852;10410.687679369612;10564.26050176488;10571.629992950247;10581.259311848175;10616.256862019662;2157.46063484129;2162.826973842097;2199.7580266170708;2203.151786562177;2208.2271205078255;2085.489055181483;2117.544727883505;2118.766935637079;2124.808767210951;2127.9893600531977;2043.1418804102238;2081.3235698398007;2086.78088800676;2092.194505115534;2099.7585277693033;2005.9097340619635;2015.868968517049;2021.0198053943825;2022.4236092713506;2025.5543780368296;1784.4914199453224;1842.6683197024531;2034.6876264809264;2055.794420557947;2067.4211220858183;10522.684319470429;10881.564737410494;10921.071708904752;10922.1808364373;10936.45317734118;5647.407022262685;5883.823485295406;5888.352281249059;5889.1460738193155;5890.4698577128265;3332.1169889979174;3417.470292104728;3425.1779572902324;3478.0783092480515;3480.3039392121423;1082.6373164989739;1095.2661716649864;1099.9175061870392;1110.6390423112439;1140.8117660585992;15322;15331.23343832815;15421.460248891348;15460;15527.689446211125;4628.930566041512;4761.2382018876815;4897.142999975062;4915.557599816034;4921.212605983097;11277.097832173406;11369.886301137049;11393.829092563617;11395.145364097725;11409.714757131138;5580.637258578179;5724.542036637059;5728.455796699307;5735.541156707453;5736.913946290809;5218.530332270114;5225.111731005738;5277.815276465305;5304.681719096867;5325.440828713007;3846.769193848322;3850.5571859236547;3931.523140421516;3956;3980.9402858957137;989.9703008909744;1006.1749365520203;1007.4459047523833;1028.0387837372082;1032.7521394865328;596.3231731984229;616.7625464196317;621.9985822825248;622.1476577089417;622.4708997352215;5029.245613158056;5075.111855425286;5109.284700141983;5123.846284611468;5187.170052791535;519.2704250528014;536.5573401943412;840.6931470013401;859.9742007739778;877.7191298784328;3879.9612003880166;3909.765414075108;4031.737937034083;4044.170944956277;4106.322456794595;13264.469421223235;13950.02349835522;13965.371558279901;13977.440902363995;13985.72028559423;13504.392302346418;13823.101498402571;13850.09974351664;13857.445702172003;13886;7487.363574096154;7661.808454788675;7669.348105410991;7684.731034413769;7702.730404435818;5580;5981.880362392815;6117.449429551361;6139.785107521216;6373.6175829450385;12648.304343261208;12728.486188726049;12852.228866268053;13089.934550327187;13173.93413032967;12800.551980680631;13097.803532946822;13201.20792752438;13358;13416.932915335361;7470.215627359266;7669.693212271447;7676.270754278335;7694.576798276148;7702.5763583001235;9853.901460985298;9908.702738917844;9920.851187232342;9933.106020458194;9987.350822196535;7928.445008849325;8257.256846883569;8460.703875364332;8552.786180345542;8581.785455363666;7973.20267973198;8027.59862006909;8102.230288122619;8168.387370947084;8223.342132629496;7538.472306938462;7662.693492260247;7691.884621730566;7695.307422332017;7703.499272547267;4888.560029597354;5502.312210973629;5509.944900550943;5531.0873705838085;5813.575673959906;5541.944580554143;5600.1319795430145;5608.298962629671;5674.177244299636;5782.681952492653 02:10:19 INFO - PID 3567 | |4;prototype.html;330.7403688104837;347.9443289073747;348.5399272959691;358.3585382165923;362.38937390497017;5482.23248745175;5611.579131565134;5620.747066382012;5627.409122042188;5661.943380566193;5379.408265090847;5448;5457.208704737821;5477.287952566171;5481.314835645544;4113.670906327501;4130.8141133648905;4136.7598211832965;4138.482689663792;4138.999999999993;4082.5100987881347;4131.462909821734;4150.273702102135;4156.625903668669;4169.270377683908;4093.304138296482;4111.876643700679;4111.938320925188;4118.485189351331;4130.586941305861;4084.8146241760514;4088.1823635273063;4088.5093788745244;4098.077932465201;4103.322951712964;3552.662497062775;3555.7866528008403;3562.305350456662;3564.269324788438;3565.2156525564333;5222.503862133091;5327.147656374961;5344.545713614348;5357.383900851413;5368.114261146906;4784.282357646346;4794.7842347094465;4809.807607695688;4814.1334559779225;4823.2282834746275;5591.2731344925305;5780;5791.623544469596;5801.129830525413;5806.796762113348;3981.422693709425;4011.0574015106426;4015.4177644241713;4025.0943537704075;4028.8589899353383;6000.459958603747;6136.7545298188015;6191.25704915413;6194.690265486708;6210.199042277779;4396.208682437192;4407.735535867858;4487.6634252431195;4491.528389519119;4502.887427814266;4547.681662283609;4554.180247555406;4564.0871825635;4564.566366195206;4564.589186973122;5000.2749601307605;5003.424606170264;5061.291419201315;5064.898702026013;5070;5878;5882.676452795137;5885.676287804126;5914.58597898143;5916.112583112482;1558.158594359056;1561.4769052367358;1569.3521802107969;1572.5911263071685;1573.5830005048672;1035.7514196592915;1102.20090434436;1107.2692023264606;1117.5418078587902;1125.0661950580998;5092.9236061459105;5099.64302498829;5100.846974590768;5104.285400043997;5131;6074.635521868702;6081.5742897996715;6114.633122012605;6117.174181485531;6117.510599152057;4889.462159162489;4998.300237966688;5029.924551131736;5037.118504261813;5101;3191.393635209303;3229.951550726741;3233.1917020744813;3235.029491152645;3242.189452636841;5530.944690553123;5549.972250138804;5583.246261754693;5595.776168953278;5601.271834661549;6157.907631385533;6192.721327540272;6219.751209951552;6290.559660823698;6315.473810475754;5578.44215578447;5583.972080139573;5592.797548527086;5601.29983752031;5623.915641265385;5935.881282374415;5999.100134979788;6044.607100538451;6079.726412311545;6084.148219249397;5992.43071908168;5997.460228579449;6010.4891084258325;6017.3681763414215;6021.729022193924;5335.759890805;5364.570834333166;5460.726963651881;5521.806736764194;5575.526080283222;4423.314386270134;4431.135928493913;4436.3123715824095;4472.195004899149;4473.306637471197;5933.465988060922;6010.909836352545;6094.421030002142;6096.451319381277;6114.6942652868065;5846.94153058481;5873.324567674601;5880.970595146997;5881.500072493886;5897.67562784051;5864.970675146597;5865.530757539472;5885.146653735099;5889.793857214977;5894.263217097863;5696.743646535833;5779.422057794187;5814.592978491465;5839.4744472995935;5841.766329346949;5900.911486327623;5916.290045194604;5919.704014799329;5931.042755890632;5947.197128387786;5558.694271815089;5628.831135065954;5721.76981948883;5738.655680659173;5743.684097374685 02:10:19 INFO - PID 3567 | |5;yui.html;709.641630976357;711.6655172069126;740.5408646639085;752.2552672853875;766.3907193780947;13887.930560347197;14645.487407940724;14685.853141468595;15782.684346313095;16499.17504124795;16451.177441127926;16616.50150495487;16642.417515386933;16673.66652666949;16679.166041697896;887.2680038967845;908.7137551671235;909.0818273543703;909.940853844498;913.7441516375426;886.8093359927615;925.2228128372166;936.536414474836;936.7189843047058;937.74212091675;954.4368822394786;956.4022485946283;957.1529196660971;957.2103015012608;957.5930229652405;948.8766460360143;949.0699114867434;949.3829011142743;949.4777872170313;949.895511493742;695.0929037605922;699.3530983839978;699.8355386484172;701.1130919386928;703.0052475746812;14200;14482.1310721356;14542.854571454256;14593.70812583753;14613.634659133606;15820.604484887856;16355.672886542203;16444.177791110516;16454;16469.176541172892;12211.206271592318;12325.568605098779;12706.491740330375;12716.300603466805;12756.61730148097;3011.382666553351;3012.29211135383;3045.512717965137;3054.4501989641853;3057.8623961921544;82662;83859.5807020967;83859.5807020967;84923;85435.5728221355;12187.634370968884;12274.140810143204;12390.380480975915;12442.81335779964;12442.937785311196;22112.44718882041;22814.543709125726;22871.31386058421;23071.769282307298;23119;6150.108234306001;6280.654563999024;6321.620702757849;6361.268454127742;6381.8085457436355;2874.770018398523;2925.195571217932;2935.5303151496087;2943.7203465670727;2946.145617770865;3769.7361184717356;3807.447920051577;3857.8263978121054;3861.2856621525107;3867.110564570108;687.4946914018193;695.7112798188796;695.8016965164903;697.0589703899694;698.671624336561;552.486187845301;589.2016317889284;612.1093808508609;626.8840264551072;642.9678516074177;9633.662821801203;10595.099416549525;10842.132629389629;11054.392008439612;11080.168987325982;587.4213899309177;613.141601757543;623.1991890420878;634.7175506899478;640.2892789004202;4722.858314250578;4926;5011.173156429221;5219.973900130475;5353.170258609922;83524.58237708773;83907.58046209851;84590.57704711438;86783.56608216919;87555;74268.25731742721;77720;77758;77944.61027694939;78155.60922195352;59114;60183.69908150431;61112;61753.38246617566;68496.6575167131;10322.948385258025;10836.837447438453;11478.483468243781;11518.308901465938;11537.365444900612;28000.29999250035;28533.14400567903;28635.713642863306;28800;29258.80558958044;34254.31491370209;34317;34454;34733.47899781556;35071.47392789059;14557.199354035629;14768.483103091341;14932.253387330808;15078.321475533408;15122.621934451727;15777.526674199793;16153.353865845234;16246.837531624533;16529.917350413172;16531.586710331856;15014.174220417983;15190.620234493785;15304.234788260765;15441.382344706086;15545.922270388575;14658.486952956595;14697;15065.77401338959;15468.92265538665;15586;15572.454964076203;15780.36878524892;15872.365105395655;15996.8400316;16010.9199454002;11156.717720578295;11208.327500350006;11282.266652667551;11558.595449159238;11602.883971160518;11782.234154779911;12095.516179353079;12206.877931220573;12245.75508489843;12280.201786883825 02:10:19 INFO - PID 3567 | __end_tp_report 02:10:19 INFO - PID 3567 | __start_cc_report 02:10:19 INFO - PID 3567 | _x_x_mozilla_cycle_collect,376 02:10:19 INFO - PID 3567 | __end_cc_report 02:10:19 INFO - PID 3567 | __startTimestamp1495876219417__endTimestamp 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | ------- Summary: start ------- 02:10:19 INFO - PID 3567 | Number of tests: 6 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#0] dojo.html Cycles:165 Average:5314.03 Median:5446.70 stddev:631.39 (11.6%) stddev-sans-first:599.79 02:10:19 INFO - PID 3567 | Values: 2725.9 2730.8 2746.6 2782.2 2785.8 5328.0 5384.2 5385.9 5450.4 5455.3 5219.1 5345.3 5346.9 5383.8 5397.8 4785.7 4830.4 4846.0 4867.9 4894.1 4846.1 4863.9 4891.4 4924.5 4964.8 4705.3 4731.8 4843.9 4846.4 4895.5 4800.2 4822.1 4832.5 4850.3 4862.0 4753.4 4755.7 4756.6 4759.1 4787.8 5319.9 5322.4 5345.7 5354.5 5355.7 5660.3 5684.2 5725.8 5733.3 5756.4 5851.5 5872.2 5878.9 5950.6 5951.9 5407.5 5435.1 5438.3 5446.7 5450.3 5884.6 5965.1 6011.0 6023.4 6030.4 5667.2 5690.9 5725.2 5742.4 5776.0 5716.6 5777.6 5807.1 5808.6 5846.0 5661.2 5767.9 5791.6 5793.1 5793.7 5734.9 5780.4 5825.7 5842.6 5864.0 4876.1 4879.9 4889.1 4911.5 4927.3 4143.4 4148.8 4149.1 4157.1 4181.1 4817.9 4833.5 4847.6 4886.5 4919.8 5898.1 5928.0 5930.9 5939.1 5953.0 4936.8 4954.0 4954.1 4955.9 4958.6 5107.2 5221.9 5222.8 5223.6 5230.7 5355.1 5374.8 5441.2 5463.9 5479.0 5748.7 5836.7 5854.8 5881.7 5939.1 5328.5 5344.5 5351.4 5373.9 5432.0 5640.7 5650.9 5670.4 5679.9 5727.2 5763.3 5805.1 5828.8 5830.2 5833.6 5623.6 5660.7 5684.5 5703.5 5760.2 5717.3 5725.2 5731.1 5736.0 5743.5 5593.3 5623.6 5666.4 5667.9 5668.6 5578.9 5608.6 5626.6 5691.7 5712.2 5388.5 5419.0 5441.5 5484.7 5485.0 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#1] ext.html Cycles:180 Average:30684.43 Median:31188.84 stddev:39969.93 (128.2%) stddev-sans-first:40018.54 02:10:19 INFO - PID 3567 | Values: 677.8 743.8 768.6 1124.2 1135.3 33568.2 33885.2 33902.3 34072.7 34194.3 36108.5 36533.1 36550.3 36571.3 36744.0 6620.0 6770.6 6785.8 6932.4 6958.5 6714.7 6748.6 6794.6 6803.7 6815.7 6726.2 6797.4 6839.0 6839.3 6850.6 6750.5 6768.8 6798.5 6807.6 6823.1 6714.0 6774.9 6801.5 6805.8 6807.0 32645.7 32730.2 32843.0 32867.0 32896.8 3013.8 3024.3 3028.5 3029.6 3031.5 24973.0 25012.0 25109.5 25246.0 25266.2 2917.6 2936.0 2938.6 2947.9 2948.5 123304.0 125109.4 136196.3 144271.3 145368.3 41064.0 41361.4 41383.6 41466.6 41494.6 43083.0 43163.4 43186.6 43210.0 43328.6 13102.3 13126.2 13157.3 13163.1 13230.1 9958.8 10370.7 10537.4 10561.1 10568.1 12947.0 13057.6 13063.7 13074.5 13224.4 5317.8 5321.4 5414.3 5420.2 5456.5 835.9 861.6 883.8 902.1 912.5 20870.3 21759.7 26338.0 27553.7 27747.4 939.8 968.4 971.2 973.9 982.4 11126.3 11670.4 11673.8 11769.6 11844.2 173172.0 174040.0 174391.0 175003.0 175206.0 42931.6 43221.8 43281.1 43399.1 43435.3 1180.5 1231.8 1236.7 1237.8 1247.0 20138.6 20828.0 21448.8 21511.7 21643.0 30953.2 31163.8 31213.8 31237.0 31239.2 151498.0 151920.0 152714.2 153524.0 153851.2 29483.0 29756.6 30482.8 31749.8 32086.8 37789.9 38154.0 38389.8 38576.0 38576.8 27403.2 28865.6 29309.0 30329.0 30617.0 28824.9 28977.6 29248.9 29358.6 29687.3 32642.2 32720.3 32748.2 32796.5 32942.8 27443.6 28422.4 28601.6 29315.3 29493.1 22074.9 23001.0 23141.1 23287.2 23319.1 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#2] jquery.html Cycles:180 Average:24061.38 Median:38632.92 stddev:55743.93 (144.3%) stddev-sans-first:55872.02 02:10:19 INFO - PID 3567 | Values: 409.4 409.5 414.2 435.1 435.3 12560.9 17375.3 18014.5 18158.2 18179.7 18983.1 19046.6 19386.3 19570.0 19720.3 5444.6 5461.8 5589.7 5671.5 5682.2 5431.7 5547.8 5551.8 5556.5 5557.0 5352.7 5455.8 5492.1 5507.1 5544.4 5429.8 5456.6 5459.4 5475.9 5480.4 4884.0 4910.9 4926.4 4940.2 4955.3 21422.9 21866.5 22321.1 22497.2 22522.5 1626.7 1633.8 1669.1 1670.0 1674.3 14251.5 14472.1 14507.6 14568.2 14685.9 1948.8 2033.5 2059.4 2067.2 2086.9 95541.5 96987.5 97559.0 98353.0 98756.0 11101.3 11238.6 11248.3 11398.5 11454.9 15221.9 15256.8 15361.8 15424.6 15443.0 7868.9 8036.2 8077.3 8158.1 8182.7 7387.5 7448.4 7478.9 7697.2 7741.7 6841.7 7010.3 7021.3 7032.7 7147.5 1971.9 1975.6 1997.2 2014.5 2087.9 834.6 860.2 870.4 879.3 900.6 17191.0 17229.7 17251.5 17346.6 17974.9 885.6 888.9 890.6 891.8 911.2 9241.9 9754.7 9837.1 9847.5 9913.3 326911.0 330403.0 331585.0 331847.0 332155.0 74766.6 75956.6 76862.6 78424.6 78587.6 1012.5 1012.7 1046.9 1047.5 1053.5 14666.0 14941.1 15046.5 15227.4 15776.8 38523.6 38742.2 38824.0 39188.8 39572.6 47787.3 48245.5 49000.3 49366.8 50557.5 8067.4 8096.6 8183.8 8274.8 8440.6 12406.4 12922.3 13074.7 13296.5 13607.5 10437.5 11212.4 11328.3 11687.2 11743.6 10096.4 10126.4 10162.3 10225.2 10277.9 10961.0 11054.5 11069.7 11222.6 11728.3 8101.2 8122.4 8171.6 8271.1 8371.9 10832.1 10894.9 10949.6 11037.5 11077.6 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#3] mootools.html Cycles:180 Average:6445.13 Median:3865.26 stddev:4272.90 (110.5%) stddev-sans-first:4266.82 02:10:19 INFO - PID 3567 | Values: 1216.0 1279.2 1283.8 1287.6 1295.0 10132.5 10515.8 10668.9 10686.9 10785.4 10410.7 10564.3 10571.6 10581.3 10616.3 2157.5 2162.8 2199.8 2203.2 2208.2 2085.5 2117.5 2118.8 2124.8 2128.0 2043.1 2081.3 2086.8 2092.2 2099.8 2005.9 2015.9 2021.0 2022.4 2025.6 1784.5 1842.7 2034.7 2055.8 2067.4 10522.7 10881.6 10921.1 10922.2 10936.5 5647.4 5883.8 5888.4 5889.1 5890.5 3332.1 3417.5 3425.2 3478.1 3480.3 1082.6 1095.3 1099.9 1110.6 1140.8 15322.0 15331.2 15421.5 15460.0 15527.7 4628.9 4761.2 4897.1 4915.6 4921.2 11277.1 11369.9 11393.8 11395.1 11409.7 5580.6 5724.5 5728.5 5735.5 5736.9 5218.5 5225.1 5277.8 5304.7 5325.4 3846.8 3850.6 3931.5 3956.0 3980.9 990.0 1006.2 1007.4 1028.0 1032.8 596.3 616.8 622.0 622.1 622.5 5029.2 5075.1 5109.3 5123.8 5187.2 519.3 536.6 840.7 860.0 877.7 3880.0 3909.8 4031.7 4044.2 4106.3 13264.5 13950.0 13965.4 13977.4 13985.7 13504.4 13823.1 13850.1 13857.4 13886.0 7487.4 7661.8 7669.3 7684.7 7702.7 5580.0 5981.9 6117.4 6139.8 6373.6 12648.3 12728.5 12852.2 13089.9 13173.9 12800.6 13097.8 13201.2 13358.0 13416.9 7470.2 7669.7 7676.3 7694.6 7702.6 9853.9 9908.7 9920.9 9933.1 9987.4 7928.4 8257.3 8460.7 8552.8 8581.8 7973.2 8027.6 8102.2 8168.4 8223.3 7538.5 7662.7 7691.9 7695.3 7703.5 4888.6 5502.3 5509.9 5531.1 5813.6 5541.9 5600.1 5608.3 5674.2 5782.7 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#4] prototype.html Cycles:180 Average:4835.51 Median:5366.34 stddev:1413.37 (26.3%) stddev-sans-first:1376.30 02:10:19 INFO - PID 3567 | Values: 330.7 347.9 348.5 358.4 362.4 5482.2 5611.6 5620.7 5627.4 5661.9 5379.4 5448.0 5457.2 5477.3 5481.3 4113.7 4130.8 4136.8 4138.5 4139.0 4082.5 4131.5 4150.3 4156.6 4169.3 4093.3 4111.9 4111.9 4118.5 4130.6 4084.8 4088.2 4088.5 4098.1 4103.3 3552.7 3555.8 3562.3 3564.3 3565.2 5222.5 5327.1 5344.5 5357.4 5368.1 4784.3 4794.8 4809.8 4814.1 4823.2 5591.3 5780.0 5791.6 5801.1 5806.8 3981.4 4011.1 4015.4 4025.1 4028.9 6000.5 6136.8 6191.3 6194.7 6210.2 4396.2 4407.7 4487.7 4491.5 4502.9 4547.7 4554.2 4564.1 4564.6 4564.6 5000.3 5003.4 5061.3 5064.9 5070.0 5878.0 5882.7 5885.7 5914.6 5916.1 1558.2 1561.5 1569.4 1572.6 1573.6 1035.8 1102.2 1107.3 1117.5 1125.1 5092.9 5099.6 5100.8 5104.3 5131.0 6074.6 6081.6 6114.6 6117.2 6117.5 4889.5 4998.3 5029.9 5037.1 5101.0 3191.4 3230.0 3233.2 3235.0 3242.2 5530.9 5550.0 5583.2 5595.8 5601.3 6157.9 6192.7 6219.8 6290.6 6315.5 5578.4 5584.0 5592.8 5601.3 5623.9 5935.9 5999.1 6044.6 6079.7 6084.1 5992.4 5997.5 6010.5 6017.4 6021.7 5335.8 5364.6 5460.7 5521.8 5575.5 4423.3 4431.1 4436.3 4472.2 4473.3 5933.5 6010.9 6094.4 6096.5 6114.7 5846.9 5873.3 5881.0 5881.5 5897.7 5865.0 5865.5 5885.1 5889.8 5894.3 5696.7 5779.4 5814.6 5839.5 5841.8 5900.9 5916.3 5919.7 5931.0 5947.2 5558.7 5628.8 5721.8 5738.7 5743.7 02:10:19 INFO - PID 3567 | 02:10:19 INFO - PID 3567 | [#5] yui.html Cycles:180 Average:17583.48 Median:3028.90 stddev:22852.73 (754.5%) stddev-sans-first:22881.71 02:10:19 INFO - PID 3567 | Values: 709.6 711.7 740.5 752.3 766.4 13887.9 14645.5 14685.9 15782.7 16499.2 16451.2 16616.5 16642.4 16673.7 16679.2 887.3 908.7 909.1 909.9 913.7 886.8 925.2 936.5 936.7 937.7 954.4 956.4 957.2 957.2 957.6 948.9 949.1 949.4 949.5 949.9 695.1 699.4 699.8 701.1 703.0 14200.0 14482.1 14542.9 14593.7 14613.6 15820.6 16355.7 16444.2 16454.0 16469.2 12211.2 12325.6 12706.5 12716.3 12756.6 3011.4 3012.3 3045.5 3054.5 3057.9 82662.0 83859.6 83859.6 84923.0 85435.6 12187.6 12274.1 12390.4 12442.8 12442.9 22112.4 22814.5 22871.3 23071.8 23119.0 6150.1 6280.7 6321.6 6361.3 6381.8 2874.8 2925.2 2935.5 2943.7 2946.1 3769.7 3807.4 3857.8 3861.3 3867.1 687.5 695.7 695.8 697.1 698.7 552.5 589.2 612.1 626.9 643.0 9633.7 10595.1 10842.1 11054.4 11080.2 587.4 613.1 623.2 634.7 640.3 4722.9 4926.0 5011.2 5220.0 5353.2 83524.6 83907.6 84590.6 86783.6 87555.0 74268.3 77720.0 77758.0 77944.6 78155.6 59114.0 60183.7 61112.0 61753.4 68496.7 10322.9 10836.8 11478.5 11518.3 11537.4 28000.3 28533.1 28635.7 28800.0 29258.8 34254.3 34317.0 34454.0 34733.5 35071.5 14557.2 14768.5 14932.3 15078.3 15122.6 15777.5 16153.4 16246.8 16529.9 16531.6 15014.2 15190.6 15304.2 15441.4 15545.9 14658.5 14697.0 15065.8 15468.9 15586.0 15572.5 15780.4 15872.4 15996.8 16010.9 11156.7 11208.3 11282.3 11558.6 11602.9 11782.2 12095.5 12206.9 12245.8 12280.2 02:10:19 INFO - PID 3567 | -------- Summary: end -------- 02:10:19 INFO - PID 3567 | 02:10:20 INFO - TEST-INFO | 3567: exit 0 02:10:20 INFO - TEST-OK | dromaeo_css | took 1150690ms 02:10:20 INFO - TEST-START | kraken 02:10:20 INFO - operating with platform_type : linux_ 02:10:20 INFO - Initialising browser for kraken test... 02:10:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42315/getInfo.html -profile /tmp/tmpbFYNBb/profile 02:10:20 INFO - TEST-INFO | started process 3983 (/builds/slave/test/build/application/firefox/firefox http://localhost:42315/getInfo.html) 02:10:55 INFO - TEST-INFO | 3983: killed by SIGTERM 02:10:55 INFO - Browser initialized. 02:10:55 INFO - Running cycle 1/1 for kraken test... 02:10:55 INFO - TEST-INFO | started process 4203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFYNBb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:07 INFO - PID 4203 | RSS: Main: 186650624 02:11:07 INFO - PID 4203 | 02:11:10 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42315/tests/kraken/driver.html?testName=audio-beat-detection) 02:11:11 INFO - PID 4203 | RSS: Main: 189845504 02:11:11 INFO - PID 4203 | 02:11:14 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42315/tests/kraken/driver.html?testName=audio-dft) 02:11:14 INFO - PID 4203 | RSS: Main: 188981248 02:11:14 INFO - PID 4203 | 02:11:17 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42315/tests/kraken/driver.html?testName=audio-fft) 02:11:18 INFO - PID 4203 | RSS: Main: 185135104 02:11:18 INFO - PID 4203 | 02:11:20 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42315/tests/kraken/driver.html?testName=audio-oscillator) 02:11:21 INFO - PID 4203 | RSS: Main: 185790464 02:11:21 INFO - PID 4203 | 02:11:23 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:11:23 INFO - PID 4203 | RSS: Main: 186150912 02:11:23 INFO - PID 4203 | 02:11:27 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42315/tests/kraken/driver.html?testName=imaging-darkroom) 02:11:27 INFO - PID 4203 | RSS: Main: 190304256 02:11:27 INFO - PID 4203 | 02:11:31 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42315/tests/kraken/driver.html?testName=imaging-desaturate) 02:11:31 INFO - PID 4203 | RSS: Main: 186884096 02:11:31 INFO - PID 4203 | 02:11:34 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42315/tests/kraken/driver.html?testName=json-parse-financial) 02:11:35 INFO - PID 4203 | RSS: Main: 186945536 02:11:35 INFO - PID 4203 | 02:11:37 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:11:37 INFO - PID 4203 | RSS: Main: 187600896 02:11:37 INFO - PID 4203 | 02:11:39 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:11:40 INFO - PID 4203 | RSS: Main: 187121664 02:11:40 INFO - PID 4203 | 02:11:42 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:11:43 INFO - PID 4203 | RSS: Main: 187080704 02:11:43 INFO - PID 4203 | 02:11:46 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:11:46 INFO - PID 4203 | RSS: Main: 187260928 02:11:46 INFO - PID 4203 | 02:11:49 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:11:50 INFO - PID 4203 | RSS: Main: 186961920 02:11:50 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | Cycle 1(1): loaded http://localhost:42315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42315/tests/kraken/driver.html?testName=ai-astar) 02:11:52 INFO - PID 4203 | RSS: Main: 188665856 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | __start_tp_report 02:11:52 INFO - PID 4203 | _x_x_mozilla_page_load 02:11:52 INFO - PID 4203 | _x_x_mozilla_page_load_details 02:11:52 INFO - PID 4203 | |i|pagename|runs| 02:11:52 INFO - PID 4203 | |0;ai-astar;102;112;111;110;110;110;110;109;109;110 02:11:52 INFO - PID 4203 | |1;audio-beat-detection;153;125;126;178;125;124;123;129;149;127 02:11:52 INFO - PID 4203 | |2;audio-dft;163;163;164;164;171;173;162;165;161;162 02:11:52 INFO - PID 4203 | |3;audio-fft;75;73;74;112;73;75;73;73;100;78 02:11:52 INFO - PID 4203 | |4;audio-oscillator;83;83;104;83;83;83;97;84;83;111 02:11:52 INFO - PID 4203 | |5;imaging-gaussian-blur;115;115;113;114;117;114;114;118;115;114 02:11:52 INFO - PID 4203 | |6;imaging-darkroom;151;150;151;153;151;152;150;151;152;150 02:11:52 INFO - PID 4203 | |7;imaging-desaturate;94;95;98;94;95;95;95;94;95;100 02:11:52 INFO - PID 4203 | |8;json-parse-financial;54;54;54;54;55;56;61;54;55;56 02:11:52 INFO - PID 4203 | |9;json-stringify-tinderbox;56;56;56;56;57;56;56;56;58;60 02:11:52 INFO - PID 4203 | |10;stanford-crypto-aes;94;89;87;91;87;88;87;90;132;94 02:11:52 INFO - PID 4203 | |11;stanford-crypto-ccm;141;134;139;139;132;136;133;132;155;135 02:11:52 INFO - PID 4203 | |12;stanford-crypto-pbkdf2;190;203;200;210;190;201;204;195;192;193 02:11:52 INFO - PID 4203 | |13;stanford-crypto-sha256-iterative;76;75;76;74;75;73;74;74;70;79 02:11:52 INFO - PID 4203 | __end_tp_report 02:11:52 INFO - PID 4203 | __start_cc_report 02:11:52 INFO - PID 4203 | _x_x_mozilla_cycle_collect,1010 02:11:52 INFO - PID 4203 | __end_cc_report 02:11:52 INFO - PID 4203 | __startTimestamp1495876312647__endTimestamp 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | ------- Summary: start ------- 02:11:52 INFO - PID 4203 | Number of tests: 14 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.71 (2.5%) stddev-sans-first:0.93 02:11:52 INFO - PID 4203 | Values: 102.0 112.0 111.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:128.00 stddev:18.28 (14.3%) stddev-sans-first:18.31 02:11:52 INFO - PID 4203 | Values: 153.0 125.0 126.0 178.0 125.0 124.0 123.0 129.0 149.0 127.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.99 (2.4%) stddev-sans-first:4.18 02:11:52 INFO - PID 4203 | Values: 163.0 163.0 164.0 164.0 171.0 173.0 162.0 165.0 161.0 162.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#3] audio-fft Cycles:10 Average:80.60 Median:73.50 stddev:13.77 (18.7%) stddev-sans-first:14.45 02:11:52 INFO - PID 4203 | Values: 75.0 73.0 74.0 112.0 73.0 75.0 73.0 73.0 100.0 78.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:10.61 (12.8%) stddev-sans-first:10.99 02:11:52 INFO - PID 4203 | Values: 83.0 83.0 104.0 83.0 83.0 83.0 97.0 84.0 83.0 111.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 02:11:52 INFO - PID 4203 | Values: 115.0 115.0 113.0 114.0 117.0 114.0 114.0 118.0 115.0 114.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 02:11:52 INFO - PID 4203 | Values: 151.0 150.0 151.0 153.0 151.0 152.0 150.0 151.0 152.0 150.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.96 (2.1%) stddev-sans-first:2.00 02:11:52 INFO - PID 4203 | Values: 94.0 95.0 98.0 94.0 95.0 95.0 95.0 94.0 95.0 100.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.16 (3.9%) stddev-sans-first:2.24 02:11:52 INFO - PID 4203 | Values: 54.0 54.0 54.0 54.0 55.0 56.0 61.0 54.0 55.0 56.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 02:11:52 INFO - PID 4203 | Values: 56.0 56.0 56.0 56.0 57.0 56.0 56.0 56.0 58.0 60.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:89.50 stddev:13.65 (15.3%) stddev-sans-first:14.48 02:11:52 INFO - PID 4203 | Values: 94.0 89.0 87.0 91.0 87.0 88.0 87.0 90.0 132.0 94.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:137.50 stddev:6.87 (5.0%) stddev-sans-first:7.17 02:11:52 INFO - PID 4203 | Values: 141.0 134.0 139.0 139.0 132.0 136.0 133.0 132.0 155.0 135.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:200.50 stddev:6.80 (3.4%) stddev-sans-first:6.60 02:11:52 INFO - PID 4203 | Values: 190.0 203.0 200.0 210.0 190.0 201.0 204.0 195.0 192.0 193.0 02:11:52 INFO - PID 4203 | 02:11:52 INFO - PID 4203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:2.32 (3.1%) stddev-sans-first:2.40 02:11:52 INFO - PID 4203 | Values: 76.0 75.0 76.0 74.0 75.0 73.0 74.0 74.0 70.0 79.0 02:11:52 INFO - PID 4203 | -------- Summary: end -------- 02:11:52 INFO - PID 4203 | 02:11:53 INFO - TEST-INFO | 4203: exit 0 02:11:53 INFO - TEST-OK | kraken | took 93535ms 02:11:53 INFO - SUITE-END | took 1244s 02:11:54 INFO - Completed test suite (00:20:44) 02:11:54 INFO - javascript benchmark 02:11:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6867.264756620639, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2725.945481090378, 2730.754232119109, 2746.6429364182654, 2782.1514438096383, 2785.804993650444, 5327.973360133194, 5384.219288203209, 5385.946140538598, 5450.400455949843, 5455.318085239345, 5219.13884209106, 5345.33183352081, 5346.893062138755, 5383.838484845451, 5397.78408863645, 4785.736784476852, 4830.396200474941, 4846.030793841228, 4867.9269810952865, 4894.143524883149, 4846.0550192712435, 4863.927041094386, 4891.388576427947, 4924.482929292427, 4964.801407943678, 4705.294205869112, 4731.787069581877, 4843.927341089887, 4846.39420072491, 4895.534924182215, 4800.231962885921, 4822.10791003662, 4832.492588278215, 4850.345203397532, 4862.027594481083, 4753.382060332169, 4755.667103302771, 4756.6432517561325, 4759.095771803346, 4787.760611969423, 5319.893602127936, 5322.414534401213, 5345.705986170759, 5354.464553544653, 5355.678659280456, 5660.320761508604, 5684.175794509814, 5725.799597014126, 5733.3406658234, 5756.424357564252, 5851.473367396912, 5872.236609240771, 5878.882422351572, 5950.642961422329, 5951.851203719898, 5407.540359069444, 5435.103207970719, 5438.320209973754, 5446.700431476307, 5450.31871016123, 5884.558658100574, 5965.13505541694, 6010.9699451502465, 6023.367546407651, 6030.366811484819, 5667.206591077253, 5690.9146362804595, 5725.1698503716725, 5742.425757424307, 5775.971120144456, 5716.571257155647, 5777.595568310262, 5807.128930660435, 5808.5933984621515, 5845.970770146122, 5661.179129026351, 5767.85580360486, 5791.62354446968, 5793.131030345482, 5793.652380857162, 5734.885302293931, 5780.364159942403, 5825.679587622722, 5842.5618078644275, 5863.970680146657, 4876.073546026244, 4879.926801097987, 4889.144399730033, 4911.45973942866, 4927.285543596158, 4143.37849322598, 4148.751074935513, 4149.149424367997, 4157.147784704189, 4181.080162364275, 4817.879553011203, 4833.492483289274, 4847.636427267969, 4886.53577910098, 4919.77860996256, 5898.085796701518, 5928.0, 5930.911036334458, 5939.10913362999, 5953.0, 4936.777844996984, 4954.0, 4954.133026720309, 4955.900881982412, 4958.628102892298, 5107.208382700687, 5221.921671174935, 5222.817201397933, 5223.634345595772, 5230.738463076831, 5355.062863998707, 5374.785008599612, 5441.183822426509, 5463.945360546344, 5478.972605136949, 5748.655080695172, 5836.678982655994, 5854.765809367577, 5881.73532191061, 5939.07944268639, 5328.467153284795, 5344.518993290622, 5351.411344751997, 5373.946260537501, 5431.972840135774, 5640.746166422603, 5650.915236271541, 5670.404607516151, 5679.8864022720145, 5727.169560413633, 5763.308402991668, 5805.10020946754, 5828.766849326149, 5830.154627579062, 5833.562482813891, 5623.578231632562, 5660.688662123623, 5684.459976302244, 5703.515201207943, 5760.164776107525, 5717.342505611908, 5725.227094342211, 5731.140328950691, 5736.0, 5743.540516758733, 5593.328800543961, 5623.578231632726, 5666.376698563073, 5667.858303542444, 5668.631538949955, 5578.944210557843, 5608.551315894637, 5626.634268772516, 5691.686957217393, 5712.200291959046, 5388.46115388458, 5418.972905135449, 5441.455854414527, 5484.698341591251, 5485.0], "value": 5267.131482559521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.7695583501609, 743.802892233558, 768.6233745464724, 1124.2186680257225, 1135.2734250079945, 33568.16079598008, 33885.15287117823, 33902.321953560946, 34072.65927340729, 34194.31611367771, 36108.45837312436, 36533.08667283319, 36550.26899462009, 36571.26857462849, 36744.0, 6619.966900165492, 6770.5599136056, 6785.76249831256, 6932.410745086674, 6958.478114141434, 6714.731410743589, 6748.595084294958, 6794.558353707018, 6803.7413078580375, 6815.693293801766, 6726.226483954334, 6797.422219111381, 6838.9658051709675, 6839.28187540306, 6850.623215723158, 6750.459963202932, 6768.796936091925, 6798.456123510107, 6807.5575087619145, 6823.078884350648, 6713.966430167867, 6774.8983765243065, 6801.4558835293055, 6805.795826125224, 6806.965965170192, 32645.6735432645, 32730.181745456317, 32843.01470955875, 32867.0, 32896.83551582251, 3013.773966952487, 3024.2741741981768, 3028.4700177469076, 3029.59100521429, 3031.4846476099115, 24973.0, 25012.0, 25109.49781004388, 25246.0, 25266.24201273946, 2917.6061231733656, 2935.985320073386, 2938.6473623165143, 2947.8968236111846, 2948.4840152973143, 123304.0, 125109.37445312715, 136196.31901840525, 144271.27864360716, 145368.27315863353, 41064.0, 41361.37957930633, 41383.58616413858, 41466.585334146876, 41494.58505414968, 43083.0, 43163.35254971178, 43186.568134318884, 43210.0, 43328.6341321976, 13102.344882756015, 13126.212427254395, 13157.342132893316, 13163.078584498993, 13230.07389482727, 9958.751031224278, 10370.688879333633, 10537.42044187577, 10561.102306303897, 10568.10171135462, 12947.0, 13057.608271751862, 13063.673408164681, 13074.542391016268, 13224.404901779442, 5317.813876514303, 5321.441248668912, 5414.3232095988005, 5420.214068960057, 5456.454354564512, 835.9414840961074, 861.6165806216173, 883.823235352932, 902.0663613160348, 912.4570880326195, 20870.26954056631, 21759.67360489594, 26338.0, 27553.724462755115, 27747.44505109927, 939.8261321655516, 968.375397868385, 971.2375785008876, 973.8685277487449, 982.4449186209769, 11126.276792008493, 11670.358130302746, 11673.824892626617, 11769.588064417705, 11844.170908036354, 173172.0, 174040.0, 174391.0, 175003.0, 175206.0, 42931.570684292754, 43221.78389108097, 43281.13437731228, 43399.13201735948, 43435.34846977298, 1180.4769563749883, 1231.7536492701495, 1236.6784635994707, 1237.7586370657816, 1247.021088445566, 20138.59722805565, 20828.0, 21448.785512144677, 21511.677324840453, 21643.0, 30953.226169345948, 31163.84418077895, 31213.8439307802, 31237.0, 31239.219019523785, 151498.0, 151920.0, 152714.23642881715, 153524.0, 153851.23074384558, 29483.0, 29756.55365169481, 30482.84758576193, 31749.84125079452, 32086.83956580202, 37789.921554313674, 38154.0, 38389.80805095957, 38576.03559911025, 38576.80711596424, 27403.17790466289, 28865.567016494348, 29309.0, 30329.0, 30617.0, 28824.85587572049, 28977.565336519547, 29248.853755731085, 29358.559621605265, 29687.25781855471, 32642.183945401554, 32720.34559308848, 32748.181295467803, 32796.508052378755, 32942.835285824374, 27443.588346175224, 28422.43155136927, 28601.570976434952, 29315.267118322212, 29493.115206543836, 22074.88962555177, 23001.0, 23141.148708103647, 23287.18494852672, 23319.067237310996], "value": 14800.538992726546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.4288467587715, 409.52904160215746, 414.2440046914382, 435.14494019252174, 435.28395788927213, 12560.90688291415, 17375.30498780049, 18014.459566213034, 18158.18288177032, 18179.727304090447, 18983.145758440867, 19046.619067618638, 19386.32147874821, 19570.0, 19720.30978915738, 5444.6188766786345, 5461.808836690717, 5589.664620122806, 5671.546276297886, 5682.17608446777, 5431.701256430894, 5547.805826796063, 5551.750171242304, 5556.499915007648, 5556.972215138919, 5352.678839269637, 5455.809046683366, 5492.148716948879, 5507.118860982244, 5544.445555444464, 5429.809956651518, 5456.61803673743, 5459.372172200168, 5475.890482190373, 5480.369757477882, 4884.047610715912, 4910.852674419773, 4926.3842019747535, 4940.209566469348, 4955.256711493269, 21422.892885535628, 21866.453338666503, 22321.10715571375, 22497.21259755917, 22522.54954900909, 1626.7234570123107, 1633.7712720219179, 1669.1487341455945, 1669.966600667992, 1674.2549565443383, 14251.50119745804, 14472.059316144418, 14507.637309067251, 14568.198749068797, 14685.926570367186, 1948.8440924725987, 2033.5017920609546, 2059.4439501334705, 2067.224790703486, 2086.895655217248, 95541.52229238879, 96987.51506242424, 97559.0, 98352.99999999929, 98756.0, 11101.333919964827, 11238.606648767254, 11248.26886252391, 11398.544058237743, 11454.942725286486, 15221.923890380478, 15256.847431525543, 15361.769573456408, 15424.614384640474, 15443.0, 7868.881966770503, 8036.236557527026, 8077.313428358655, 8158.143394943564, 8182.713605023796, 7387.519811212362, 7448.441366897504, 7478.887816682754, 7697.191794861571, 7741.729039483591, 6841.665875154297, 7010.298970102949, 7021.262767409348, 7032.718691252293, 7147.499675022698, 1971.9014049297477, 1975.614755122766, 1997.1811557261453, 2014.469003557307, 2087.853850230469, 834.5827086456771, 860.2086080805674, 870.3994243971766, 879.305348774461, 900.6307413960245, 17191.0, 17229.65540689204, 17251.482455526355, 17346.566335841704, 17974.91012544929, 885.5749240364532, 888.9066648001996, 890.6081324217324, 891.7592250092439, 911.2300106410073, 9241.907580924104, 9754.658586949423, 9837.065478779505, 9847.458389788488, 9913.306068575275, 326911.0, 330403.0, 331585.0, 331847.0, 332155.0, 74766.62616686882, 75956.62021689856, 76862.61568692232, 78424.60787696025, 78587.60706196433, 1012.4836333469983, 1012.7164393969553, 1046.9319494233002, 1047.4657924458581, 1053.5294733849112, 14666.0, 14941.103533788008, 15046.473373431878, 15227.390904364145, 15776.842231577537, 38523.614763852005, 38742.2251554973, 38824.0, 39188.80405597954, 39572.604273956895, 47787.28319075147, 48245.5175448255, 49000.2649960258, 49366.75316623537, 50557.49442505675, 8067.435279530377, 8096.595170241582, 8183.79540511492, 8274.793130171794, 8440.577971101544, 12406.441710123247, 12922.289274090015, 13074.738505229652, 13296.468141274627, 13607.523736669169, 10437.478126093512, 11212.43937803123, 11328.32030078198, 11687.240329378903, 11743.588974386197, 10096.444695541522, 10126.443045632266, 10162.288639795144, 10225.233107516817, 10277.9486102572, 10961.0, 11054.502547385548, 11069.667909962393, 11222.55109795599, 11728.272126185084, 8101.189881011852, 8122.390820688353, 8171.591420429074, 8271.090180080308, 8371.874421883798, 10832.133429325793, 10894.875499277881, 10949.56201751921, 11037.503312351124, 11077.556897724], "value": 8846.59891213821, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1215.9999999999998, 1279.2196759976418, 1283.8395200599925, 1287.5751002169286, 1294.993525032375, 10132.49337533123, 10515.842262366052, 10668.893311066888, 10686.946565267173, 10785.406802625852, 10410.687679369612, 10564.26050176488, 10571.629992950247, 10581.259311848175, 10616.256862019662, 2157.46063484129, 2162.826973842097, 2199.7580266170708, 2203.151786562177, 2208.2271205078255, 2085.489055181483, 2117.544727883505, 2118.766935637079, 2124.808767210951, 2127.9893600531977, 2043.1418804102238, 2081.3235698398007, 2086.78088800676, 2092.194505115534, 2099.7585277693033, 2005.9097340619635, 2015.868968517049, 2021.0198053943825, 2022.4236092713506, 2025.5543780368296, 1784.4914199453224, 1842.6683197024531, 2034.6876264809264, 2055.794420557947, 2067.4211220858183, 10522.684319470429, 10881.564737410494, 10921.071708904752, 10922.1808364373, 10936.45317734118, 5647.407022262685, 5883.823485295406, 5888.352281249059, 5889.1460738193155, 5890.4698577128265, 3332.1169889979174, 3417.470292104728, 3425.1779572902324, 3478.0783092480515, 3480.3039392121423, 1082.6373164989739, 1095.2661716649864, 1099.9175061870392, 1110.6390423112439, 1140.8117660585992, 15322.0, 15331.23343832815, 15421.460248891348, 15460.0, 15527.689446211125, 4628.930566041512, 4761.2382018876815, 4897.142999975062, 4915.557599816034, 4921.212605983097, 11277.097832173406, 11369.886301137049, 11393.829092563617, 11395.145364097725, 11409.714757131138, 5580.637258578179, 5724.542036637059, 5728.455796699307, 5735.541156707453, 5736.913946290809, 5218.530332270114, 5225.111731005738, 5277.815276465305, 5304.681719096867, 5325.440828713007, 3846.769193848322, 3850.5571859236547, 3931.523140421516, 3956.0, 3980.9402858957137, 989.9703008909744, 1006.1749365520203, 1007.4459047523833, 1028.0387837372082, 1032.7521394865328, 596.3231731984229, 616.7625464196317, 621.9985822825248, 622.1476577089417, 622.4708997352215, 5029.245613158056, 5075.111855425286, 5109.284700141983, 5123.846284611468, 5187.170052791535, 519.2704250528014, 536.5573401943412, 840.6931470013401, 859.9742007739778, 877.7191298784328, 3879.9612003880166, 3909.765414075108, 4031.737937034083, 4044.170944956277, 4106.322456794595, 13264.469421223235, 13950.02349835522, 13965.371558279901, 13977.440902363995, 13985.72028559423, 13504.392302346418, 13823.101498402571, 13850.09974351664, 13857.445702172003, 13886.0, 7487.363574096154, 7661.808454788675, 7669.348105410991, 7684.731034413769, 7702.730404435818, 5580.0, 5981.880362392815, 6117.449429551361, 6139.785107521216, 6373.6175829450385, 12648.304343261208, 12728.486188726049, 12852.228866268053, 13089.934550327187, 13173.93413032967, 12800.551980680631, 13097.803532946822, 13201.20792752438, 13358.0, 13416.932915335361, 7470.215627359266, 7669.693212271447, 7676.270754278335, 7694.576798276148, 7702.5763583001235, 9853.901460985298, 9908.702738917844, 9920.851187232342, 9933.106020458194, 9987.350822196535, 7928.445008849325, 8257.256846883569, 8460.703875364332, 8552.786180345542, 8581.785455363666, 7973.20267973198, 8027.59862006909, 8102.230288122619, 8168.387370947084, 8223.342132629496, 7538.472306938462, 7662.693492260247, 7691.884621730566, 7695.307422332017, 7703.499272547267, 4888.560029597354, 5502.312210973629, 5509.944900550943, 5531.0873705838085, 5813.575673959906, 5541.944580554143, 5600.1319795430145, 5608.298962629671, 5674.177244299636, 5782.681952492653], "value": 4741.461932263416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7403688104837, 347.9443289073747, 348.5399272959691, 358.3585382165923, 362.38937390497017, 5482.23248745175, 5611.579131565134, 5620.747066382012, 5627.409122042188, 5661.943380566193, 5379.408265090847, 5448.0, 5457.208704737821, 5477.287952566171, 5481.314835645544, 4113.670906327501, 4130.8141133648905, 4136.7598211832965, 4138.482689663792, 4138.999999999993, 4082.5100987881347, 4131.462909821734, 4150.273702102135, 4156.625903668669, 4169.270377683908, 4093.304138296482, 4111.876643700679, 4111.938320925188, 4118.485189351331, 4130.586941305861, 4084.8146241760514, 4088.1823635273063, 4088.5093788745244, 4098.077932465201, 4103.322951712964, 3552.662497062775, 3555.7866528008403, 3562.305350456662, 3564.269324788438, 3565.2156525564333, 5222.503862133091, 5327.147656374961, 5344.545713614348, 5357.383900851413, 5368.114261146906, 4784.282357646346, 4794.7842347094465, 4809.807607695688, 4814.1334559779225, 4823.2282834746275, 5591.2731344925305, 5780.0, 5791.623544469596, 5801.129830525413, 5806.796762113348, 3981.422693709425, 4011.0574015106426, 4015.4177644241713, 4025.0943537704075, 4028.8589899353383, 6000.459958603747, 6136.7545298188015, 6191.25704915413, 6194.690265486708, 6210.199042277779, 4396.208682437192, 4407.735535867858, 4487.6634252431195, 4491.528389519119, 4502.887427814266, 4547.681662283609, 4554.180247555406, 4564.0871825635, 4564.566366195206, 4564.589186973122, 5000.2749601307605, 5003.424606170264, 5061.291419201315, 5064.898702026013, 5070.0, 5878.0, 5882.676452795137, 5885.676287804126, 5914.58597898143, 5916.112583112482, 1558.158594359056, 1561.4769052367358, 1569.3521802107969, 1572.5911263071685, 1573.5830005048672, 1035.7514196592915, 1102.20090434436, 1107.2692023264606, 1117.5418078587902, 1125.0661950580998, 5092.9236061459105, 5099.64302498829, 5100.846974590768, 5104.285400043997, 5131.0, 6074.635521868702, 6081.5742897996715, 6114.633122012605, 6117.174181485531, 6117.510599152057, 4889.462159162489, 4998.300237966688, 5029.924551131736, 5037.118504261813, 5101.0, 3191.393635209303, 3229.951550726741, 3233.1917020744813, 3235.029491152645, 3242.189452636841, 5530.944690553123, 5549.972250138804, 5583.246261754693, 5595.776168953278, 5601.271834661549, 6157.907631385533, 6192.721327540272, 6219.751209951552, 6290.559660823698, 6315.473810475754, 5578.44215578447, 5583.972080139573, 5592.797548527086, 5601.29983752031, 5623.915641265385, 5935.881282374415, 5999.100134979788, 6044.607100538451, 6079.726412311545, 6084.148219249397, 5992.43071908168, 5997.460228579449, 6010.4891084258325, 6017.3681763414215, 6021.729022193924, 5335.759890805, 5364.570834333166, 5460.726963651881, 5521.806736764194, 5575.526080283222, 4423.314386270134, 4431.135928493913, 4436.3123715824095, 4472.195004899149, 4473.306637471197, 5933.465988060922, 6010.909836352545, 6094.421030002142, 6096.451319381277, 6114.6942652868065, 5846.94153058481, 5873.324567674601, 5880.970595146997, 5881.500072493886, 5897.67562784051, 5864.970675146597, 5865.530757539472, 5885.146653735099, 5889.793857214977, 5894.263217097863, 5696.743646535833, 5779.422057794187, 5814.592978491465, 5839.4744472995935, 5841.766329346949, 5900.911486327623, 5916.290045194604, 5919.704014799329, 5931.042755890632, 5947.197128387786, 5558.694271815089, 5628.831135065954, 5721.76981948883, 5738.655680659173, 5743.684097374685], "value": 4398.980770705339, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.641630976357, 711.6655172069126, 740.5408646639085, 752.2552672853875, 766.3907193780947, 13887.930560347197, 14645.487407940724, 14685.853141468595, 15782.684346313095, 16499.17504124795, 16451.177441127926, 16616.50150495487, 16642.417515386933, 16673.66652666949, 16679.166041697896, 887.2680038967845, 908.7137551671235, 909.0818273543703, 909.940853844498, 913.7441516375426, 886.8093359927615, 925.2228128372166, 936.536414474836, 936.7189843047058, 937.74212091675, 954.4368822394786, 956.4022485946283, 957.1529196660971, 957.2103015012608, 957.5930229652405, 948.8766460360143, 949.0699114867434, 949.3829011142743, 949.4777872170313, 949.895511493742, 695.0929037605922, 699.3530983839978, 699.8355386484172, 701.1130919386928, 703.0052475746812, 14200.0, 14482.1310721356, 14542.854571454256, 14593.70812583753, 14613.634659133606, 15820.604484887856, 16355.672886542203, 16444.177791110516, 16454.0, 16469.176541172892, 12211.206271592318, 12325.568605098779, 12706.491740330375, 12716.300603466805, 12756.61730148097, 3011.382666553351, 3012.29211135383, 3045.512717965137, 3054.4501989641853, 3057.8623961921544, 82662.0, 83859.5807020967, 83859.5807020967, 84923.0, 85435.5728221355, 12187.634370968884, 12274.140810143204, 12390.380480975915, 12442.81335779964, 12442.937785311196, 22112.44718882041, 22814.543709125726, 22871.31386058421, 23071.769282307298, 23119.0, 6150.108234306001, 6280.654563999024, 6321.620702757849, 6361.268454127742, 6381.8085457436355, 2874.770018398523, 2925.195571217932, 2935.5303151496087, 2943.7203465670727, 2946.145617770865, 3769.7361184717356, 3807.447920051577, 3857.8263978121054, 3861.2856621525107, 3867.110564570108, 687.4946914018193, 695.7112798188796, 695.8016965164903, 697.0589703899694, 698.671624336561, 552.486187845301, 589.2016317889284, 612.1093808508609, 626.8840264551072, 642.9678516074177, 9633.662821801203, 10595.099416549525, 10842.132629389629, 11054.392008439612, 11080.168987325982, 587.4213899309177, 613.141601757543, 623.1991890420878, 634.7175506899478, 640.2892789004202, 4722.858314250578, 4926.0, 5011.173156429221, 5219.973900130475, 5353.170258609922, 83524.58237708773, 83907.58046209851, 84590.57704711438, 86783.56608216919, 87555.0, 74268.25731742721, 77720.0, 77758.0, 77944.61027694939, 78155.60922195352, 59114.0, 60183.69908150431, 61112.0, 61753.38246617566, 68496.6575167131, 10322.948385258025, 10836.837447438453, 11478.483468243781, 11518.308901465938, 11537.365444900612, 28000.29999250035, 28533.14400567903, 28635.713642863306, 28800.0, 29258.80558958044, 34254.31491370209, 34317.0, 34454.0, 34733.47899781556, 35071.47392789059, 14557.199354035629, 14768.483103091341, 14932.253387330808, 15078.321475533408, 15122.621934451727, 15777.526674199793, 16153.353865845234, 16246.837531624533, 16529.917350413172, 16531.586710331856, 15014.174220417983, 15190.620234493785, 15304.234788260765, 15441.382344706086, 15545.922270388575, 14658.486952956595, 14697.0, 15065.77401338959, 15468.92265538665, 15586.0, 15572.454964076203, 15780.36878524892, 15872.365105395655, 15996.8400316, 16010.9199454002, 11156.717720578295, 11208.327500350006, 11282.266652667551, 11558.595449159238, 11602.883971160518, 11782.234154779911, 12095.516179353079, 12206.877931220573, 12245.75508489843, 12280.201786883825], "value": 7290.865170577792, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 126.0, 178.0, 125.0, 124.0, 123.0, 129.0, 149.0, 127.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 171.0, 173.0, 162.0, 165.0, 161.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 112.0, 73.0, 75.0, 73.0, 73.0, 100.0, 78.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 83.0, 83.0, 83.0, 97.0, 84.0, 83.0, 111.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 113.0, 114.0, 117.0, 114.0, 114.0, 118.0, 115.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 153.0, 151.0, 152.0, 150.0, 151.0, 152.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 98.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 100.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 61.0, 54.0, 55.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 58.0, 60.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 89.0, 87.0, 91.0, 87.0, 88.0, 87.0, 90.0, 132.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 139.0, 139.0, 132.0, 136.0, 133.0, 132.0, 155.0, 135.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 203.0, 200.0, 210.0, 190.0, 201.0, 204.0, 195.0, 192.0, 193.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 74.0, 75.0, 73.0, 74.0, 74.0, 70.0, 79.0], "value": 74.6, "unit": "score"}]}]} 02:11:54 INFO - Return code: 0 02:11:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:11:54 INFO - # TBPL SUCCESS # 02:11:54 INFO - Running post-action listener: _resource_record_post_action 02:11:54 INFO - [mozharness: 2017-05-27 09:11:54.441525Z] Finished run-tests step (success) 02:11:54 INFO - Running post-run listener: _resource_record_post_run 02:11:54 INFO - Total resource usage - Wall time: 1261s; CPU: 13.0%; Read bytes: 8597504; Write bytes: 419168256; Read time: 1756; Write time: 400500 02:11:54 INFO - TinderboxPrint: CPU usage
12.7% 02:11:54 INFO - TinderboxPrint: I/O read bytes / time
8,597,504 / 1,756 02:11:54 INFO - TinderboxPrint: I/O write bytes / time
419,168,256 / 400,500 02:11:54 INFO - TinderboxPrint: CPU idle
8,783.0 (87.3%) 02:11:54 INFO - TinderboxPrint: CPU user
1,222.4 (12.1%) 02:11:54 INFO - TinderboxPrint: Swap in / out
0 / 0 02:11:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 108748800; Read time: 20; Write time: 86896 02:11:54 INFO - run-tests - Wall time: 1245s; CPU: 13.0%; Read bytes: 6356992; Write bytes: 310419456; Read time: 1508; Write time: 313604 02:11:55 INFO - Running post-run listener: _upload_blobber_files 02:11:55 INFO - Blob upload gear active. 02:11:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:11:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:11:55 INFO - (blobuploader) - INFO - Open directory for files ... 02:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:56 INFO - (blobuploader) - INFO - Done attempting. 02:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:57 INFO - (blobuploader) - INFO - Done attempting. 02:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:11:58 INFO - (blobuploader) - INFO - Done attempting. 02:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:12:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:12:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:12:03 INFO - (blobuploader) - INFO - Done attempting. 02:12:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:12:03 INFO - Return code: 0 02:12:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:12:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:12:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66bc2330c048e60d8e885e56c6a7fd4fd8e7a269fa42ec0aa1291a2915e43817c0a3d8b1c72ae98f1604bb30488563343ecc7847c3dbf4cea4a203c0864b4aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/791da5ff2171c999650fa05494fca4d0572c71de3c5832d5c43cd4a2d50565a5933d0edabb2f591c845afa58d8690c8adf423bcdbf52c47961c6c63ba66bfa0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a611f1187977ed2317e8d6915d586f24b56f24ef77349ae5d705f90a7bd890b82cc5887d326f018351a8667f08e71ede1784d39a3ebc60ba88aa64ff5ed47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/844da559c06cff6b3e92b7b1481810d9e402360773e26dfa91f724bc8d74ab5c58c6fea27c2ebc137dd994fc125795c29ce55640b6065dd2281a37fbb1825738"} 02:12:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:12:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:12:03 INFO - Contents: 02:12:03 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66bc2330c048e60d8e885e56c6a7fd4fd8e7a269fa42ec0aa1291a2915e43817c0a3d8b1c72ae98f1604bb30488563343ecc7847c3dbf4cea4a203c0864b4aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/791da5ff2171c999650fa05494fca4d0572c71de3c5832d5c43cd4a2d50565a5933d0edabb2f591c845afa58d8690c8adf423bcdbf52c47961c6c63ba66bfa0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a611f1187977ed2317e8d6915d586f24b56f24ef77349ae5d705f90a7bd890b82cc5887d326f018351a8667f08e71ede1784d39a3ebc60ba88aa64ff5ed47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/844da559c06cff6b3e92b7b1481810d9e402360773e26dfa91f724bc8d74ab5c58c6fea27c2ebc137dd994fc125795c29ce55640b6065dd2281a37fbb1825738"} 02:12:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:12:03 INFO - Copying logs to upload dir... 02:12:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:12:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1325.873622 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 5 secs) (at 2017-05-27 02:12:03.644787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 02:12:03.648988) ========= 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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 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/sha512/a66bc2330c048e60d8e885e56c6a7fd4fd8e7a269fa42ec0aa1291a2915e43817c0a3d8b1c72ae98f1604bb30488563343ecc7847c3dbf4cea4a203c0864b4aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/791da5ff2171c999650fa05494fca4d0572c71de3c5832d5c43cd4a2d50565a5933d0edabb2f591c845afa58d8690c8adf423bcdbf52c47961c6c63ba66bfa0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a611f1187977ed2317e8d6915d586f24b56f24ef77349ae5d705f90a7bd890b82cc5887d326f018351a8667f08e71ede1784d39a3ebc60ba88aa64ff5ed47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/844da559c06cff6b3e92b7b1481810d9e402360773e26dfa91f724bc8d74ab5c58c6fea27c2ebc137dd994fc125795c29ce55640b6065dd2281a37fbb1825738"} build_url:https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/Uq-60V7AQ9e-6gp7Ofi6fg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a66bc2330c048e60d8e885e56c6a7fd4fd8e7a269fa42ec0aa1291a2915e43817c0a3d8b1c72ae98f1604bb30488563343ecc7847c3dbf4cea4a203c0864b4aa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/791da5ff2171c999650fa05494fca4d0572c71de3c5832d5c43cd4a2d50565a5933d0edabb2f591c845afa58d8690c8adf423bcdbf52c47961c6c63ba66bfa0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2a611f1187977ed2317e8d6915d586f24b56f24ef77349ae5d705f90a7bd890b82cc5887d326f018351a8667f08e71ede1784d39a3ebc60ba88aa64ff5ed47c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/844da559c06cff6b3e92b7b1481810d9e402360773e26dfa91f724bc8d74ab5c58c6fea27c2ebc137dd994fc125795c29ce55640b6065dd2281a37fbb1825738"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-27 02:12:03.672562) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 02:12:03.675886) ========= 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=7de08804244eb36560b44971000001c3-1495858706.824648-1198610443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-27 02:12:03.757471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 02:12:03.760784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-27 02:12:03.761061) ========= ========= Total master_lag: 0.21 =========