builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1501871342.3 results: success (0) revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.297549) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.298069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.298365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.327090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.327417) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 11:29:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-08-04 11:29:02 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.469493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.469844) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016200 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.519053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:02.519400) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc829569880635c52d6e3d54f51cd7d3df180186 --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 bc829569880635c52d6e3d54f51cd7d3df180186 --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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 11:29:02,753 truncating revision to first 12 chars 2017-08-04 11:29:02,753 Setting DEBUG logging. 2017-08-04 11:29:02,753 attempt 1/10 2017-08-04 11:29:02,753 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc8295698806?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 11:29:03,263 unpacking tar archive at: mozilla-central-bc8295698806/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:03.349225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:03.349580) ========= script_repo_revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:03.350140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:03.350426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:29:03.361474) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-04 11:29:03.361854) ========= /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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:29:03 INFO - MultiFileLogger online at 20170804 11:29:03 in /builds/slave/test 11:29:03 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 11:29:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:29:03 INFO - {'append_to_log': False, 11:29:03 INFO - 'base_work_dir': '/builds/slave/test', 11:29:03 INFO - 'blob_upload_branch': 'Firefox', 11:29:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:29:03 INFO - 'branch': 'Firefox', 11:29:03 INFO - 'buildbot_json_path': 'buildprops.json', 11:29:03 INFO - 'code_coverage': False, 11:29:03 INFO - 'config_files': ('talos/linux_config.py',), 11:29:03 INFO - 'default_actions': ('clobber', 11:29:03 INFO - 'read-buildbot-config', 11:29:03 INFO - 'download-and-extract', 11:29:03 INFO - 'populate-webroot', 11:29:03 INFO - 'create-virtualenv', 11:29:03 INFO - 'install', 11:29:03 INFO - 'setup-mitmproxy', 11:29:03 INFO - 'run-tests'), 11:29:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:29:03 INFO - 'disable_ccov_upload': False, 11:29:03 INFO - 'download_minidump_stackwalk': True, 11:29:03 INFO - 'download_symbols': 'ondemand', 11:29:03 INFO - 'enable_stylo': False, 11:29:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:29:03 INFO - 'tooltool.py': '/tools/tooltool.py', 11:29:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:29:03 INFO - '/tools/misc-python/virtualenv.py')}, 11:29:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:29:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:29:03 INFO - 'gecko_profile': False, 11:29:03 INFO - 'gecko_profile_interval': 0, 11:29:03 INFO - 'installer_path': 'installer.exe', 11:29:03 INFO - 'log_level': 'info', 11:29:03 INFO - 'log_name': 'talos', 11:29:03 INFO - 'log_to_console': True, 11:29:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:29:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:29:03 INFO - 'opt_config_files': (), 11:29:03 INFO - 'pip_index': False, 11:29:03 INFO - 'suite': 'dromaeojs-e10s', 11:29:03 INFO - 'system_bits': '32', 11:29:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:29:03 INFO - 'title': 'talos-linux64-ix-059', 11:29:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:29:03 INFO - 'use_talos_json': True, 11:29:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:29:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:29:03 INFO - 'work_dir': 'build'} 11:29:03 INFO - [mozharness: 2017-08-04 18:29:03.794269Z] Running clobber step. 11:29:03 INFO - Running pre-action listener: _resource_record_pre_action 11:29:03 INFO - Running main action method: clobber 11:29:03 INFO - rmtree: /builds/slave/test/build 11:29:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:29:04 INFO - Running post-action listener: _resource_record_post_action 11:29:04 INFO - [mozharness: 2017-08-04 18:29:04.772955Z] Finished clobber step (success) 11:29:04 INFO - [mozharness: 2017-08-04 18:29:04.773058Z] Running read-buildbot-config step. 11:29:04 INFO - Running pre-action listener: _resource_record_pre_action 11:29:04 INFO - Running main action method: read_buildbot_config 11:29:04 INFO - Using buildbot properties: 11:29:04 INFO - { 11:29:04 INFO - "project": "", 11:29:04 INFO - "product": "firefox", 11:29:04 INFO - "who": "archaeopteryx@coole-files.de", 11:29:04 INFO - "installer_path": "public/build/target.tar.bz2", 11:29:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:29:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:29:04 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:29:04 INFO - "stage_platform": "linux64-stylo", 11:29:04 INFO - "basedir": "/builds/slave/test", 11:29:04 INFO - "buildnumber": 256, 11:29:04 INFO - "platform": "ubuntu64_hw_stylo", 11:29:04 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:29:04 INFO - "slavebuilddir": "test", 11:29:04 INFO - "taskId": "Yp_DOm8qQdaB1sX0BDhLzA", 11:29:04 INFO - "branch": "mozilla-central", 11:29:04 INFO - "script_repo_revision": "production", 11:29:04 INFO - "revision": "bc829569880635c52d6e3d54f51cd7d3df180186", 11:29:04 INFO - "slavename": "talos-linux64-ix-059", 11:29:04 INFO - "repo_path": "mozilla-central" 11:29:04 INFO - } 11:29:04 INFO - Finding installer, test and symbols from parent task. 11:29:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yp_DOm8qQdaB1sX0BDhLzA'}, attempt #1 11:29:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yp_DOm8qQdaB1sX0BDhLzA'}, attempt #1 11:29:05 INFO - Task dependencies: Q6EcMmQCRh-0euMeGSZPJw 11:29:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw'}, attempt #1 11:29:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:29:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json 11:29:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip 11:29:06 INFO - Running post-action listener: _resource_record_post_action 11:29:06 INFO - [mozharness: 2017-08-04 18:29:06.165180Z] Finished read-buildbot-config step (success) 11:29:06 INFO - [mozharness: 2017-08-04 18:29:06.165449Z] Running download-and-extract step. 11:29:06 INFO - Running pre-action listener: _resource_record_pre_action 11:29:06 INFO - Running main action method: download_and_extract 11:29:06 INFO - mkdir: /builds/slave/test/build/tests 11:29:06 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')]} 11:29:06 INFO - trying https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json 11:29:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:29:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:29:06 INFO - Downloaded 989 bytes. 11:29:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:29:06 INFO - Using the following test package requirements: 11:29:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:29:06 INFO - u'common': [u'target.common.tests.zip'], 11:29:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:29:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:29:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:29:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:29:06 INFO - u'mozbase': [u'target.common.tests.zip'], 11:29:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:29:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:29:06 INFO - u'web-platform': [u'target.common.tests.zip', 11:29:06 INFO - u'target.web-platform.tests.tar.gz'], 11:29:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:29:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:29:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip 11:29:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:29:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip into memory 11:29:07 INFO - Content-Length response header: 54282354 11:29:07 INFO - Bytes received: 54282354 11:29:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:29:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip 11:29:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:29:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip into memory 11:29:19 INFO - Content-Length response header: 54282354 11:29:19 INFO - Bytes received: 54282354 11:29:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip 11:29:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:29:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip into memory 11:29:33 INFO - Content-Length response header: 14496008 11:29:33 INFO - Bytes received: 14496008 11:29:33 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')]} 11:29:33 INFO - trying https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:29:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:29:34 INFO - Downloaded 61729187 bytes. 11:29:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:29:34 INFO - mkdir: /builds/slave/test/properties 11:29:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:29:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:29:34 INFO - Contents: 11:29:34 INFO - build_url:https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:29:34 INFO - Running post-action listener: _resource_record_post_action 11:29:34 INFO - Running post-action listener: set_extra_try_arguments 11:29:34 INFO - [mozharness: 2017-08-04 18:29:34.678034Z] Finished download-and-extract step (success) 11:29:34 INFO - [mozharness: 2017-08-04 18:29:34.678133Z] Running populate-webroot step. 11:29:34 INFO - Running pre-action listener: _resource_record_pre_action 11:29:34 INFO - Running main action method: populate_webroot 11:29:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:29:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:29:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:29:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:29:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:29:34 INFO - 'tests': ['damp', 'tps']}, 11:29:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:29:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:29:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:29:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:29:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:29:34 INFO - 'ts_paint', 11:29:34 INFO - 'tpaint', 11:29:34 INFO - 'sessionrestore', 11:29:34 INFO - 'sessionrestore_many_windows', 11:29:34 INFO - 'sessionrestore_no_auto_restore', 11:29:34 INFO - 'tabpaint']}, 11:29:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:29:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:29:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:29:34 INFO - 'tsvgr_opacity', 11:29:34 INFO - 'tart', 11:29:34 INFO - 'tscrollx', 11:29:34 INFO - 'tsvg_static']}, 11:29:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:29:34 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:29:34 INFO - 'talos_options': ['--mitmproxy', 11:29:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:29:34 INFO - '--firstNonBlankPaint'], 11:29:34 INFO - 'tests': ['tp6_google', 11:29:34 INFO - 'tp6_youtube', 11:29:34 INFO - 'tp6_amazon', 11:29:34 INFO - 'tp6_facebook']}, 11:29:34 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:29:34 INFO - 'talos_options': ['--stylo', 11:29:34 INFO - '--mitmproxy', 11:29:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:29:34 INFO - '--firstNonBlankPaint'], 11:29:34 INFO - 'tests': ['tp6_google', 11:29:34 INFO - 'tp6_youtube', 11:29:34 INFO - 'tp6_amazon', 11:29:34 INFO - 'tp6_facebook']}, 11:29:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:29:34 INFO - 'talos_options': ['--stylo', 11:29:34 INFO - '--stylo-threads=1', 11:29:34 INFO - '--mitmproxy', 11:29:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:29:34 INFO - '--firstNonBlankPaint'], 11:29:34 INFO - 'tests': ['tp6_google', 11:29:34 INFO - 'tp6_youtube', 11:29:34 INFO - 'tp6_amazon', 11:29:34 INFO - 'tp6_facebook']}, 11:29:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:29:34 INFO - 'talos_options': ['--xperf_path', 11:29:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:29:34 INFO - 'tests': ['tp5n']}}} 11:29:34 INFO - Running post-action listener: _resource_record_post_action 11:29:34 INFO - [mozharness: 2017-08-04 18:29:34.686725Z] Finished populate-webroot step (success) 11:29:34 INFO - [mozharness: 2017-08-04 18:29:34.686816Z] Running create-virtualenv step. 11:29:34 INFO - Running pre-action listener: _resource_record_pre_action 11:29:34 INFO - Running main action method: create_virtualenv 11:29:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:29:34 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 11:29:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:29:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:29:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:29:34 INFO - Using real prefix '/usr' 11:29:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:29:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:29:37 INFO - Installing pip.................done. 11:29:37 INFO - Return code: 0 11:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:29:39 INFO - Reading from file tmpfile_stdout 11:29:39 INFO - Output received: 11:29:39 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) 11:29:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29: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')]} 11:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29: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', 'pip>=1.5'] in /builds/slave/test/build 11:29: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 pip>=1.5 11:29:39 INFO - Using env: {'DISPLAY': ':0', 11:29:39 INFO - 'HOME': '/home/cltbld', 11:29:39 INFO - 'LANG': 'en_US.UTF-8', 11:29:39 INFO - 'LANGUAGE': 'en_US:en', 11:29:39 INFO - 'LOGNAME': 'cltbld', 11:29:39 INFO - 'MAIL': '/var/mail/cltbld', 11:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:39 INFO - 'MOZ_NO_REMOTE': '1', 11:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:39 INFO - 'NO_EM_RESTART': '1', 11:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:39 INFO - 'PWD': '/builds/slave/test', 11:29:39 INFO - 'SHELL': '/bin/bash', 11:29:39 INFO - 'SHLVL': '1', 11:29:39 INFO - 'TERM': 'linux', 11:29:39 INFO - 'TMOUT': '86400', 11:29:39 INFO - 'USER': 'cltbld', 11:29:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:39 INFO - '_': '/tools/buildbot/bin/python'} 11:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:39 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 11:29:39 INFO - Cleaning up... 11:29:39 INFO - Return code: 0 11:29:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29: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')]} 11:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29: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', '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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:29: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 psutil>=3.1.1 11:29:39 INFO - Using env: {'DISPLAY': ':0', 11:29:39 INFO - 'HOME': '/home/cltbld', 11:29:39 INFO - 'LANG': 'en_US.UTF-8', 11:29:39 INFO - 'LANGUAGE': 'en_US:en', 11:29:39 INFO - 'LOGNAME': 'cltbld', 11:29:39 INFO - 'MAIL': '/var/mail/cltbld', 11:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:39 INFO - 'MOZ_NO_REMOTE': '1', 11:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:39 INFO - 'NO_EM_RESTART': '1', 11:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:39 INFO - 'PWD': '/builds/slave/test', 11:29:39 INFO - 'SHELL': '/bin/bash', 11:29:39 INFO - 'SHLVL': '1', 11:29:39 INFO - 'TERM': 'linux', 11:29:39 INFO - 'TMOUT': '86400', 11:29:39 INFO - 'USER': 'cltbld', 11:29:39 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:39 INFO - '_': '/tools/buildbot/bin/python'} 11:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:40 INFO - Downloading/unpacking psutil>=3.1.1 11:29: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 11:29: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 11:29: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 11:29: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 11:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:29:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:41 INFO - Installing collected packages: psutil 11:29:41 INFO - Running setup.py install for psutil 11:29:41 INFO - building 'psutil._psutil_linux' extension 11:29:41 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 11:29:42 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 11:29:43 INFO - building 'psutil._psutil_posix' extension 11:29:43 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 11:29:43 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 11:29:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:29:43 INFO - Successfully installed psutil 11:29:43 INFO - Cleaning up... 11:29:43 INFO - Return code: 0 11:29:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:29:43 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')]} 11:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:43 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')]} 11:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:43 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:43 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 11:29:43 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 11:29:43 INFO - Using env: {'DISPLAY': ':0', 11:29:43 INFO - 'HOME': '/home/cltbld', 11:29:43 INFO - 'LANG': 'en_US.UTF-8', 11:29:43 INFO - 'LANGUAGE': 'en_US:en', 11:29:43 INFO - 'LOGNAME': 'cltbld', 11:29:43 INFO - 'MAIL': '/var/mail/cltbld', 11:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:43 INFO - 'MOZ_NO_REMOTE': '1', 11:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:43 INFO - 'NO_EM_RESTART': '1', 11:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:43 INFO - 'PWD': '/builds/slave/test', 11:29:43 INFO - 'SHELL': '/bin/bash', 11:29:43 INFO - 'SHLVL': '1', 11:29:43 INFO - 'TERM': 'linux', 11:29:43 INFO - 'TMOUT': '86400', 11:29:43 INFO - 'USER': 'cltbld', 11:29:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:43 INFO - '_': '/tools/buildbot/bin/python'} 11:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:29: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 11:29: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 11:29: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 11:29: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 11:29:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:29:44 INFO - Installing collected packages: mozsystemmonitor 11:29:44 INFO - Running setup.py install for mozsystemmonitor 11:29:44 INFO - Successfully installed mozsystemmonitor 11:29:44 INFO - Cleaning up... 11:29:44 INFO - Return code: 0 11:29:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29: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')]} 11:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:44 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:44 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 11:29:44 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 11:29:44 INFO - Using env: {'DISPLAY': ':0', 11:29:44 INFO - 'HOME': '/home/cltbld', 11:29:44 INFO - 'LANG': 'en_US.UTF-8', 11:29:44 INFO - 'LANGUAGE': 'en_US:en', 11:29:44 INFO - 'LOGNAME': 'cltbld', 11:29:44 INFO - 'MAIL': '/var/mail/cltbld', 11:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:44 INFO - 'MOZ_NO_REMOTE': '1', 11:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:44 INFO - 'NO_EM_RESTART': '1', 11:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:44 INFO - 'PWD': '/builds/slave/test', 11:29:44 INFO - 'SHELL': '/bin/bash', 11:29:44 INFO - 'SHLVL': '1', 11:29:44 INFO - 'TERM': 'linux', 11:29:44 INFO - 'TMOUT': '86400', 11:29:44 INFO - 'USER': 'cltbld', 11:29:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:44 INFO - '_': '/tools/buildbot/bin/python'} 11:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:44 INFO - Downloading/unpacking jsonschema==2.5.1 11:29: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 11:29: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 11:29: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 11:29: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 11:29:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:29:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:29:46 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 11:29:46 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 11:29:46 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 11:29:46 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 11:29:46 INFO - Downloading functools32-3.2.3-2.tar.gz 11:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:29:46 INFO - warning: no files found matching '*.txt' 11:29:46 INFO - no previously-included directories found matching 'build' 11:29:46 INFO - no previously-included directories found matching 'dist' 11:29:46 INFO - no previously-included directories found matching '.git*' 11:29:46 INFO - Installing collected packages: jsonschema, functools32 11:29:46 INFO - Running setup.py install for functools32 11:29:46 INFO - warning: no files found matching '*.txt' 11:29:46 INFO - no previously-included directories found matching 'build' 11:29:46 INFO - no previously-included directories found matching 'dist' 11:29:46 INFO - no previously-included directories found matching '.git*' 11:29:46 INFO - Successfully installed jsonschema functools32 11:29:46 INFO - Cleaning up... 11:29:46 INFO - Return code: 0 11:29:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:29:46 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')]} 11:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:46 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')]} 11:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:46 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:46 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 11:29:46 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 11:29:46 INFO - Using env: {'DISPLAY': ':0', 11:29:46 INFO - 'HOME': '/home/cltbld', 11:29:46 INFO - 'LANG': 'en_US.UTF-8', 11:29:46 INFO - 'LANGUAGE': 'en_US:en', 11:29:46 INFO - 'LOGNAME': 'cltbld', 11:29:46 INFO - 'MAIL': '/var/mail/cltbld', 11:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:46 INFO - 'MOZ_NO_REMOTE': '1', 11:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:46 INFO - 'NO_EM_RESTART': '1', 11:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:46 INFO - 'PWD': '/builds/slave/test', 11:29:46 INFO - 'SHELL': '/bin/bash', 11:29:46 INFO - 'SHLVL': '1', 11:29:46 INFO - 'TERM': 'linux', 11:29:46 INFO - 'TMOUT': '86400', 11:29:46 INFO - 'USER': 'cltbld', 11:29:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:46 INFO - '_': '/tools/buildbot/bin/python'} 11:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:29:46 INFO - Cleaning up... 11:29:46 INFO - Return code: 0 11:29:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:29:46 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')]} 11:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:46 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')]} 11:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:46 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:46 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 11:29:46 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 11:29:46 INFO - Using env: {'DISPLAY': ':0', 11:29:46 INFO - 'HOME': '/home/cltbld', 11:29:46 INFO - 'LANG': 'en_US.UTF-8', 11:29:46 INFO - 'LANGUAGE': 'en_US:en', 11:29:46 INFO - 'LOGNAME': 'cltbld', 11:29:46 INFO - 'MAIL': '/var/mail/cltbld', 11:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:46 INFO - 'MOZ_NO_REMOTE': '1', 11:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:46 INFO - 'NO_EM_RESTART': '1', 11:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:46 INFO - 'PWD': '/builds/slave/test', 11:29:46 INFO - 'SHELL': '/bin/bash', 11:29:46 INFO - 'SHLVL': '1', 11:29:46 INFO - 'TERM': 'linux', 11:29:46 INFO - 'TMOUT': '86400', 11:29:46 INFO - 'USER': 'cltbld', 11:29:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:46 INFO - '_': '/tools/buildbot/bin/python'} 11:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:29:46 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 11:29:46 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 11:29:46 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 11:29:46 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 11:29:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:29:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:29:48 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 11:29:48 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 11:29:48 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 11:29:48 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 11:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:29:48 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 11:29:48 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 11:29:48 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 11:29:48 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 11:29:48 INFO - Downloading docopt-0.6.1.tar.gz 11:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:29:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:29:48 INFO - Running setup.py install for blobuploader 11:29:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:29:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:29:48 INFO - Running setup.py install for requests 11:29:49 INFO - Running setup.py install for docopt 11:29:49 INFO - Successfully installed blobuploader requests docopt 11:29:49 INFO - Cleaning up... 11:29:49 INFO - Return code: 0 11:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:49 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')]} 11:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:49 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')]} 11:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:49 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:49 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 11:29:49 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 11:29:49 INFO - Using env: {'DISPLAY': ':0', 11:29:49 INFO - 'HOME': '/home/cltbld', 11:29:49 INFO - 'LANG': 'en_US.UTF-8', 11:29:49 INFO - 'LANGUAGE': 'en_US:en', 11:29:49 INFO - 'LOGNAME': 'cltbld', 11:29:49 INFO - 'MAIL': '/var/mail/cltbld', 11:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:49 INFO - 'MOZ_NO_REMOTE': '1', 11:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:49 INFO - 'NO_EM_RESTART': '1', 11:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:49 INFO - 'PWD': '/builds/slave/test', 11:29:49 INFO - 'SHELL': '/bin/bash', 11:29:49 INFO - 'SHLVL': '1', 11:29:49 INFO - 'TERM': 'linux', 11:29:49 INFO - 'TMOUT': '86400', 11:29:49 INFO - 'USER': 'cltbld', 11:29:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:49 INFO - '_': '/tools/buildbot/bin/python'} 11:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:49 INFO - Running setup.py (path:/tmp/pip-rOEAAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:49 INFO - Running setup.py (path:/tmp/pip-LYuY2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:49 INFO - Running setup.py (path:/tmp/pip-BWYkW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:49 INFO - Running setup.py (path:/tmp/pip-W5cUoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:49 INFO - Running setup.py (path:/tmp/pip-7fSdPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:49 INFO - Running setup.py (path:/tmp/pip-DvTAqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:49 INFO - Running setup.py (path:/tmp/pip-gLVEDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:49 INFO - Running setup.py (path:/tmp/pip-JtNIMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:49 INFO - Running setup.py (path:/tmp/pip-JlAoOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:50 INFO - Running setup.py (path:/tmp/pip-RpNtc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:50 INFO - Running setup.py (path:/tmp/pip-DMzaPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:50 INFO - Running setup.py (path:/tmp/pip-Ipl4ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:50 INFO - Running setup.py (path:/tmp/pip-KnaH_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:50 INFO - Running setup.py (path:/tmp/pip-FlEI8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:50 INFO - Running setup.py (path:/tmp/pip-pqIGNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:50 INFO - Running setup.py (path:/tmp/pip-5yIPou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:50 INFO - Running setup.py (path:/tmp/pip-PFel89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:29:50 INFO - Running setup.py install for manifestparser 11:29:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:29:50 INFO - Running setup.py install for mozcrash 11:29:50 INFO - Running setup.py install for mozdebug 11:29:50 INFO - Running setup.py install for mozdevice 11:29:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozfile 11:29:51 INFO - Running setup.py install for mozhttpd 11:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozinfo 11:29:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozInstall 11:29:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozleak 11:29:51 INFO - Running setup.py install for mozlog 11:29:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for moznetwork 11:29:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozprocess 11:29:51 INFO - Running setup.py install for mozprofile 11:29:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:29:51 INFO - Running setup.py install for mozrunner 11:29:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:29:52 INFO - Running setup.py install for mozscreenshot 11:29:52 INFO - Running setup.py install for moztest 11:29:52 INFO - Running setup.py install for mozversion 11:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:29:52 INFO - Cleaning up... 11:29:52 INFO - Return code: 0 11:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29: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')]} 11:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29: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')]} 11:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:52 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:52 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 11:29:52 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 11:29:52 INFO - Using env: {'DISPLAY': ':0', 11:29:52 INFO - 'HOME': '/home/cltbld', 11:29:52 INFO - 'LANG': 'en_US.UTF-8', 11:29:52 INFO - 'LANGUAGE': 'en_US:en', 11:29:52 INFO - 'LOGNAME': 'cltbld', 11:29:52 INFO - 'MAIL': '/var/mail/cltbld', 11:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:52 INFO - 'MOZ_NO_REMOTE': '1', 11:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:52 INFO - 'NO_EM_RESTART': '1', 11:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:52 INFO - 'PWD': '/builds/slave/test', 11:29:52 INFO - 'SHELL': '/bin/bash', 11:29:52 INFO - 'SHLVL': '1', 11:29:52 INFO - 'TERM': 'linux', 11:29:52 INFO - 'TMOUT': '86400', 11:29:52 INFO - 'USER': 'cltbld', 11:29:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:52 INFO - '_': '/tools/buildbot/bin/python'} 11:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:29:52 INFO - Running setup.py (path:/tmp/pip-yoTynR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:29:52 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)) 11:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:29:52 INFO - Running setup.py (path:/tmp/pip-H4SlyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:29:52 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)) 11:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:29:52 INFO - Running setup.py (path:/tmp/pip-rUX5L_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:29:52 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)) 11:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:29:52 INFO - Running setup.py (path:/tmp/pip-ySNx5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:29:52 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)) 11:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:29:52 INFO - Running setup.py (path:/tmp/pip-qLBCn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:29:53 INFO - Running setup.py (path:/tmp/pip-svU0ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:29:53 INFO - Running setup.py (path:/tmp/pip-LmGsN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:29:53 INFO - Running setup.py (path:/tmp/pip-TqzB2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:29:53 INFO - Running setup.py (path:/tmp/pip-xlnwci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:29:53 INFO - Running setup.py (path:/tmp/pip-V0gt24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:29:53 INFO - Running setup.py (path:/tmp/pip-JHrf4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:29:53 INFO - Running setup.py (path:/tmp/pip-1SIAMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:29:53 INFO - Running setup.py (path:/tmp/pip-q2xmI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:29:53 INFO - Running setup.py (path:/tmp/pip-WlW_V_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:53 INFO - Running setup.py (path:/tmp/pip-Mg2Zcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:29:53 INFO - Running setup.py (path:/tmp/pip-Or1vh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:29:53 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)) 11:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:29:53 INFO - Running setup.py (path:/tmp/pip-BMlTPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:29:53 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)) 11:29:53 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)) 11:29:53 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)) 11:29:53 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)) 11:29:53 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)) 11:29:53 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)) 11:29:53 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:29:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:29:53 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 11:29:53 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 11:29:53 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 11:29:53 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 11:29:54 INFO - Downloading blessings-1.6.tar.gz 11:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:29:55 INFO - Installing collected packages: blessings 11:29:55 INFO - Running setup.py install for blessings 11:29:55 INFO - Successfully installed blessings 11:29:55 INFO - Cleaning up... 11:29:55 INFO - Return code: 0 11:29:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:55 INFO - Reading from file tmpfile_stdout 11:29:55 INFO - Current package versions: 11:29:55 INFO - argparse == 1.2.1 11:29:55 INFO - blessings == 1.6 11:29:55 INFO - blobuploader == 1.2.4 11:29:55 INFO - docopt == 0.6.1 11:29:55 INFO - functools32 == 3.2.3-2 11:29:55 INFO - jsonschema == 2.5.1 11:29:55 INFO - manifestparser == 1.1 11:29:55 INFO - mozInstall == 1.13 11:29:55 INFO - mozcrash == 1.0 11:29:55 INFO - mozdebug == 0.1 11:29:55 INFO - mozdevice == 0.51 11:29:55 INFO - mozfile == 1.2 11:29:55 INFO - mozhttpd == 0.7 11:29:55 INFO - mozinfo == 0.10 11:29:55 INFO - mozleak == 0.1 11:29:55 INFO - mozlog == 3.5 11:29:55 INFO - moznetwork == 0.27 11:29:55 INFO - mozprocess == 0.25 11:29:55 INFO - mozprofile == 0.28 11:29:55 INFO - mozrunner == 6.13 11:29:55 INFO - mozscreenshot == 0.1 11:29:55 INFO - mozsystemmonitor == 0.3 11:29:55 INFO - moztest == 0.8 11:29:55 INFO - mozversion == 1.4 11:29:55 INFO - psutil == 3.1.1 11:29:55 INFO - requests == 1.2.3 11:29:55 INFO - wsgiref == 0.1.2 11:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:29:55 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')]} 11:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:55 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')]} 11:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:55 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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:55 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 11:29:55 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 11:29:55 INFO - Using env: {'DISPLAY': ':0', 11:29:55 INFO - 'HOME': '/home/cltbld', 11:29:55 INFO - 'LANG': 'en_US.UTF-8', 11:29:55 INFO - 'LANGUAGE': 'en_US:en', 11:29:55 INFO - 'LOGNAME': 'cltbld', 11:29:55 INFO - 'MAIL': '/var/mail/cltbld', 11:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:55 INFO - 'MOZ_NO_REMOTE': '1', 11:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:55 INFO - 'NO_EM_RESTART': '1', 11:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:55 INFO - 'PWD': '/builds/slave/test', 11:29:55 INFO - 'SHELL': '/bin/bash', 11:29:55 INFO - 'SHLVL': '1', 11:29:55 INFO - 'TERM': 'linux', 11:29:55 INFO - 'TMOUT': '86400', 11:29:55 INFO - 'USER': 'cltbld', 11:29:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:55 INFO - '_': '/tools/buildbot/bin/python'} 11:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 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)) 11:29:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:29:55 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 11:29:55 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 11:29:55 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 11:29:55 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 11:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:29:56 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)) 11:29:56 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)) 11:29:56 INFO - Installing collected packages: simplejson 11:29:56 INFO - Running setup.py install for simplejson 11:29:56 INFO - building 'simplejson._speedups' extension 11:29:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:29:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:29:57 INFO - Successfully installed simplejson 11:29:57 INFO - Cleaning up... 11:29:57 INFO - Return code: 0 11:29:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:29:57 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')]} 11:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:29:57 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')]} 11:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:29:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x13781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1544a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e7d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', '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 11:29:57 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 11:29:57 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 11:29:57 INFO - Using env: {'DISPLAY': ':0', 11:29:57 INFO - 'HOME': '/home/cltbld', 11:29:57 INFO - 'LANG': 'en_US.UTF-8', 11:29:57 INFO - 'LANGUAGE': 'en_US:en', 11:29:57 INFO - 'LOGNAME': 'cltbld', 11:29:57 INFO - 'MAIL': '/var/mail/cltbld', 11:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:29:57 INFO - 'MOZ_NO_REMOTE': '1', 11:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:29:57 INFO - 'NO_EM_RESTART': '1', 11:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:29:57 INFO - 'PWD': '/builds/slave/test', 11:29:57 INFO - 'SHELL': '/bin/bash', 11:29:57 INFO - 'SHLVL': '1', 11:29:57 INFO - 'TERM': 'linux', 11:29:57 INFO - 'TMOUT': '86400', 11:29:57 INFO - 'USER': 'cltbld', 11:29:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:29:57 INFO - '_': '/tools/buildbot/bin/python'} 11:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:29:58 INFO - Cleaning up... 11:29:58 INFO - Return code: 0 11:29:58 INFO - Running post-action listener: _resource_record_post_action 11:29:58 INFO - Running post-action listener: _start_resource_monitoring 11:29:58 INFO - Starting resource monitoring. 11:29:58 INFO - [mozharness: 2017-08-04 18:29:58.191105Z] Finished create-virtualenv step (success) 11:29:58 INFO - [mozharness: 2017-08-04 18:29:58.192104Z] Running install step. 11:29:58 INFO - Running pre-action listener: _resource_record_pre_action 11:29:58 INFO - Running main action method: install 11:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:29:58 INFO - Reading from file tmpfile_stdout 11:29:58 INFO - Detecting whether we're running mozinstall >=1.0... 11:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:29:58 INFO - Reading from file tmpfile_stdout 11:29:58 INFO - Output received: 11:29:58 INFO - Usage: mozinstall [options] installer 11:29:58 INFO - Options: 11:29:58 INFO - -h, --help show this help message and exit 11:29:58 INFO - -d DEST, --destination=DEST 11:29:58 INFO - Directory to install application into. [default: 11:29:58 INFO - "/builds/slave/test"] 11:29:58 INFO - --app=APP Application being installed. [default: firefox] 11:29:58 INFO - mkdir: /builds/slave/test/build/application 11:29:58 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'] 11:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:30:16 INFO - Reading from file tmpfile_stdout 11:30:16 INFO - Output received: 11:30:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:30:16 INFO - Running post-action listener: _resource_record_post_action 11:30:16 INFO - [mozharness: 2017-08-04 18:30:16.496697Z] Finished install step (success) 11:30:16 INFO - [mozharness: 2017-08-04 18:30:16.496924Z] Running setup-mitmproxy step. 11:30:16 INFO - Running pre-action listener: _resource_record_pre_action 11:30:16 INFO - Running main action method: setup_mitmproxy 11:30:16 INFO - Skipping: mitmproxy is not required 11:30:16 INFO - Running post-action listener: _resource_record_post_action 11:30:16 INFO - [mozharness: 2017-08-04 18:30:16.497741Z] Finished setup-mitmproxy step (success) 11:30:16 INFO - [mozharness: 2017-08-04 18:30:16.497963Z] Running run-tests step. 11:30:16 INFO - Running pre-action listener: _resource_record_pre_action 11:30:16 INFO - Running pre-action listener: _set_gcov_prefix 11:30:16 INFO - Running main action method: run_tests 11:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:30:16 INFO - Python 2.7.3 11:30:16 INFO - Return code: 0 11:30:16 INFO - grabbing minidump binary from tooltool 11:30:16 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')]} 11:30:16 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 0x16e4eb0>, '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 0x16e5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e6240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:30:16 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 11:30:16 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 11:30:16 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 11:30:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:30:16 INFO - Return code: 0 11:30:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:30:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:30:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:30:16 INFO - ENV: RUST_BACKTRACE is now 1 11:30:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:30:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:30:16 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:30:16 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 11:30:16 INFO - Using env: {'DISPLAY': ':0', 11:30:16 INFO - 'HOME': '/home/cltbld', 11:30:16 INFO - 'LANG': 'en_US.UTF-8', 11:30:16 INFO - 'LANGUAGE': 'en_US:en', 11:30:16 INFO - 'LOGNAME': 'cltbld', 11:30:16 INFO - 'MAIL': '/var/mail/cltbld', 11:30:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:30:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:30:16 INFO - 'MOZ_NO_REMOTE': '1', 11:30:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:30:16 INFO - 'NO_EM_RESTART': '1', 11:30:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:30:16 INFO - 'PWD': '/builds/slave/test', 11:30:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:30:16 INFO - 'RUST_BACKTRACE': '1', 11:30:16 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:30:16 INFO - 'SHELL': '/bin/bash', 11:30:16 INFO - 'SHLVL': '1', 11:30:16 INFO - 'STYLO_FORCE_ENABLED': '1', 11:30:16 INFO - 'TERM': 'linux', 11:30:16 INFO - 'TMOUT': '86400', 11:30:16 INFO - 'USER': 'cltbld', 11:30:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390', 11:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:30:16 INFO - '_': '/tools/buildbot/bin/python'} 11:30:16 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 11:30:17 INFO - mozversion application_buildid: 20170804172933 11:30:17 INFO - mozversion application_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:30:17 INFO - mozversion application_display_name: Nightly 11:30:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:30:17 INFO - mozversion application_name: Firefox 11:30:17 INFO - mozversion application_remotingname: firefox 11:30:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:30:17 INFO - mozversion application_vendor: Mozilla 11:30:17 INFO - mozversion application_version: 57.0a1 11:30:17 INFO - mozversion platform_buildid: 20170804172933 11:30:17 INFO - mozversion platform_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:30:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:30:17 INFO - mozversion platform_version: 57.0a1 11:30:17 INFO - using testdate: 1501871417 11:30:17 INFO - actual date: 1501871417 11:30:17 INFO - starting webserver on 'localhost:34742' 11:30:17 INFO - SUITE-START | Running 2 tests 11:30:17 INFO - TEST-START | dromaeo_css 11:30:17 INFO - Initialising browser for dromaeo_css test... 11:30:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34742/getInfo.html -profile /tmp/tmpS75oG7/profile 11:30:17 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox http://localhost:34742/getInfo.html) 11:30:25 INFO - TEST-INFO | 3340: exit 0 11:30:25 INFO - Browser initialized. 11:30:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:30:25 INFO - TEST-INFO | started process 3567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS75oG7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:30:26 INFO - PID 3567 | 11:30:26 INFO - PID 3567 | (/builds/slave/test/build/application/firefox/firefox:3621): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:30:26 INFO - PID 3567 | 11:30:36 INFO - PID 3567 | RSS: Main: 174166016 11:30:36 INFO - PID 3567 | 11:33:35 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34742/tests/dromaeo/cssquery-ext.html) 11:33:37 INFO - PID 3567 | RSS: Main: 175763456 11:33:37 INFO - PID 3567 | 11:36:39 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-ext.html (next: http://localhost:34742/tests/dromaeo/cssquery-jquery.html) 11:36:40 INFO - PID 3567 | RSS: Main: 173129728 11:36:40 INFO - PID 3567 | 11:39:41 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34742/tests/dromaeo/cssquery-mootools.html) 11:39:42 INFO - PID 3567 | RSS: Main: 175271936 11:39:42 INFO - PID 3567 | 11:42:44 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34742/tests/dromaeo/cssquery-prototype.html) 11:42:44 INFO - PID 3567 | RSS: Main: 173522944 11:42:44 INFO - PID 3567 | 11:45:48 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34742/tests/dromaeo/cssquery-yui.html) 11:45:49 INFO - PID 3567 | RSS: Main: 177098752 11:45:49 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | Cycle 1(1): loaded http://localhost:34742/tests/dromaeo/cssquery-yui.html (next: http://localhost:34742/tests/dromaeo/cssquery-dojo.html) 11:48:51 INFO - PID 3567 | RSS: Main: 177893376 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | __start_tp_report 11:48:51 INFO - PID 3567 | _x_x_mozilla_page_load 11:48:51 INFO - PID 3567 | _x_x_mozilla_page_load_details 11:48:51 INFO - PID 3567 | |i|pagename|runs| 11:48:51 INFO - PID 3567 | |0;dojo.html;3052.7557795376374;3157.810531368118;3176.507641315597;3195.568598239237;3208.7272581830534;6044.697765111743;6095.9999999999945;6113.816585502431;6141.754329826807;6144.631322120676;6189.288231853338;6321.589096708711;6356.237251529811;6381.074744162105;6388.712507937143;5716.028275193206;5718.331064945678;5774.6535207887455;5815.651060936336;5864.677442740647;5539.833804985837;5700.230468886689;5701.71491425427;5796.449337312949;5905.734241959122;5646.604737668365;5679.176519404705;5685.516731077863;5713.228714123582;5825.650460972355;5730.7421166047625;5795.82612521625;5805.680687562224;5809.448102430262;5827.883442331172;5661.122526008434;5688.943110568925;5710.828675139753;5775.422457754233;5783.566232532535;6078.270607527125;6172.07418887166;6179;6189.845253868644;6324.557280990332;6637.336266373372;6682.732690692366;6704.061431399608;6785.762498312535;6794.320567943216;6715.194176698778;6843.076184715099;6849.589024658537;6858.108445902001;6873.690683919235;6228.719707613213;6241.65670888101;6321.936780632181;6356.078368636522;6373.71318290678;6748.257691653914;6896.034555162181;6898.666561152229;6902.309769023058;6994.825129371705;6649.202095748445;6651.268360480343;6652.467802575782;6655.401013908675;6657.667116644148;6721.7311307548125;6747.932520674829;6826.419754320839;6840.110785597841;6842.521023528405;6674.5327827052615;6718.093057437183;6762.323767623297;6792.966035169792;6813.1142951415995;6482.708278127496;6625.403713665697;6704.094947182166;6719.966400168066;6814.557053791487;4977.751112444435;4993.925091123636;4995.625328100407;4999.150144475448;4999.325091112653;4358.346248062752;4400.515943246241;4404.66964977628;4419.845305414295;4445.444319460067;5830.650160990354;5887.1463637772285;5909.615874968199;5914.349421563625;5923.289205295306;6766.72933082681;6779.49153813466;6866.176058872968;6871.106756121672;6885.586864788129;5713.400092990176;5795.043817770105;5832.24180856486;5837.6497410155525;5901.881962360729;5977.103434484862;5984.1323008164445;5997.580169388101;6004.789832355847;6008.21893153896;6456.451201647818;6590.143281373486;6604.042413849965;6613.503987200883;6613.867722645617;6779.491538134758;6789.830254243683;6869.553479023847;6879.724811007503;6898.206706228848;6365.586236894587;6484.902726459201;6494.6103233806125;6505.447037001908;6592.70332835014;6613.636250006103;6617;6620.90068648961;6627.768028118992;6650.634215118215;6667.099941507834;6716.731330746716;6740;6740.090087838079;6745;6498.3826536478955;6501.512386570931;6520.217573891164;6525.7063432146615;6556.573822701509;5728.742206600629;6521.7065232065615;6527.738890444329;6562.737490500326;6615.4376877965915;6461.935380646133;6495.545311828127;6533.8693226136165;6542.574732642363;6604.174478190226;6365.077063825626;6541.6075035498025;6584.440322572635;6677.599344039373;6685.064091027358;6347.492200624031;6353.936460635335;6421.7110230038825;6442.2269327679105;6451.838704032437 11:48:51 INFO - PID 3567 | |1;ext.html;847.9024912135106;886.8004698942739;904.5929331800692;906.5512571277222;1189.8929096381323;33475.66524334759;34036.1490962726;34054.48918266225;44361.556384436146;44888.10223795522;45117.774411127895;45449.54550454494;45549;45614.08771824562;45658;7388.74139405121;7815.218478152196;7921.920780792176;7933.206679332078;7966.800829979239;7833.686652533892;7921.7227397041115;7951.960240198791;7959;7965.641546130438;7971.920280797205;7972.441929064968;7976.680932762712;7981.760547183565;7982.720604778834;7876.72431464896;7968.800779980518;7974.122846486882;7981.201879812031;7984.441089123764;7813.570253636048;7844.49010814301;7871.645775940096;7881.408894332891;7881.8029549261155;41900;41908.580914190774;41960.580394195975;42191;42221.78889105566;3686.391745362012;3703.8518459261595;3711.6845068169237;3712.777233366007;3731.81340932955;32889.17777055569;32972.67027329744;33229.66770332314;33313.50029749556;33383;5085.593152547787;5104.515071068243;5167.767450464738;5168.328117344721;5183.870403239912;201039;201560;202577;202775;203535.98232008892;50115.49884501181;50285;50390;50414.495855041714;50492;52190.21714674283;53247.73376133094;53278;53428.465715343125;53537.46462535403;17018.234179461706;17358.91320543389;17386.739198912026;17481.300747970192;17509.7373539397;12053.819192712117;12260.44827982743;14099.436022559188;14270.072445291024;14408.495702650356;14075.577732668036;14098.365573549216;14124;14148.292585370691;14196.787048194285;5604.523615492647;5649.378568357477;5679.813271890352;5694.163482430459;5696.946064977992;996.8155891160013;1004.7638804880847;1010.4695035106628;1019.4851599941982;1022.7903279827617;23578;23718.407039824142;23813.52372952566;23877.044918203424;23883.641745373487;1117.9161562882653;1123.5393488669606;1125.0886781706843;1130.2032067392468;1132.8867113288604;12331.321777302155;12397.380130993415;12403.379831008413;12408.193467424588;12495.750084998432;235308;237085;237812;237908;238530;55766.16350754742;55788;55967.160492592644;55998.16002759962;56018.71990640102;1463.0636392708461;1463.8023866777849;1498.3631956418697;1500.6323450754635;1513.2660659580094;22696.205632802772;22827.77172228323;22889.771102288763;22949.655755163352;23287.18494852672;38989.61010389973;39046;39172.80413597914;39276.60723392844;39277.41083883801;204195;204237;204599;204631;206687;32451.18872028218;33229.33541329208;33258.501122482696;34676.65323346734;36557.634423656484;45967.540324596324;47552.762236188595;47926.28110578274;47930.520694792605;48150.518494814605;33766;33867.15332116717;34101.65898341084;34138.82930585331;34308.31383372368;33705;33782.83108584442;33959.151021224665;34107.14732131617;34380.82809585936;37151.44272835964;37189.62810371862;37276.813615931744;37368.252634946606;37455.625443745215;32520;32789.18027049343;32983.01050968475;33159.668403316624;33747.66252337445;25345;25618;25752;26255.73744262533;26583.60124598094 11:48:51 INFO - PID 3567 | |2;jquery.html;590.6957916672915;592.8103007037747;593.8129489210899;595.5354823237876;597.7728463183989;22278.66582001269;22880.08479660814;23001.309960701165;23058.88470557649;23132.190373336936;25283.620745688782;27251.591226131623;27402;27421.588676169824;27654;6496.74013039479;6651.301613330603;6652.06871038055;6664.4002039816405;6667.299933506984;6097.237845269341;6488.351164883497;6506.577072490297;6652.900206496906;6664.600123992552;6616.801495955129;6616.900746488783;6629.801105966829;6639.767608133692;6646.6676666166495;6622.668866556653;6638.17022872141;6641.767538136142;6642.103316052319;6644.036614690867;6164.445199932027;6175.907361389583;6176.413240742122;6184.536159787989;6191.628502289877;29764.8511757442;29904.55143172854;30584.8470757647;31415.214619634462;31562.526562101586;1936.94189174325;1983.841292696581;1985.2356842615698;1988.363723608446;1989.0253775649971;19311.51721206967;19668.606627867364;19675.80324196754;19793.40619781409;19806.50483737918;2331.9300420987397;2379.476515166678;2439.865807380593;2444.8655323957173;2448.155386391692;134026;139240.99999999898;139416;140340;140926.29536852354;14374.281285935662;14669.77995330071;14819.184944828137;15320.923395382952;15554.22228888551;23158.842057897375;23961.52076958451;24105;24109.879450602984;24145.517089658108;9485.051494850597;9503;9504.62384403899;9551.665691700757;9677.90322096784;8466.66133354659;8579.184977427134;8611.784705382415;8630.784230394165;8663.610137543825;9321.72034838956;9338.225737109928;9395.718128456158;9577.664781732607;9638.518074096268;2742.287005378616;2745.5881617757495;2765.4054378308356;2775.2229375774814;2823.8820884336747;940.4122423485321;960.0735290444754;965.1458459263603;966.8549717542425;977.9511024448749;19571.11929963155;19631.411057668294;19730.112144953513;19889.502762430766;20189;1037.1858091398217;1043.4417586591137;1050.5062620568322;1052.3159946034984;1059.560282482761;11106.555737770399;11119.833202501968;11231.26996745209;11303.660890173307;11324.433778311051;446733;478149;496109;504143;504395;115631;121820;121869.39065304617;122693.38653306855;125314.3734281341;1186.8160435132568;1212.5452955141823;1227.7789997800303;1236;1244.3715923458597;17696.469105926328;17742;17774.200160993045;17960.19179136968;18031.18859651345;54192.45807541874;54512.182317266066;54629;54825.45174548363;55636.443635563126;67893.660531699;68030.65984670045;68328.65835670989;68444;69120;14779.113253204841;14919.776203356741;15039;15151.848481515484;15213.6196595086;23511.17710880111;23531.41171470727;23685;23888.92499837477;23901.521969560858;18575.53561160982;18675.626487470447;18899.716504252174;18953.336633217772;19030.619387611892;16642.084685342423;17088;17273.481795546155;17343.479695609152;17388.391406300718;18966.52583685419;19143.947082910574;19303.131359089155;19492.02539873029;19495.317663881695;14724.705505889608;14751.483698070946;14875.702485950436;14880.107193568421;14950.700985980437;18085.547861303046;18427.26290948401;19307;19458.902705486384;19529.023548822217 11:48:51 INFO - PID 3567 | |3;mootools.html;1376.821013268275;1428.9854203515504;1429.1710807731513;1453.4113683957994;1458.547850166448;13430.328483575819;13954.790678139823;13957.30213489324;13988.160710357373;14186;13987;14279.643008924782;14300.71398572028;14301.928490357559;14305.499307524238;2297.069686776858;2342.7305859826083;2345.2846881701075;2351.1065794997876;2353.305774796431;2320.6751054852334;2348.3072493614427;2363.1728894886824;2402.4474370894704;2404.555157295897;2309.503456756797;2323.3030090972725;2324.8023917966993;2340.496793189464;2350.4828937633692;2300.470891694903;2315.9305220843403;2319.1998760427628;2320.9555699935013;2322.314917099443;2263.739669937962;2271.5456908618344;2274.692916456274;2275.328778010491;2286.817054635625;13265.071444998854;13548.796768048487;13555.186688798703;13594.864051359558;13597.796033059512;7176.102987126609;7414.073240844895;7440.03279573652;7487.850242995164;7493.925060749377;4620.8151673933;4718.103560323528;4876.439209490918;4887.291342755316;4895.534924182232;1854.1192933356683;1911.5603411215359;1920.5678722287514;1949.2495389275089;1970.7142464342733;21774.12903483859;21955;22021.779782202295;22050.33848984533;22096.88951555248;6137.478314343241;6224.813255602339;6241.407066328691;6264.878216055264;6347.650879201596;15008.324625391884;15019.924900375647;15026;15052.32264548098;15129.546113616609;7185.53294035886;7336.486445948839;7368.742094026683;7374.188839227681;7379.040724705754;5519.227308176858;5762.654240745569;6013.6993150342305;6091.604045737013;6879.965600171967;4699.882502937386;4807.759612019385;4918.3360246367;4923.729194894244;4941.752912354368;1363.8704323089291;1367.1045465220298;1376.3324787478066;1381.1298881704463;1399.9930000349932;797.6091715059695;813.3696385301321;817.3869597801648;839.7522730794431;844.9522591986016;7134.393576545948;7145;7190.7483238086415;7200.387967022862;7219;725.0791494801573;730.3718801830422;735.2941176470648;743.3941337809775;745.8620155271292;4415.911681766347;4435.807359792761;4495.910081798345;4510.639148868083;4543.091381723669;18590.721139182653;19006.80993190078;19151;19181.904090479456;19544.31594894172;17864.642707145784;18967.905160474384;18973.905130474537;19230.903845480683;19237.519062023282;10417.218708596885;10502.264841461025;10557.049865511986;10667.253292269621;10700.518476668569;7547.547147171187;7548.622568871644;7558.659860306189;7561.508501947355;7623;16033;16083.919580402024;16377.93543419674;16591.17044147812;16709.91645041767;17064.91467542704;17248.913755431142;17315.56711082233;17328.913355433142;17395.739063914305;10002.949690282416;10146.644867429604;10152.746181345525;10156.187504999434;10214.080732733792;12848.550300739429;12886.29125398112;12945.482180713043;12947.676308092374;13017.21896686202;10398.428086455318;10434.947825260826;10562.15502759762;10726.302790318605;10727.731806704895;10368.844467333147;10376.74058148522;10452;10573.682789516326;10801.945990269998;9136.908630913871;9359.017303183067;9364.859527106963;9372.531373431437;9391.483468409304;6912.412444942236;6995.335443132894;6995.370416662525;7057.36483716468;7063.646817658993;6878.828029299308;6895.620740859301;6931.098957135742;6954.061201737903;6984 11:48:51 INFO - PID 3567 | |4;prototype.html;485.42068998402584;498.5787009976569;501.919692849144;513.1507355326933;530;6107.206063211782;6221.844453888655;6223.688815559215;6269.843253918654;6276.968615156929;5949.762009519625;6055.848603784908;6087.299960504543;6105.481034112106;6106.5725399221965;4928.260760885878;4948.342305327719;4967.801287948496;4980.377452818398;4993.825216117437;4972.552470277675;4985.133548209776;4990.700557966516;5004.299398084271;5007.599392048627;4697.5772180503745;4877.26840973855;4952.232403977371;4974.776135073912;4989.328574927404;4941.407031156285;4948.391772673877;4952.529509696591;4955.702657840541;4965.577925876305;4394.4067550880545;4434.778261086965;4442.644588432918;4443.5556444355625;4504.842330518449;5969.060420122742;5996.280446346466;6014.8496287592725;6021.849453763647;6077.453029227347;5668.376478587352;5698.971505142489;5719.59962802604;5746.936816688926;5806.342004537157;6505.804825855184;6530.314316996694;6532.738690452376;6534.411902928759;6555.93444065558;4869.537393947569;4896.632752543538;4901.338319326881;4906.656534042619;4944.826931057396;6747.467076996864;6894.482913781386;6895.31136812127;6897.206821215575;6970.1635803703375;4954.133026720381;4991.301217829507;5001.499850015042;5017.9247311290355;5044.124848836128;5047.192449208109;5059.215821547666;5079.466656001141;5089.796408143633;5097.64316497849;5634.3802181759975;5661.66030038199;5703.800366987136;5728.484436400744;5732.570057245724;6482.805515834532;6493.350664933469;6500.447461965691;6521.184851893513;6590.934090659128;1662.717338052534;1691.7227493242524;1728.2568495547036;1771.7873855137466;1772.6100257943233;1225.136278923357;1233.8581063177849;1235.7404944961659;1247.4635906560266;1248.719038216394;5708.65748055118;5722.656640601577;5723.227364305849;5757.568182386254;5785.681787501728;6549.672516374162;6634.13756211699;6638.535302528873;6663.167104111986;6681.365270299411;5757.65454072757;5774.94225057744;5781.456159289899;5816.539159200269;5881.147233651182;3558.6975107116186;3572;3639.8544058237903;3643.4534819776713;3649.288388764219;6532.41208291256;6542.672866356758;6542.901856472156;6573.1783527059115;6582.736690532421;6669.233038200669;6849.48628852838;6865.450763938873;6887.173539175331;6891.4486841053595;6388.968055159695;6515.0553169791065;6558.8360290993105;6559;6600.60396376219;6701.899471507833;6718.428933540704;6749;6752.864942701217;6761.763338283136;6621.6689165540565;6676.365745254193;6728;6761.459083273425;6784.626845523346;6410.61536307823;6558.8360290993105;6565.671716414256;6574.934250657432;6608.867822643617;4960.280759289955;4962.181240095344;4991.3511243538105;4991.850244492671;4993.575546078624;6655;6657.538080198173;6773.729050838108;6825.624590647562;6827.21487028998;6408.327125651739;6457.4511166551365;6517.706703198272;6547.1161393211305;6554.770583029762;6284.506577796898;6463;6469;6472.579282346633;6560.147180866456;6041.909371359346;6187.474064704551;6372.808815735535;6387.552871298964;6449.806505804833;6396.552241343062;6423.710933007932;6519.989401642753;6541.215054193527;6585.440237579859;6288.245410550763;6305.549723563698;6323.620582765049;6363.5863668861375;6364.554481186457 11:48:51 INFO - PID 3567 | |5;yui.html;882.6822343956176;883.2933653077537;899.9145081217287;903.6069309850216;913.182701482173;18058.90970545147;19076.90461547694;19147.138378772954;19162.904185479052;19220.519487012814;20247.39257822264;22102.115915363407;22171.22400715975;22240.88879555604;22400;1039.9896001039988;1062.9627963021296;1063.5161001744189;1063.8882917293688;1064.297563608019;1010.7321559786662;1017.3183966742264;1031.742064483879;1061.9893801062005;1064.8083344997897;1099.8955099265556;1100.8018556659797;1102.3441052573705;1102.3551222534827;1105.011015141452;1097.0346095436005;1097.369012817629;1102.9503672334724;1103.0734183286079;1103.17813229144;796.7530065679658;800.0799081056773;800.8398320335956;804.3725893802844;807.019471342316;17268.30926762928;17678.91160544202;17688.469345919642;17713.29146834125;20018.399448016582;21558.568828623498;21933.232336868292;22502.21242256513;22545.661815072788;22815.08739650412;16389.344426222935;16442.917785410995;16642.50072497815;16647.750283745754;16673.49979500617;3548.361294966905;3549.4498352755363;3576.517170182018;3577.5528058992627;3596.8381422836037;128883;129829.35085324512;130551;134834.32582837218;135163;17013.744793828104;17083.658326833392;17096.91451542759;17454.563635909202;17459.127043647768;32029.359412811613;32550.837245814095;32684.509732354032;32947.3410531788;33427;8523.318134549221;9074.092590740873;9168.81662366749;9179.908200917906;9193.908060919306;4079.428879956749;4191.790410479463;4192.140611174702;4192.203481338597;4200.369944508348;4763.261694437368;4927.457979622239;4938.950610493921;5462.535684466785;5624.072028115397;1017.9134773544183;1045.534737042009;1062.628080171949;1066.1470823341451;1068.4764465411893;615.3354377272535;630.2814791138106;631.1132858334048;637.9011253255753;652.1228947066188;11466.827997580043;12088.274703517816;12311.076669249842;12380.566680166152;12639.684007899876;613.9447449729546;625.9624422534663;636.1570918532963;637.9521535884735;638.7955854126727;5714.514266287412;5745.1669507921115;5796.594238403271;5885.293764748258;5907.379725128885;104926.4753676242;108599;108777;109574;111304.44347778209;93385.5330723342;94983;94986;96992.51503742437;99417.50291248497;79845.60077199693;80977.59511202406;81612.59193704113;83065;83960.16039839646;11106.000919834507;11473.541058357907;11505.539778409106;11620.593279235187;11837.289762614271;37744.433833493065;38005;39191.804040979616;39462.21075578415;40071.39892901551;47378;48656.2701559484;49317;49644.25533616926;50255;16390.262438190548;16455.506334809976;16487.83512164863;16689.91655041717;16984.660306793547;18133.90933045326;18357.265709371477;18364.81635183631;18588.907055464635;18591.628167436305;15675.608109797346;15892.761608576111;15931.920340398225;16044.598885027968;16179.43371981975;16707.66584668324;19301.03494825281;19971.400857974284;20445.182192712124;20482.692759608915;16565.585860353105;17057;17110;17113.229904654072;17130.571735706708;13369.66575835612;13542.932285338511;13711.657208569466;13791.793123102962;13914.86085139176;14884.62788430298;14894.882289152221;15039.699206015599;15264.465743699362;15359 11:48:51 INFO - PID 3567 | __end_tp_report 11:48:51 INFO - PID 3567 | __start_cc_report 11:48:51 INFO - PID 3567 | _x_x_mozilla_cycle_collect,378 11:48:51 INFO - PID 3567 | __end_cc_report 11:48:51 INFO - PID 3567 | __startTimestamp1501872531500__endTimestamp 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | ------- Summary: start ------- 11:48:51 INFO - PID 3567 | Number of tests: 6 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#0] dojo.html Cycles:165 Average:6173.76 Median:6451.84 stddev:773.52 (12.0%) stddev-sans-first:736.12 11:48:51 INFO - PID 3567 | Values: 3052.8 3157.8 3176.5 3195.6 3208.7 6044.7 6096.0 6113.8 6141.8 6144.6 6189.3 6321.6 6356.2 6381.1 6388.7 5716.0 5718.3 5774.7 5815.7 5864.7 5539.8 5700.2 5701.7 5796.4 5905.7 5646.6 5679.2 5685.5 5713.2 5825.7 5730.7 5795.8 5805.7 5809.4 5827.9 5661.1 5688.9 5710.8 5775.4 5783.6 6078.3 6172.1 6179.0 6189.8 6324.6 6637.3 6682.7 6704.1 6785.8 6794.3 6715.2 6843.1 6849.6 6858.1 6873.7 6228.7 6241.7 6321.9 6356.1 6373.7 6748.3 6896.0 6898.7 6902.3 6994.8 6649.2 6651.3 6652.5 6655.4 6657.7 6721.7 6747.9 6826.4 6840.1 6842.5 6674.5 6718.1 6762.3 6793.0 6813.1 6482.7 6625.4 6704.1 6720.0 6814.6 4977.8 4993.9 4995.6 4999.2 4999.3 4358.3 4400.5 4404.7 4419.8 4445.4 5830.7 5887.1 5909.6 5914.3 5923.3 6766.7 6779.5 6866.2 6871.1 6885.6 5713.4 5795.0 5832.2 5837.6 5901.9 5977.1 5984.1 5997.6 6004.8 6008.2 6456.5 6590.1 6604.0 6613.5 6613.9 6779.5 6789.8 6869.6 6879.7 6898.2 6365.6 6484.9 6494.6 6505.4 6592.7 6613.6 6617.0 6620.9 6627.8 6650.6 6667.1 6716.7 6740.0 6740.1 6745.0 6498.4 6501.5 6520.2 6525.7 6556.6 5728.7 6521.7 6527.7 6562.7 6615.4 6461.9 6495.5 6533.9 6542.6 6604.2 6365.1 6541.6 6584.4 6677.6 6685.1 6347.5 6353.9 6421.7 6442.2 6451.8 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#1] ext.html Cycles:180 Average:39174.75 Median:34528.74 stddev:55836.39 (161.7%) stddev-sans-first:55918.86 11:48:51 INFO - PID 3567 | Values: 847.9 886.8 904.6 906.6 1189.9 33475.7 34036.1 34054.5 44361.6 44888.1 45117.8 45449.5 45549.0 45614.1 45658.0 7388.7 7815.2 7921.9 7933.2 7966.8 7833.7 7921.7 7952.0 7959.0 7965.6 7971.9 7972.4 7976.7 7981.8 7982.7 7876.7 7968.8 7974.1 7981.2 7984.4 7813.6 7844.5 7871.6 7881.4 7881.8 41900.0 41908.6 41960.6 42191.0 42221.8 3686.4 3703.9 3711.7 3712.8 3731.8 32889.2 32972.7 33229.7 33313.5 33383.0 5085.6 5104.5 5167.8 5168.3 5183.9 201039.0 201560.0 202577.0 202775.0 203536.0 50115.5 50285.0 50390.0 50414.5 50492.0 52190.2 53247.7 53278.0 53428.5 53537.5 17018.2 17358.9 17386.7 17481.3 17509.7 12053.8 12260.4 14099.4 14270.1 14408.5 14075.6 14098.4 14124.0 14148.3 14196.8 5604.5 5649.4 5679.8 5694.2 5696.9 996.8 1004.8 1010.5 1019.5 1022.8 23578.0 23718.4 23813.5 23877.0 23883.6 1117.9 1123.5 1125.1 1130.2 1132.9 12331.3 12397.4 12403.4 12408.2 12495.8 235308.0 237085.0 237812.0 237908.0 238530.0 55766.2 55788.0 55967.2 55998.2 56018.7 1463.1 1463.8 1498.4 1500.6 1513.3 22696.2 22827.8 22889.8 22949.7 23287.2 38989.6 39046.0 39172.8 39276.6 39277.4 204195.0 204237.0 204599.0 204631.0 206687.0 32451.2 33229.3 33258.5 34676.7 36557.6 45967.5 47552.8 47926.3 47930.5 48150.5 33766.0 33867.2 34101.7 34138.8 34308.3 33705.0 33782.8 33959.2 34107.1 34380.8 37151.4 37189.6 37276.8 37368.3 37455.6 32520.0 32789.2 32983.0 33159.7 33747.7 25345.0 25618.0 25752.0 26255.7 26583.6 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#2] jquery.html Cycles:180 Average:34890.58 Median:13134.20 stddev:82140.59 (625.4%) stddev-sans-first:82330.65 11:48:51 INFO - PID 3567 | Values: 590.7 592.8 593.8 595.5 597.8 22278.7 22880.1 23001.3 23058.9 23132.2 25283.6 27251.6 27402.0 27421.6 27654.0 6496.7 6651.3 6652.1 6664.4 6667.3 6097.2 6488.4 6506.6 6652.9 6664.6 6616.8 6616.9 6629.8 6639.8 6646.7 6622.7 6638.2 6641.8 6642.1 6644.0 6164.4 6175.9 6176.4 6184.5 6191.6 29764.9 29904.6 30584.8 31415.2 31562.5 1936.9 1983.8 1985.2 1988.4 1989.0 19311.5 19668.6 19675.8 19793.4 19806.5 2331.9 2379.5 2439.9 2444.9 2448.2 134026.0 139241.0 139416.0 140340.0 140926.3 14374.3 14669.8 14819.2 15320.9 15554.2 23158.8 23961.5 24105.0 24109.9 24145.5 9485.1 9503.0 9504.6 9551.7 9677.9 8466.7 8579.2 8611.8 8630.8 8663.6 9321.7 9338.2 9395.7 9577.7 9638.5 2742.3 2745.6 2765.4 2775.2 2823.9 940.4 960.1 965.1 966.9 978.0 19571.1 19631.4 19730.1 19889.5 20189.0 1037.2 1043.4 1050.5 1052.3 1059.6 11106.6 11119.8 11231.3 11303.7 11324.4 446733.0 478149.0 496109.0 504143.0 504395.0 115631.0 121820.0 121869.4 122693.4 125314.4 1186.8 1212.5 1227.8 1236.0 1244.4 17696.5 17742.0 17774.2 17960.2 18031.2 54192.5 54512.2 54629.0 54825.5 55636.4 67893.7 68030.7 68328.7 68444.0 69120.0 14779.1 14919.8 15039.0 15151.8 15213.6 23511.2 23531.4 23685.0 23888.9 23901.5 18575.5 18675.6 18899.7 18953.3 19030.6 16642.1 17088.0 17273.5 17343.5 17388.4 18966.5 19143.9 19303.1 19492.0 19495.3 14724.7 14751.5 14875.7 14880.1 14950.7 18085.5 18427.3 19307.0 19458.9 19529.0 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#3] mootools.html Cycles:180 Average:8390.48 Median:2298.77 stddev:5847.12 (254.4%) stddev-sans-first:5839.78 11:48:51 INFO - PID 3567 | Values: 1376.8 1429.0 1429.2 1453.4 1458.5 13430.3 13954.8 13957.3 13988.2 14186.0 13987.0 14279.6 14300.7 14301.9 14305.5 2297.1 2342.7 2345.3 2351.1 2353.3 2320.7 2348.3 2363.2 2402.4 2404.6 2309.5 2323.3 2324.8 2340.5 2350.5 2300.5 2315.9 2319.2 2321.0 2322.3 2263.7 2271.5 2274.7 2275.3 2286.8 13265.1 13548.8 13555.2 13594.9 13597.8 7176.1 7414.1 7440.0 7487.9 7493.9 4620.8 4718.1 4876.4 4887.3 4895.5 1854.1 1911.6 1920.6 1949.2 1970.7 21774.1 21955.0 22021.8 22050.3 22096.9 6137.5 6224.8 6241.4 6264.9 6347.7 15008.3 15019.9 15026.0 15052.3 15129.5 7185.5 7336.5 7368.7 7374.2 7379.0 5519.2 5762.7 6013.7 6091.6 6880.0 4699.9 4807.8 4918.3 4923.7 4941.8 1363.9 1367.1 1376.3 1381.1 1400.0 797.6 813.4 817.4 839.8 845.0 7134.4 7145.0 7190.7 7200.4 7219.0 725.1 730.4 735.3 743.4 745.9 4415.9 4435.8 4495.9 4510.6 4543.1 18590.7 19006.8 19151.0 19181.9 19544.3 17864.6 18967.9 18973.9 19230.9 19237.5 10417.2 10502.3 10557.0 10667.3 10700.5 7547.5 7548.6 7558.7 7561.5 7623.0 16033.0 16083.9 16377.9 16591.2 16709.9 17064.9 17248.9 17315.6 17328.9 17395.7 10002.9 10146.6 10152.7 10156.2 10214.1 12848.6 12886.3 12945.5 12947.7 13017.2 10398.4 10434.9 10562.2 10726.3 10727.7 10368.8 10376.7 10452.0 10573.7 10801.9 9136.9 9359.0 9364.9 9372.5 9391.5 6912.4 6995.3 6995.4 7057.4 7063.6 6878.8 6895.6 6931.1 6954.1 6984.0 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#4] prototype.html Cycles:180 Average:5495.22 Median:6048.88 stddev:1539.16 (25.4%) stddev-sans-first:1496.84 11:48:51 INFO - PID 3567 | Values: 485.4 498.6 501.9 513.2 530.0 6107.2 6221.8 6223.7 6269.8 6277.0 5949.8 6055.8 6087.3 6105.5 6106.6 4928.3 4948.3 4967.8 4980.4 4993.8 4972.6 4985.1 4990.7 5004.3 5007.6 4697.6 4877.3 4952.2 4974.8 4989.3 4941.4 4948.4 4952.5 4955.7 4965.6 4394.4 4434.8 4442.6 4443.6 4504.8 5969.1 5996.3 6014.8 6021.8 6077.5 5668.4 5699.0 5719.6 5746.9 5806.3 6505.8 6530.3 6532.7 6534.4 6555.9 4869.5 4896.6 4901.3 4906.7 4944.8 6747.5 6894.5 6895.3 6897.2 6970.2 4954.1 4991.3 5001.5 5017.9 5044.1 5047.2 5059.2 5079.5 5089.8 5097.6 5634.4 5661.7 5703.8 5728.5 5732.6 6482.8 6493.4 6500.4 6521.2 6590.9 1662.7 1691.7 1728.3 1771.8 1772.6 1225.1 1233.9 1235.7 1247.5 1248.7 5708.7 5722.7 5723.2 5757.6 5785.7 6549.7 6634.1 6638.5 6663.2 6681.4 5757.7 5774.9 5781.5 5816.5 5881.1 3558.7 3572.0 3639.9 3643.5 3649.3 6532.4 6542.7 6542.9 6573.2 6582.7 6669.2 6849.5 6865.5 6887.2 6891.4 6389.0 6515.1 6558.8 6559.0 6600.6 6701.9 6718.4 6749.0 6752.9 6761.8 6621.7 6676.4 6728.0 6761.5 6784.6 6410.6 6558.8 6565.7 6574.9 6608.9 4960.3 4962.2 4991.4 4991.9 4993.6 6655.0 6657.5 6773.7 6825.6 6827.2 6408.3 6457.5 6517.7 6547.1 6554.8 6284.5 6463.0 6469.0 6472.6 6560.1 6041.9 6187.5 6372.8 6387.6 6449.8 6396.6 6423.7 6520.0 6541.2 6585.4 6288.2 6305.5 6323.6 6363.6 6364.6 11:48:51 INFO - PID 3567 | 11:48:51 INFO - PID 3567 | [#5] yui.html Cycles:180 Average:23047.33 Median:18834.27 stddev:31546.95 (167.5%) stddev-sans-first:31591.55 11:48:51 INFO - PID 3567 | Values: 882.7 883.3 899.9 903.6 913.2 18058.9 19076.9 19147.1 19162.9 19220.5 20247.4 22102.1 22171.2 22240.9 22400.0 1040.0 1063.0 1063.5 1063.9 1064.3 1010.7 1017.3 1031.7 1062.0 1064.8 1099.9 1100.8 1102.3 1102.4 1105.0 1097.0 1097.4 1103.0 1103.1 1103.2 796.8 800.1 800.8 804.4 807.0 17268.3 17678.9 17688.5 17713.3 20018.4 21558.6 21933.2 22502.2 22545.7 22815.1 16389.3 16442.9 16642.5 16647.8 16673.5 3548.4 3549.4 3576.5 3577.6 3596.8 128883.0 129829.4 130551.0 134834.3 135163.0 17013.7 17083.7 17096.9 17454.6 17459.1 32029.4 32550.8 32684.5 32947.3 33427.0 8523.3 9074.1 9168.8 9179.9 9193.9 4079.4 4191.8 4192.1 4192.2 4200.4 4763.3 4927.5 4939.0 5462.5 5624.1 1017.9 1045.5 1062.6 1066.1 1068.5 615.3 630.3 631.1 637.9 652.1 11466.8 12088.3 12311.1 12380.6 12639.7 613.9 626.0 636.2 638.0 638.8 5714.5 5745.2 5796.6 5885.3 5907.4 104926.5 108599.0 108777.0 109574.0 111304.4 93385.5 94983.0 94986.0 96992.5 99417.5 79845.6 80977.6 81612.6 83065.0 83960.2 11106.0 11473.5 11505.5 11620.6 11837.3 37744.4 38005.0 39191.8 39462.2 40071.4 47378.0 48656.3 49317.0 49644.3 50255.0 16390.3 16455.5 16487.8 16689.9 16984.7 18133.9 18357.3 18364.8 18588.9 18591.6 15675.6 15892.8 15931.9 16044.6 16179.4 16707.7 19301.0 19971.4 20445.2 20482.7 16565.6 17057.0 17110.0 17113.2 17130.6 13369.7 13542.9 13711.7 13791.8 13914.9 14884.6 14894.9 15039.7 15264.5 15359.0 11:48:51 INFO - PID 3567 | -------- Summary: end -------- 11:48:51 INFO - PID 3567 | 11:48:52 INFO - TEST-INFO | 3567: exit 0 11:48:52 INFO - TEST-OK | dromaeo_css | took 1115003ms 11:48:52 INFO - TEST-START | kraken 11:48:52 INFO - Initialising browser for kraken test... 11:48:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34742/getInfo.html -profile /tmp/tmpIsJlpz/profile 11:48:52 INFO - TEST-INFO | started process 3934 (/builds/slave/test/build/application/firefox/firefox http://localhost:34742/getInfo.html) 11:48:57 INFO - TEST-INFO | 3934: exit 0 11:48:57 INFO - Browser initialized. 11:48:57 INFO - Running cycle 1/1 for kraken test... 11:48:57 INFO - TEST-INFO | started process 4160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIsJlpz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:48:58 INFO - PID 4160 | 11:48:58 INFO - PID 4160 | (/builds/slave/test/build/application/firefox/firefox:4214): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:48:58 INFO - PID 4160 | 11:49:09 INFO - PID 4160 | RSS: Main: 174080000 11:49:09 INFO - PID 4160 | 11:49:11 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34742/tests/kraken/driver.html?testName=audio-beat-detection) 11:49:12 INFO - PID 4160 | RSS: Main: 179367936 11:49:12 INFO - PID 4160 | 11:49:15 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34742/tests/kraken/driver.html?testName=audio-dft) 11:49:16 INFO - PID 4160 | RSS: Main: 179179520 11:49:16 INFO - PID 4160 | 11:49:19 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34742/tests/kraken/driver.html?testName=audio-fft) 11:49:19 INFO - PID 4160 | RSS: Main: 174075904 11:49:19 INFO - PID 4160 | 11:49:22 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34742/tests/kraken/driver.html?testName=audio-oscillator) 11:49:22 INFO - PID 4160 | RSS: Main: 174915584 11:49:22 INFO - PID 4160 | 11:49:24 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:49:25 INFO - PID 4160 | RSS: Main: 175099904 11:49:25 INFO - PID 4160 | 11:49:28 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34742/tests/kraken/driver.html?testName=imaging-darkroom) 11:49:29 INFO - PID 4160 | RSS: Main: 177475584 11:49:29 INFO - PID 4160 | 11:49:32 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34742/tests/kraken/driver.html?testName=imaging-desaturate) 11:49:33 INFO - PID 4160 | RSS: Main: 176762880 11:49:33 INFO - PID 4160 | 11:49:36 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34742/tests/kraken/driver.html?testName=json-parse-financial) 11:49:37 INFO - PID 4160 | RSS: Main: 177733632 11:49:37 INFO - PID 4160 | 11:49:38 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:49:39 INFO - PID 4160 | RSS: Main: 177692672 11:49:39 INFO - PID 4160 | 11:49:41 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:49:41 INFO - PID 4160 | RSS: Main: 175034368 11:49:41 INFO - PID 4160 | 11:49:44 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:49:44 INFO - PID 4160 | RSS: Main: 174944256 11:49:44 INFO - PID 4160 | 11:49:47 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:49:48 INFO - PID 4160 | RSS: Main: 175599616 11:49:48 INFO - PID 4160 | 11:49:51 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:49:52 INFO - PID 4160 | RSS: Main: 175554560 11:49:52 INFO - PID 4160 | 11:49:53 INFO - PID 4160 | Cycle 1(1): loaded http://localhost:34742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34742/tests/kraken/driver.html?testName=ai-astar) 11:49:54 INFO - PID 4160 | RSS: Main: 176779264 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | __start_tp_report 11:49:54 INFO - PID 4160 | _x_x_mozilla_page_load 11:49:54 INFO - PID 4160 | _x_x_mozilla_page_load_details 11:49:54 INFO - PID 4160 | |i|pagename|runs| 11:49:54 INFO - PID 4160 | |0;ai-astar;99;115;106;107;108;109;111;99;109;108 11:49:54 INFO - PID 4160 | |1;audio-beat-detection;157;129;153;175;124;141;150;121;188;124 11:49:54 INFO - PID 4160 | |2;audio-dft;168;163;162;163;164;164;168;169;164;168 11:49:54 INFO - PID 4160 | |3;audio-fft;74;86;77;163;81;74;75;81;162;75 11:49:54 INFO - PID 4160 | |4;audio-oscillator;77;84;145;83;79;79;125;86;78;131 11:49:54 INFO - PID 4160 | |5;imaging-gaussian-blur;114;121;120;114;119;120;113;117;118;115 11:49:54 INFO - PID 4160 | |6;imaging-darkroom;152;152;151;152;152;152;152;154;151;153 11:49:54 INFO - PID 4160 | |7;imaging-desaturate;99;94;96;94;99;96;96;94;94;94 11:49:54 INFO - PID 4160 | |8;json-parse-financial;59;54;63;54;56;54;54;64;55;54 11:49:54 INFO - PID 4160 | |9;json-stringify-tinderbox;58;54;54;54;55;54;55;54;54;56 11:49:54 INFO - PID 4160 | |10;stanford-crypto-aes;77;95;88;88;79;80;80;88;83;79 11:49:54 INFO - PID 4160 | |11;stanford-crypto-ccm;131;140;129;130;129;136;128;127;124;180 11:49:54 INFO - PID 4160 | |12;stanford-crypto-pbkdf2;179;172;180;175;180;189;172;192;172;176 11:49:54 INFO - PID 4160 | |13;stanford-crypto-sha256-iterative;68;73;68;67;68;68;68;66;65;66 11:49:54 INFO - PID 4160 | __end_tp_report 11:49:54 INFO - PID 4160 | __start_cc_report 11:49:54 INFO - PID 4160 | _x_x_mozilla_cycle_collect,986 11:49:54 INFO - PID 4160 | __end_cc_report 11:49:54 INFO - PID 4160 | __startTimestamp1501872594201__endTimestamp 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | ------- Summary: start ------- 11:49:54 INFO - PID 4160 | Number of tests: 14 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#0] ai-astar Cycles:10 Average:107.10 Median:110.00 stddev:4.93 (4.5%) stddev-sans-first:4.27 11:49:54 INFO - PID 4160 | Values: 99.0 115.0 106.0 107.0 108.0 109.0 111.0 99.0 109.0 108.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:22.85 (15.1%) stddev-sans-first:23.90 11:49:54 INFO - PID 4160 | Values: 157.0 129.0 153.0 175.0 124.0 141.0 150.0 121.0 188.0 124.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#2] audio-dft Cycles:10 Average:165.30 Median:166.00 stddev:2.63 (1.6%) stddev-sans-first:2.60 11:49:54 INFO - PID 4160 | Values: 168.0 163.0 162.0 163.0 164.0 164.0 168.0 169.0 164.0 168.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:35.89 (47.2%) stddev-sans-first:37.27 11:49:54 INFO - PID 4160 | Values: 74.0 86.0 77.0 163.0 81.0 74.0 75.0 81.0 162.0 75.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:79.00 stddev:26.12 (33.1%) stddev-sans-first:26.71 11:49:54 INFO - PID 4160 | Values: 77.0 84.0 145.0 83.0 79.0 79.0 125.0 86.0 78.0 131.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:118.50 stddev:2.92 (2.5%) stddev-sans-first:2.88 11:49:54 INFO - PID 4160 | Values: 114.0 121.0 120.0 114.0 119.0 120.0 113.0 117.0 118.0 115.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 11:49:54 INFO - PID 4160 | Values: 152.0 152.0 151.0 152.0 152.0 152.0 152.0 154.0 151.0 153.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:2.01 (2.1%) stddev-sans-first:1.72 11:49:54 INFO - PID 4160 | Values: 99.0 94.0 96.0 94.0 99.0 96.0 96.0 94.0 94.0 94.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.50 stddev:3.92 (7.1%) stddev-sans-first:4.07 11:49:54 INFO - PID 4160 | Values: 59.0 54.0 63.0 54.0 56.0 54.0 54.0 64.0 55.0 54.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.50 stddev:1.32 (2.4%) stddev-sans-first:0.73 11:49:54 INFO - PID 4160 | Values: 58.0 54.0 54.0 54.0 55.0 54.0 55.0 54.0 54.0 56.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:85.50 stddev:5.77 (6.8%) stddev-sans-first:5.59 11:49:54 INFO - PID 4160 | Values: 77.0 95.0 88.0 88.0 79.0 80.0 80.0 88.0 83.0 79.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:130.50 stddev:16.32 (12.5%) stddev-sans-first:17.23 11:49:54 INFO - PID 4160 | Values: 131.0 140.0 129.0 130.0 129.0 136.0 128.0 127.0 124.0 180.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.50 stddev:7.01 (3.9%) stddev-sans-first:7.43 11:49:54 INFO - PID 4160 | Values: 179.0 172.0 180.0 175.0 180.0 189.0 172.0 192.0 172.0 176.0 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:2.16 (3.2%) stddev-sans-first:2.29 11:49:54 INFO - PID 4160 | Values: 68.0 73.0 68.0 67.0 68.0 68.0 68.0 66.0 65.0 66.0 11:49:54 INFO - PID 4160 | -------- Summary: end -------- 11:49:54 INFO - PID 4160 | 11:49:54 INFO - PID 4160 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:49:54 INFO - TEST-INFO | 4160: exit 0 11:49:54 INFO - TEST-OK | kraken | took 62679ms 11:49:54 INFO - SUITE-END | took 1177s 11:49:55 INFO - Completed test suite (00:19:38) 11:49:55 INFO - javascript benchmark 11:49:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8431.873419851565, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.7557795376374, 3157.810531368118, 3176.507641315597, 3195.568598239237, 3208.7272581830534, 6044.697765111743, 6095.9999999999945, 6113.816585502431, 6141.754329826807, 6144.631322120676, 6189.288231853338, 6321.589096708711, 6356.237251529811, 6381.074744162105, 6388.712507937143, 5716.028275193206, 5718.331064945678, 5774.6535207887455, 5815.651060936336, 5864.677442740647, 5539.833804985837, 5700.230468886689, 5701.71491425427, 5796.449337312949, 5905.734241959122, 5646.604737668365, 5679.176519404705, 5685.516731077863, 5713.228714123582, 5825.650460972355, 5730.7421166047625, 5795.82612521625, 5805.680687562224, 5809.448102430262, 5827.883442331172, 5661.122526008434, 5688.943110568925, 5710.828675139753, 5775.422457754233, 5783.566232532535, 6078.270607527125, 6172.07418887166, 6179.0, 6189.845253868644, 6324.557280990332, 6637.336266373372, 6682.732690692366, 6704.061431399608, 6785.762498312535, 6794.320567943216, 6715.194176698778, 6843.076184715099, 6849.589024658537, 6858.108445902001, 6873.690683919235, 6228.719707613213, 6241.65670888101, 6321.936780632181, 6356.078368636522, 6373.71318290678, 6748.257691653914, 6896.034555162181, 6898.666561152229, 6902.309769023058, 6994.825129371705, 6649.202095748445, 6651.268360480343, 6652.467802575782, 6655.401013908675, 6657.667116644148, 6721.7311307548125, 6747.932520674829, 6826.419754320839, 6840.110785597841, 6842.521023528405, 6674.5327827052615, 6718.093057437183, 6762.323767623297, 6792.966035169792, 6813.1142951415995, 6482.708278127496, 6625.403713665697, 6704.094947182166, 6719.966400168066, 6814.557053791487, 4977.751112444435, 4993.925091123636, 4995.625328100407, 4999.150144475448, 4999.325091112653, 4358.346248062752, 4400.515943246241, 4404.66964977628, 4419.845305414295, 4445.444319460067, 5830.650160990354, 5887.1463637772285, 5909.615874968199, 5914.349421563625, 5923.289205295306, 6766.72933082681, 6779.49153813466, 6866.176058872968, 6871.106756121672, 6885.586864788129, 5713.400092990176, 5795.043817770105, 5832.24180856486, 5837.6497410155525, 5901.881962360729, 5977.103434484862, 5984.1323008164445, 5997.580169388101, 6004.789832355847, 6008.21893153896, 6456.451201647818, 6590.143281373486, 6604.042413849965, 6613.503987200883, 6613.867722645617, 6779.491538134758, 6789.830254243683, 6869.553479023847, 6879.724811007503, 6898.206706228848, 6365.586236894587, 6484.902726459201, 6494.6103233806125, 6505.447037001908, 6592.70332835014, 6613.636250006103, 6617.0, 6620.90068648961, 6627.768028118992, 6650.634215118215, 6667.099941507834, 6716.731330746716, 6740.0, 6740.090087838079, 6745.0, 6498.3826536478955, 6501.512386570931, 6520.217573891164, 6525.7063432146615, 6556.573822701509, 5728.742206600629, 6521.7065232065615, 6527.738890444329, 6562.737490500326, 6615.4376877965915, 6461.935380646133, 6495.545311828127, 6533.8693226136165, 6542.574732642363, 6604.174478190226, 6365.077063825626, 6541.6075035498025, 6584.440322572635, 6677.599344039373, 6685.064091027358, 6347.492200624031, 6353.936460635335, 6421.7110230038825, 6442.2269327679105, 6451.838704032437], "value": 6112.88306856394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.9024912135106, 886.8004698942739, 904.5929331800692, 906.5512571277222, 1189.8929096381323, 33475.66524334759, 34036.1490962726, 34054.48918266225, 44361.556384436146, 44888.10223795522, 45117.774411127895, 45449.54550454494, 45549.0, 45614.08771824562, 45658.0, 7388.74139405121, 7815.218478152196, 7921.920780792176, 7933.206679332078, 7966.800829979239, 7833.686652533892, 7921.7227397041115, 7951.960240198791, 7959.0, 7965.641546130438, 7971.920280797205, 7972.441929064968, 7976.680932762712, 7981.760547183565, 7982.720604778834, 7876.72431464896, 7968.800779980518, 7974.122846486882, 7981.201879812031, 7984.441089123764, 7813.570253636048, 7844.49010814301, 7871.645775940096, 7881.408894332891, 7881.8029549261155, 41900.0, 41908.580914190774, 41960.580394195975, 42191.0, 42221.78889105566, 3686.391745362012, 3703.8518459261595, 3711.6845068169237, 3712.777233366007, 3731.81340932955, 32889.17777055569, 32972.67027329744, 33229.66770332314, 33313.50029749556, 33383.0, 5085.593152547787, 5104.515071068243, 5167.767450464738, 5168.328117344721, 5183.870403239912, 201039.0, 201560.0, 202577.0, 202775.0, 203535.98232008892, 50115.49884501181, 50285.0, 50390.0, 50414.495855041714, 50492.0, 52190.21714674283, 53247.73376133094, 53278.0, 53428.465715343125, 53537.46462535403, 17018.234179461706, 17358.91320543389, 17386.739198912026, 17481.300747970192, 17509.7373539397, 12053.819192712117, 12260.44827982743, 14099.436022559188, 14270.072445291024, 14408.495702650356, 14075.577732668036, 14098.365573549216, 14124.0, 14148.292585370691, 14196.787048194285, 5604.523615492647, 5649.378568357477, 5679.813271890352, 5694.163482430459, 5696.946064977992, 996.8155891160013, 1004.7638804880847, 1010.4695035106628, 1019.4851599941982, 1022.7903279827617, 23578.0, 23718.407039824142, 23813.52372952566, 23877.044918203424, 23883.641745373487, 1117.9161562882653, 1123.5393488669606, 1125.0886781706843, 1130.2032067392468, 1132.8867113288604, 12331.321777302155, 12397.380130993415, 12403.379831008413, 12408.193467424588, 12495.750084998432, 235308.0, 237085.0, 237812.0, 237908.0, 238530.0, 55766.16350754742, 55788.0, 55967.160492592644, 55998.16002759962, 56018.71990640102, 1463.0636392708461, 1463.8023866777849, 1498.3631956418697, 1500.6323450754635, 1513.2660659580094, 22696.205632802772, 22827.77172228323, 22889.771102288763, 22949.655755163352, 23287.18494852672, 38989.61010389973, 39046.0, 39172.80413597914, 39276.60723392844, 39277.41083883801, 204195.0, 204237.0, 204599.0, 204631.0, 206687.0, 32451.18872028218, 33229.33541329208, 33258.501122482696, 34676.65323346734, 36557.634423656484, 45967.540324596324, 47552.762236188595, 47926.28110578274, 47930.520694792605, 48150.518494814605, 33766.0, 33867.15332116717, 34101.65898341084, 34138.82930585331, 34308.31383372368, 33705.0, 33782.83108584442, 33959.151021224665, 34107.14732131617, 34380.82809585936, 37151.44272835964, 37189.62810371862, 37276.813615931744, 37368.252634946606, 37455.625443745215, 32520.0, 32789.18027049343, 32983.01050968475, 33159.668403316624, 33747.66252337445, 25345.0, 25618.0, 25752.0, 26255.73744262533, 26583.60124598094], "value": 17779.49352504974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6957916672915, 592.8103007037747, 593.8129489210899, 595.5354823237876, 597.7728463183989, 22278.66582001269, 22880.08479660814, 23001.309960701165, 23058.88470557649, 23132.190373336936, 25283.620745688782, 27251.591226131623, 27402.0, 27421.588676169824, 27654.0, 6496.74013039479, 6651.301613330603, 6652.06871038055, 6664.4002039816405, 6667.299933506984, 6097.237845269341, 6488.351164883497, 6506.577072490297, 6652.900206496906, 6664.600123992552, 6616.801495955129, 6616.900746488783, 6629.801105966829, 6639.767608133692, 6646.6676666166495, 6622.668866556653, 6638.17022872141, 6641.767538136142, 6642.103316052319, 6644.036614690867, 6164.445199932027, 6175.907361389583, 6176.413240742122, 6184.536159787989, 6191.628502289877, 29764.8511757442, 29904.55143172854, 30584.8470757647, 31415.214619634462, 31562.526562101586, 1936.94189174325, 1983.841292696581, 1985.2356842615698, 1988.363723608446, 1989.0253775649971, 19311.51721206967, 19668.606627867364, 19675.80324196754, 19793.40619781409, 19806.50483737918, 2331.9300420987397, 2379.476515166678, 2439.865807380593, 2444.8655323957173, 2448.155386391692, 134026.0, 139240.99999999898, 139416.0, 140340.0, 140926.29536852354, 14374.281285935662, 14669.77995330071, 14819.184944828137, 15320.923395382952, 15554.22228888551, 23158.842057897375, 23961.52076958451, 24105.0, 24109.879450602984, 24145.517089658108, 9485.051494850597, 9503.0, 9504.62384403899, 9551.665691700757, 9677.90322096784, 8466.66133354659, 8579.184977427134, 8611.784705382415, 8630.784230394165, 8663.610137543825, 9321.72034838956, 9338.225737109928, 9395.718128456158, 9577.664781732607, 9638.518074096268, 2742.287005378616, 2745.5881617757495, 2765.4054378308356, 2775.2229375774814, 2823.8820884336747, 940.4122423485321, 960.0735290444754, 965.1458459263603, 966.8549717542425, 977.9511024448749, 19571.11929963155, 19631.411057668294, 19730.112144953513, 19889.502762430766, 20189.0, 1037.1858091398217, 1043.4417586591137, 1050.5062620568322, 1052.3159946034984, 1059.560282482761, 11106.555737770399, 11119.833202501968, 11231.26996745209, 11303.660890173307, 11324.433778311051, 446733.0, 478149.0, 496109.0, 504143.0, 504395.0, 115631.0, 121820.0, 121869.39065304617, 122693.38653306855, 125314.3734281341, 1186.8160435132568, 1212.5452955141823, 1227.7789997800303, 1236.0, 1244.3715923458597, 17696.469105926328, 17742.0, 17774.200160993045, 17960.19179136968, 18031.18859651345, 54192.45807541874, 54512.182317266066, 54629.0, 54825.45174548363, 55636.443635563126, 67893.660531699, 68030.65984670045, 68328.65835670989, 68444.0, 69120.0, 14779.113253204841, 14919.776203356741, 15039.0, 15151.848481515484, 15213.6196595086, 23511.17710880111, 23531.41171470727, 23685.0, 23888.92499837477, 23901.521969560858, 18575.53561160982, 18675.626487470447, 18899.716504252174, 18953.336633217772, 19030.619387611892, 16642.084685342423, 17088.0, 17273.481795546155, 17343.479695609152, 17388.391406300718, 18966.52583685419, 19143.947082910574, 19303.131359089155, 19492.02539873029, 19495.317663881695, 14724.705505889608, 14751.483698070946, 14875.702485950436, 14880.107193568421, 14950.700985980437, 18085.547861303046, 18427.26290948401, 19307.0, 19458.902705486384, 19529.023548822217], "value": 12073.948576295878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.821013268275, 1428.9854203515504, 1429.1710807731513, 1453.4113683957994, 1458.547850166448, 13430.328483575819, 13954.790678139823, 13957.30213489324, 13988.160710357373, 14186.0, 13987.0, 14279.643008924782, 14300.71398572028, 14301.928490357559, 14305.499307524238, 2297.069686776858, 2342.7305859826083, 2345.2846881701075, 2351.1065794997876, 2353.305774796431, 2320.6751054852334, 2348.3072493614427, 2363.1728894886824, 2402.4474370894704, 2404.555157295897, 2309.503456756797, 2323.3030090972725, 2324.8023917966993, 2340.496793189464, 2350.4828937633692, 2300.470891694903, 2315.9305220843403, 2319.1998760427628, 2320.9555699935013, 2322.314917099443, 2263.739669937962, 2271.5456908618344, 2274.692916456274, 2275.328778010491, 2286.817054635625, 13265.071444998854, 13548.796768048487, 13555.186688798703, 13594.864051359558, 13597.796033059512, 7176.102987126609, 7414.073240844895, 7440.03279573652, 7487.850242995164, 7493.925060749377, 4620.8151673933, 4718.103560323528, 4876.439209490918, 4887.291342755316, 4895.534924182232, 1854.1192933356683, 1911.5603411215359, 1920.5678722287514, 1949.2495389275089, 1970.7142464342733, 21774.12903483859, 21955.0, 22021.779782202295, 22050.33848984533, 22096.88951555248, 6137.478314343241, 6224.813255602339, 6241.407066328691, 6264.878216055264, 6347.650879201596, 15008.324625391884, 15019.924900375647, 15026.0, 15052.32264548098, 15129.546113616609, 7185.53294035886, 7336.486445948839, 7368.742094026683, 7374.188839227681, 7379.040724705754, 5519.227308176858, 5762.654240745569, 6013.6993150342305, 6091.604045737013, 6879.965600171967, 4699.882502937386, 4807.759612019385, 4918.3360246367, 4923.729194894244, 4941.752912354368, 1363.8704323089291, 1367.1045465220298, 1376.3324787478066, 1381.1298881704463, 1399.9930000349932, 797.6091715059695, 813.3696385301321, 817.3869597801648, 839.7522730794431, 844.9522591986016, 7134.393576545948, 7145.0, 7190.7483238086415, 7200.387967022862, 7219.0, 725.0791494801573, 730.3718801830422, 735.2941176470648, 743.3941337809775, 745.8620155271292, 4415.911681766347, 4435.807359792761, 4495.910081798345, 4510.639148868083, 4543.091381723669, 18590.721139182653, 19006.80993190078, 19151.0, 19181.904090479456, 19544.31594894172, 17864.642707145784, 18967.905160474384, 18973.905130474537, 19230.903845480683, 19237.519062023282, 10417.218708596885, 10502.264841461025, 10557.049865511986, 10667.253292269621, 10700.518476668569, 7547.547147171187, 7548.622568871644, 7558.659860306189, 7561.508501947355, 7623.0, 16033.0, 16083.919580402024, 16377.93543419674, 16591.17044147812, 16709.91645041767, 17064.91467542704, 17248.913755431142, 17315.56711082233, 17328.913355433142, 17395.739063914305, 10002.949690282416, 10146.644867429604, 10152.746181345525, 10156.187504999434, 10214.080732733792, 12848.550300739429, 12886.29125398112, 12945.482180713043, 12947.676308092374, 13017.21896686202, 10398.428086455318, 10434.947825260826, 10562.15502759762, 10726.302790318605, 10727.731806704895, 10368.844467333147, 10376.74058148522, 10452.0, 10573.682789516326, 10801.945990269998, 9136.908630913871, 9359.017303183067, 9364.859527106963, 9372.531373431437, 9391.483468409304, 6912.412444942236, 6995.335443132894, 6995.370416662525, 7057.36483716468, 7063.646817658993, 6878.828029299308, 6895.620740859301, 6931.098957135742, 6954.061201737903, 6984.0], "value": 6016.512512756812, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.42068998402584, 498.5787009976569, 501.919692849144, 513.1507355326933, 530.0, 6107.206063211782, 6221.844453888655, 6223.688815559215, 6269.843253918654, 6276.968615156929, 5949.762009519625, 6055.848603784908, 6087.299960504543, 6105.481034112106, 6106.5725399221965, 4928.260760885878, 4948.342305327719, 4967.801287948496, 4980.377452818398, 4993.825216117437, 4972.552470277675, 4985.133548209776, 4990.700557966516, 5004.299398084271, 5007.599392048627, 4697.5772180503745, 4877.26840973855, 4952.232403977371, 4974.776135073912, 4989.328574927404, 4941.407031156285, 4948.391772673877, 4952.529509696591, 4955.702657840541, 4965.577925876305, 4394.4067550880545, 4434.778261086965, 4442.644588432918, 4443.5556444355625, 4504.842330518449, 5969.060420122742, 5996.280446346466, 6014.8496287592725, 6021.849453763647, 6077.453029227347, 5668.376478587352, 5698.971505142489, 5719.59962802604, 5746.936816688926, 5806.342004537157, 6505.804825855184, 6530.314316996694, 6532.738690452376, 6534.411902928759, 6555.93444065558, 4869.537393947569, 4896.632752543538, 4901.338319326881, 4906.656534042619, 4944.826931057396, 6747.467076996864, 6894.482913781386, 6895.31136812127, 6897.206821215575, 6970.1635803703375, 4954.133026720381, 4991.301217829507, 5001.499850015042, 5017.9247311290355, 5044.124848836128, 5047.192449208109, 5059.215821547666, 5079.466656001141, 5089.796408143633, 5097.64316497849, 5634.3802181759975, 5661.66030038199, 5703.800366987136, 5728.484436400744, 5732.570057245724, 6482.805515834532, 6493.350664933469, 6500.447461965691, 6521.184851893513, 6590.934090659128, 1662.717338052534, 1691.7227493242524, 1728.2568495547036, 1771.7873855137466, 1772.6100257943233, 1225.136278923357, 1233.8581063177849, 1235.7404944961659, 1247.4635906560266, 1248.719038216394, 5708.65748055118, 5722.656640601577, 5723.227364305849, 5757.568182386254, 5785.681787501728, 6549.672516374162, 6634.13756211699, 6638.535302528873, 6663.167104111986, 6681.365270299411, 5757.65454072757, 5774.94225057744, 5781.456159289899, 5816.539159200269, 5881.147233651182, 3558.6975107116186, 3572.0, 3639.8544058237903, 3643.4534819776713, 3649.288388764219, 6532.41208291256, 6542.672866356758, 6542.901856472156, 6573.1783527059115, 6582.736690532421, 6669.233038200669, 6849.48628852838, 6865.450763938873, 6887.173539175331, 6891.4486841053595, 6388.968055159695, 6515.0553169791065, 6558.8360290993105, 6559.0, 6600.60396376219, 6701.899471507833, 6718.428933540704, 6749.0, 6752.864942701217, 6761.763338283136, 6621.6689165540565, 6676.365745254193, 6728.0, 6761.459083273425, 6784.626845523346, 6410.61536307823, 6558.8360290993105, 6565.671716414256, 6574.934250657432, 6608.867822643617, 4960.280759289955, 4962.181240095344, 4991.3511243538105, 4991.850244492671, 4993.575546078624, 6655.0, 6657.538080198173, 6773.729050838108, 6825.624590647562, 6827.21487028998, 6408.327125651739, 6457.4511166551365, 6517.706703198272, 6547.1161393211305, 6554.770583029762, 6284.506577796898, 6463.0, 6469.0, 6472.579282346633, 6560.147180866456, 6041.909371359346, 6187.474064704551, 6372.808815735535, 6387.552871298964, 6449.806505804833, 6396.552241343062, 6423.710933007932, 6519.989401642753, 6541.215054193527, 6585.440237579859, 6288.245410550763, 6305.549723563698, 6323.620582765049, 6363.5863668861375, 6364.554481186457], "value": 5041.456599349299, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.6822343956176, 883.2933653077537, 899.9145081217287, 903.6069309850216, 913.182701482173, 18058.90970545147, 19076.90461547694, 19147.138378772954, 19162.904185479052, 19220.519487012814, 20247.39257822264, 22102.115915363407, 22171.22400715975, 22240.88879555604, 22400.0, 1039.9896001039988, 1062.9627963021296, 1063.5161001744189, 1063.8882917293688, 1064.297563608019, 1010.7321559786662, 1017.3183966742264, 1031.742064483879, 1061.9893801062005, 1064.8083344997897, 1099.8955099265556, 1100.8018556659797, 1102.3441052573705, 1102.3551222534827, 1105.011015141452, 1097.0346095436005, 1097.369012817629, 1102.9503672334724, 1103.0734183286079, 1103.17813229144, 796.7530065679658, 800.0799081056773, 800.8398320335956, 804.3725893802844, 807.019471342316, 17268.30926762928, 17678.91160544202, 17688.469345919642, 17713.29146834125, 20018.399448016582, 21558.568828623498, 21933.232336868292, 22502.21242256513, 22545.661815072788, 22815.08739650412, 16389.344426222935, 16442.917785410995, 16642.50072497815, 16647.750283745754, 16673.49979500617, 3548.361294966905, 3549.4498352755363, 3576.517170182018, 3577.5528058992627, 3596.8381422836037, 128883.0, 129829.35085324512, 130551.0, 134834.32582837218, 135163.0, 17013.744793828104, 17083.658326833392, 17096.91451542759, 17454.563635909202, 17459.127043647768, 32029.359412811613, 32550.837245814095, 32684.509732354032, 32947.3410531788, 33427.0, 8523.318134549221, 9074.092590740873, 9168.81662366749, 9179.908200917906, 9193.908060919306, 4079.428879956749, 4191.790410479463, 4192.140611174702, 4192.203481338597, 4200.369944508348, 4763.261694437368, 4927.457979622239, 4938.950610493921, 5462.535684466785, 5624.072028115397, 1017.9134773544183, 1045.534737042009, 1062.628080171949, 1066.1470823341451, 1068.4764465411893, 615.3354377272535, 630.2814791138106, 631.1132858334048, 637.9011253255753, 652.1228947066188, 11466.827997580043, 12088.274703517816, 12311.076669249842, 12380.566680166152, 12639.684007899876, 613.9447449729546, 625.9624422534663, 636.1570918532963, 637.9521535884735, 638.7955854126727, 5714.514266287412, 5745.1669507921115, 5796.594238403271, 5885.293764748258, 5907.379725128885, 104926.4753676242, 108599.0, 108777.0, 109574.0, 111304.44347778209, 93385.5330723342, 94983.0, 94986.0, 96992.51503742437, 99417.50291248497, 79845.60077199693, 80977.59511202406, 81612.59193704113, 83065.0, 83960.16039839646, 11106.000919834507, 11473.541058357907, 11505.539778409106, 11620.593279235187, 11837.289762614271, 37744.433833493065, 38005.0, 39191.804040979616, 39462.21075578415, 40071.39892901551, 47378.0, 48656.2701559484, 49317.0, 49644.25533616926, 50255.0, 16390.262438190548, 16455.506334809976, 16487.83512164863, 16689.91655041717, 16984.660306793547, 18133.90933045326, 18357.265709371477, 18364.81635183631, 18588.907055464635, 18591.628167436305, 15675.608109797346, 15892.761608576111, 15931.920340398225, 16044.598885027968, 16179.43371981975, 16707.66584668324, 19301.03494825281, 19971.400857974284, 20445.182192712124, 20482.692759608915, 16565.585860353105, 17057.0, 17110.0, 17113.229904654072, 17130.571735706708, 13369.66575835612, 13542.932285338511, 13711.657208569466, 13791.793123102962, 13914.86085139176, 14884.62788430298, 14894.882289152221, 15039.699206015599, 15264.465743699362, 15359.0], "value": 9028.17537306507, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 115.0, 106.0, 107.0, 108.0, 109.0, 111.0, 99.0, 109.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 153.0, 175.0, 124.0, 141.0, 150.0, 121.0, 188.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 162.0, 163.0, 164.0, 164.0, 168.0, 169.0, 164.0, 168.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 86.0, 77.0, 163.0, 81.0, 74.0, 75.0, 81.0, 162.0, 75.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 145.0, 83.0, 79.0, 79.0, 125.0, 86.0, 78.0, 131.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 120.0, 114.0, 119.0, 120.0, 113.0, 117.0, 118.0, 115.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 152.0, 152.0, 152.0, 152.0, 154.0, 151.0, 153.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 96.0, 94.0, 99.0, 96.0, 96.0, 94.0, 94.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 54.0, 63.0, 54.0, 56.0, 54.0, 54.0, 64.0, 55.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 95.0, 88.0, 88.0, 79.0, 80.0, 80.0, 88.0, 83.0, 79.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 140.0, 129.0, 130.0, 129.0, 136.0, 128.0, 127.0, 124.0, 180.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 172.0, 180.0, 175.0, 180.0, 189.0, 172.0, 192.0, 172.0, 176.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 73.0, 68.0, 67.0, 68.0, 68.0, 68.0, 66.0, 65.0, 66.0], "value": 67.7, "unit": "score"}]}]} 11:49:55 INFO - Return code: 0 11:49:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:49:55 INFO - # TBPL SUCCESS # 11:49:55 INFO - Running post-action listener: _package_coverage_data 11:49:55 INFO - Running post-action listener: _resource_record_post_action 11:49:55 INFO - [mozharness: 2017-08-04 18:49:55.488726Z] Finished run-tests step (success) 11:49:55 INFO - Running post-run listener: _resource_record_post_run 11:49:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 6037504; Write bytes: 441589760; Read time: 3264; Write time: 418280 11:49:55 INFO - TinderboxPrint: CPU usage
13.2% 11:49:55 INFO - TinderboxPrint: I/O read bytes / time
6,037,504 / 3,264 11:49:55 INFO - TinderboxPrint: I/O write bytes / time
441,589,760 / 418,280 11:49:55 INFO - TinderboxPrint: CPU idle
8,284.5 (86.8%) 11:49:55 INFO - TinderboxPrint: CPU user
1,205.7 (12.6%) 11:49:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:49:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116019200; Read time: 0; Write time: 95684 11:49:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:49:55 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3883008; Write bytes: 268296192; Read time: 2816; Write time: 297228 11:49:56 INFO - Running post-run listener: _upload_blobber_files 11:49:56 INFO - Blob upload gear active. 11:49:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:49:56 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 11:49:56 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'] 11:49:56 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 11:49:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:49:58 INFO - (blobuploader) - INFO - Done attempting. 11:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:50:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:05 INFO - (blobuploader) - INFO - Done attempting. 11:50:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:50:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:06 INFO - (blobuploader) - INFO - Done attempting. 11:50:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:50:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:50:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:50:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:50:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:50:07 INFO - (blobuploader) - INFO - Done attempting. 11:50:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:50:07 INFO - Return code: 0 11:50:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:50:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:50:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b722072de22e524452ab5efe40e3db56fc2b24ce2be64582bdcce8d50740355a9ead35b65eff365ab7e816df20d2698c6c5a6c421c916a90ca46c51eff774cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c46f2ca507564ea744e9c9f8d653a1d22081cb2de80ae7b805ad331dc936784994e3347fdfc096ab44e9af7175750a8badbf6df890f5b7e399d6a49146ee6015", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78723ef12952f4b64742bf7abfcb3d18cd0218f77bf3b99887b844b9a7ba7582ca48ab90176eb5d51c9028802779f50489de88c2cd500a3d296374700a471b6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ca1c82a70124d014b1b31ae5cb5116dd1189c7a8787d20c30f82165d21b542dff42d03b18aa8871a6aabdfbcccca6d96b697c29218cc71f797d73ec10c5e6d"} 11:50:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:50:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:50:07 INFO - Contents: 11:50:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b722072de22e524452ab5efe40e3db56fc2b24ce2be64582bdcce8d50740355a9ead35b65eff365ab7e816df20d2698c6c5a6c421c916a90ca46c51eff774cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c46f2ca507564ea744e9c9f8d653a1d22081cb2de80ae7b805ad331dc936784994e3347fdfc096ab44e9af7175750a8badbf6df890f5b7e399d6a49146ee6015", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78723ef12952f4b64742bf7abfcb3d18cd0218f77bf3b99887b844b9a7ba7582ca48ab90176eb5d51c9028802779f50489de88c2cd500a3d296374700a471b6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ca1c82a70124d014b1b31ae5cb5116dd1189c7a8787d20c30f82165d21b542dff42d03b18aa8871a6aabdfbcccca6d96b697c29218cc71f797d73ec10c5e6d"} 11:50:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:50:07 INFO - Copying logs to upload dir... 11:50:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:50:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.133365 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-04 11:50:07.474574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:50:07.478328) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b722072de22e524452ab5efe40e3db56fc2b24ce2be64582bdcce8d50740355a9ead35b65eff365ab7e816df20d2698c6c5a6c421c916a90ca46c51eff774cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c46f2ca507564ea744e9c9f8d653a1d22081cb2de80ae7b805ad331dc936784994e3347fdfc096ab44e9af7175750a8badbf6df890f5b7e399d6a49146ee6015", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78723ef12952f4b64742bf7abfcb3d18cd0218f77bf3b99887b844b9a7ba7582ca48ab90176eb5d51c9028802779f50489de88c2cd500a3d296374700a471b6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ca1c82a70124d014b1b31ae5cb5116dd1189c7a8787d20c30f82165d21b542dff42d03b18aa8871a6aabdfbcccca6d96b697c29218cc71f797d73ec10c5e6d"} build_url:https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011160 build_url: 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b722072de22e524452ab5efe40e3db56fc2b24ce2be64582bdcce8d50740355a9ead35b65eff365ab7e816df20d2698c6c5a6c421c916a90ca46c51eff774cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c46f2ca507564ea744e9c9f8d653a1d22081cb2de80ae7b805ad331dc936784994e3347fdfc096ab44e9af7175750a8badbf6df890f5b7e399d6a49146ee6015", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78723ef12952f4b64742bf7abfcb3d18cd0218f77bf3b99887b844b9a7ba7582ca48ab90176eb5d51c9028802779f50489de88c2cd500a3d296374700a471b6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ca1c82a70124d014b1b31ae5cb5116dd1189c7a8787d20c30f82165d21b542dff42d03b18aa8871a6aabdfbcccca6d96b697c29218cc71f797d73ec10c5e6d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:50:07.502629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:50:07.502943) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501871341.486440-1896685390 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:50:07.586841) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:50:07.587163) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:50:07.587447) ========= ========= Total master_lag: 0.13 =========