builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1501872343.9 results: success (0) revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:43.898356) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:43.898815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:43.899117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:43.916107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:43.916415) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 11:45:44-- 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% 38.6M=0s 2017-08-04 11:45:44 (38.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.224821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:44.155060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:44.155368) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015117 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:44.204611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 11:45:44.205043) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 11:45:44,534 truncating revision to first 12 chars 2017-08-04 11:45:44,534 Setting DEBUG logging. 2017-08-04 11:45:44,534 attempt 1/10 2017-08-04 11:45:44,534 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:45:45,614 unpacking tar archive at: mozilla-central-bc8295698806/testing/mozharness/ program finished with exit code 0 elapsedTime=1.395185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-04 11:45:45.613523) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:45.613825) ========= script_repo_revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:45.614257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:45.614521) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:45:45.685260) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-04 11:45:45.685622) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:45:46 INFO - MultiFileLogger online at 20170804 11:45:46 in /builds/slave/test 11:45:46 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:45:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:45:46 INFO - {'append_to_log': False, 11:45:46 INFO - 'base_work_dir': '/builds/slave/test', 11:45:46 INFO - 'blob_upload_branch': 'Firefox', 11:45:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:45:46 INFO - 'branch': 'Firefox', 11:45:46 INFO - 'buildbot_json_path': 'buildprops.json', 11:45:46 INFO - 'code_coverage': False, 11:45:46 INFO - 'config_files': ('talos/linux_config.py',), 11:45:46 INFO - 'default_actions': ('clobber', 11:45:46 INFO - 'read-buildbot-config', 11:45:46 INFO - 'download-and-extract', 11:45:46 INFO - 'populate-webroot', 11:45:46 INFO - 'create-virtualenv', 11:45:46 INFO - 'install', 11:45:46 INFO - 'setup-mitmproxy', 11:45:46 INFO - 'run-tests'), 11:45:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:45:46 INFO - 'disable_ccov_upload': False, 11:45:46 INFO - 'download_minidump_stackwalk': True, 11:45:46 INFO - 'download_symbols': 'ondemand', 11:45:46 INFO - 'enable_stylo': False, 11:45:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:45:46 INFO - 'tooltool.py': '/tools/tooltool.py', 11:45:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:45:46 INFO - '/tools/misc-python/virtualenv.py')}, 11:45:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:45:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:45:46 INFO - 'gecko_profile': False, 11:45:46 INFO - 'gecko_profile_interval': 0, 11:45:46 INFO - 'installer_path': 'installer.exe', 11:45:46 INFO - 'log_level': 'info', 11:45:46 INFO - 'log_name': 'talos', 11:45:46 INFO - 'log_to_console': True, 11:45:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:45:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:45:46 INFO - 'opt_config_files': (), 11:45:46 INFO - 'pip_index': False, 11:45:46 INFO - 'suite': 'dromaeojs-e10s', 11:45:46 INFO - 'system_bits': '32', 11:45:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:45:46 INFO - 'title': 'talos-linux64-ix-006', 11:45:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:45:46 INFO - 'use_talos_json': True, 11:45:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:45:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:45:46 INFO - 'work_dir': 'build'} 11:45:46 INFO - [mozharness: 2017-08-04 18:45:46.227447Z] Running clobber step. 11:45:46 INFO - Running pre-action listener: _resource_record_pre_action 11:45:46 INFO - Running main action method: clobber 11:45:46 INFO - rmtree: /builds/slave/test/build 11:45:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:45:47 INFO - Running post-action listener: _resource_record_post_action 11:45:47 INFO - [mozharness: 2017-08-04 18:45:47.215961Z] Finished clobber step (success) 11:45:47 INFO - [mozharness: 2017-08-04 18:45:47.216064Z] Running read-buildbot-config step. 11:45:47 INFO - Running pre-action listener: _resource_record_pre_action 11:45:47 INFO - Running main action method: read_buildbot_config 11:45:47 INFO - Using buildbot properties: 11:45:47 INFO - { 11:45:47 INFO - "project": "", 11:45:47 INFO - "product": "firefox", 11:45:47 INFO - "who": "archaeopteryx@coole-files.de", 11:45:47 INFO - "installer_path": "public/build/target.tar.bz2", 11:45:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:45:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:45:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:45:47 INFO - "stage_platform": "linux64-pgo", 11:45:47 INFO - "basedir": "/builds/slave/test", 11:45:47 INFO - "buildnumber": 110, 11:45:47 INFO - "platform": "ubuntu64_hw", 11:45:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:45:47 INFO - "slavebuilddir": "test", 11:45:47 INFO - "taskId": "WAhtmB8UTkqI8sopAKMoBQ", 11:45:47 INFO - "branch": "mozilla-central", 11:45:47 INFO - "script_repo_revision": "production", 11:45:47 INFO - "revision": "bc829569880635c52d6e3d54f51cd7d3df180186", 11:45:47 INFO - "slavename": "talos-linux64-ix-006", 11:45:47 INFO - "repo_path": "mozilla-central" 11:45:47 INFO - } 11:45:47 INFO - Finding installer, test and symbols from parent task. 11:45:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAhtmB8UTkqI8sopAKMoBQ'}, attempt #1 11:45:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WAhtmB8UTkqI8sopAKMoBQ'}, attempt #1 11:45:48 INFO - Task dependencies: KFlhWM79RY6N1TxtxvhXpg 11:45:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg'}, attempt #1 11:45:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 11:45:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.test_packages.json 11:45:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.crashreporter-symbols.zip 11:45:48 INFO - Running post-action listener: _resource_record_post_action 11:45:48 INFO - [mozharness: 2017-08-04 18:45:48.600577Z] Finished read-buildbot-config step (success) 11:45:48 INFO - [mozharness: 2017-08-04 18:45:48.600799Z] Running download-and-extract step. 11:45:48 INFO - Running pre-action listener: _resource_record_pre_action 11:45:48 INFO - Running main action method: download_and_extract 11:45:48 INFO - mkdir: /builds/slave/test/build/tests 11:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:45:48 INFO - trying https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.test_packages.json 11:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:45:49 INFO - Downloaded 989 bytes. 11:45:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:45:49 INFO - Using the following test package requirements: 11:45:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:45:49 INFO - u'common': [u'target.common.tests.zip'], 11:45:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:45:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:45:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:45:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:45:49 INFO - u'mozbase': [u'target.common.tests.zip'], 11:45:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:45:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:45:49 INFO - u'web-platform': [u'target.common.tests.zip', 11:45:49 INFO - u'target.web-platform.tests.tar.gz'], 11:45:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:45:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:45:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip 11:45:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:45:49 INFO - Fetch https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip into memory 11:45:50 INFO - Content-Length response header: 54897708 11:45:50 INFO - Bytes received: 54897708 11:46:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:46:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip 11:46:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:46:01 INFO - Fetch https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.common.tests.zip into memory 11:46:02 INFO - Content-Length response header: 54897708 11:46:02 INFO - Bytes received: 54897708 11:46:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.talos.tests.zip 11:46:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:46:15 INFO - Fetch https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.talos.tests.zip into memory 11:46:15 INFO - Content-Length response header: 14496008 11:46:15 INFO - Bytes received: 14496008 11:46: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:46:16 INFO - trying https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 11:46:16 INFO - Downloading https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:46:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:46:17 INFO - Downloaded 62815548 bytes. 11:46:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 11:46:17 INFO - mkdir: /builds/slave/test/properties 11:46:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:17 INFO - Contents: 11:46:17 INFO - build_url:https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 11:46:17 INFO - Running post-action listener: _resource_record_post_action 11:46:17 INFO - Running post-action listener: set_extra_try_arguments 11:46:17 INFO - [mozharness: 2017-08-04 18:46:17.306314Z] Finished download-and-extract step (success) 11:46:17 INFO - [mozharness: 2017-08-04 18:46:17.306424Z] Running populate-webroot step. 11:46:17 INFO - Running pre-action listener: _resource_record_pre_action 11:46:17 INFO - Running main action method: populate_webroot 11:46:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:46:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:46:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:46:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:46:17 INFO - 'tests': ['damp', 'tps']}, 11:46:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:46:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:46:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:46:17 INFO - 'other-e10s': {'tests': ['a11yr', 11:46:17 INFO - 'ts_paint', 11:46:17 INFO - 'tpaint', 11:46:17 INFO - 'sessionrestore', 11:46:17 INFO - 'sessionrestore_many_windows', 11:46:17 INFO - 'sessionrestore_no_auto_restore', 11:46:17 INFO - 'tabpaint']}, 11:46:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:46:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:46:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:46:17 INFO - 'tsvgr_opacity', 11:46:17 INFO - 'tart', 11:46:17 INFO - 'tscrollx', 11:46:17 INFO - 'tsvg_static']}, 11:46:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:46:17 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:46:17 INFO - 'talos_options': ['--mitmproxy', 11:46:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:46:17 INFO - '--firstNonBlankPaint'], 11:46:17 INFO - 'tests': ['tp6_google', 11:46:17 INFO - 'tp6_youtube', 11:46:17 INFO - 'tp6_amazon', 11:46:17 INFO - 'tp6_facebook']}, 11:46:17 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:46:17 INFO - 'talos_options': ['--stylo', 11:46:17 INFO - '--mitmproxy', 11:46:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:46:17 INFO - '--firstNonBlankPaint'], 11:46:17 INFO - 'tests': ['tp6_google', 11:46:17 INFO - 'tp6_youtube', 11:46:17 INFO - 'tp6_amazon', 11:46:17 INFO - 'tp6_facebook']}, 11:46:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:46:17 INFO - 'talos_options': ['--stylo', 11:46:17 INFO - '--stylo-threads=1', 11:46:17 INFO - '--mitmproxy', 11:46:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:46:17 INFO - '--firstNonBlankPaint'], 11:46:17 INFO - 'tests': ['tp6_google', 11:46:17 INFO - 'tp6_youtube', 11:46:17 INFO - 'tp6_amazon', 11:46:17 INFO - 'tp6_facebook']}, 11:46:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:46:17 INFO - 'talos_options': ['--xperf_path', 11:46:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:17 INFO - 'tests': ['tp5n']}}} 11:46:17 INFO - Running post-action listener: _resource_record_post_action 11:46:17 INFO - [mozharness: 2017-08-04 18:46:17.315473Z] Finished populate-webroot step (success) 11:46:17 INFO - [mozharness: 2017-08-04 18:46:17.315575Z] Running create-virtualenv step. 11:46:17 INFO - Running pre-action listener: _resource_record_pre_action 11:46:17 INFO - Running main action method: create_virtualenv 11:46:17 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:17 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:46:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:46:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:18 INFO - Using real prefix '/usr' 11:46:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:21 INFO - Installing pip.................done. 11:46:21 INFO - Return code: 0 11:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:46:21 INFO - Reading from file tmpfile_stdout 11:46:21 INFO - Output received: 11:46:21 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:46:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:21 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:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:21 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:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:21 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:21 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:46:21 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:46:21 INFO - Using env: {'DISPLAY': ':0', 11:46:21 INFO - 'HOME': '/home/cltbld', 11:46:21 INFO - 'LANG': 'en_US.UTF-8', 11:46:21 INFO - 'LANGUAGE': 'en_US:en', 11:46:21 INFO - 'LOGNAME': 'cltbld', 11:46:21 INFO - 'MAIL': '/var/mail/cltbld', 11:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:21 INFO - 'MOZ_NO_REMOTE': '1', 11:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:21 INFO - 'NO_EM_RESTART': '1', 11:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:21 INFO - 'PWD': '/builds/slave/test', 11:46:21 INFO - 'SHELL': '/bin/bash', 11:46:21 INFO - 'SHLVL': '1', 11:46:21 INFO - 'TERM': 'linux', 11:46:21 INFO - 'TMOUT': '86400', 11:46:21 INFO - 'USER': 'cltbld', 11:46:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:21 INFO - '_': '/tools/buildbot/bin/python'} 11:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:21 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:46:21 INFO - Cleaning up... 11:46:21 INFO - Return code: 0 11:46:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:46:21 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:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:21 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:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:21 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:21 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:46:21 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:46:21 INFO - Using env: {'DISPLAY': ':0', 11:46:21 INFO - 'HOME': '/home/cltbld', 11:46:21 INFO - 'LANG': 'en_US.UTF-8', 11:46:21 INFO - 'LANGUAGE': 'en_US:en', 11:46:21 INFO - 'LOGNAME': 'cltbld', 11:46:21 INFO - 'MAIL': '/var/mail/cltbld', 11:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:21 INFO - 'MOZ_NO_REMOTE': '1', 11:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:21 INFO - 'NO_EM_RESTART': '1', 11:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:21 INFO - 'PWD': '/builds/slave/test', 11:46:21 INFO - 'SHELL': '/bin/bash', 11:46:21 INFO - 'SHLVL': '1', 11:46:21 INFO - 'TERM': 'linux', 11:46:21 INFO - 'TMOUT': '86400', 11:46:21 INFO - 'USER': 'cltbld', 11:46:21 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:21 INFO - '_': '/tools/buildbot/bin/python'} 11:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:22 INFO - Downloading/unpacking psutil>=3.1.1 11:46:22 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:46:22 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:46:22 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:46:22 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:46:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:23 INFO - Installing collected packages: psutil 11:46:23 INFO - Running setup.py install for psutil 11:46:23 INFO - building 'psutil._psutil_linux' extension 11:46:23 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:46:24 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:46:24 INFO - building 'psutil._psutil_posix' extension 11:46:24 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:46:24 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:46:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:24 INFO - Successfully installed psutil 11:46:24 INFO - Cleaning up... 11:46:24 INFO - Return code: 0 11:46:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46:24 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:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:24 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:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:24 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:24 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:46:24 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:46:24 INFO - Using env: {'DISPLAY': ':0', 11:46:24 INFO - 'HOME': '/home/cltbld', 11:46:24 INFO - 'LANG': 'en_US.UTF-8', 11:46:24 INFO - 'LANGUAGE': 'en_US:en', 11:46:24 INFO - 'LOGNAME': 'cltbld', 11:46:24 INFO - 'MAIL': '/var/mail/cltbld', 11:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:24 INFO - 'MOZ_NO_REMOTE': '1', 11:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:24 INFO - 'NO_EM_RESTART': '1', 11:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:24 INFO - 'PWD': '/builds/slave/test', 11:46:24 INFO - 'SHELL': '/bin/bash', 11:46:24 INFO - 'SHLVL': '1', 11:46:24 INFO - 'TERM': 'linux', 11:46:24 INFO - 'TMOUT': '86400', 11:46:24 INFO - 'USER': 'cltbld', 11:46:24 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:24 INFO - '_': '/tools/buildbot/bin/python'} 11:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46:25 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:46:25 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:46:25 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:46:25 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:46:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:26 INFO - Installing collected packages: mozsystemmonitor 11:46:26 INFO - Running setup.py install for mozsystemmonitor 11:46:26 INFO - Successfully installed mozsystemmonitor 11:46:26 INFO - Cleaning up... 11:46:26 INFO - Return code: 0 11:46:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46:26 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:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:26 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:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:26 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:46:26 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:46:26 INFO - Using env: {'DISPLAY': ':0', 11:46:26 INFO - 'HOME': '/home/cltbld', 11:46:26 INFO - 'LANG': 'en_US.UTF-8', 11:46:26 INFO - 'LANGUAGE': 'en_US:en', 11:46:26 INFO - 'LOGNAME': 'cltbld', 11:46:26 INFO - 'MAIL': '/var/mail/cltbld', 11:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:26 INFO - 'MOZ_NO_REMOTE': '1', 11:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:26 INFO - 'NO_EM_RESTART': '1', 11:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:26 INFO - 'PWD': '/builds/slave/test', 11:46:26 INFO - 'SHELL': '/bin/bash', 11:46:26 INFO - 'SHLVL': '1', 11:46:26 INFO - 'TERM': 'linux', 11:46:26 INFO - 'TMOUT': '86400', 11:46:26 INFO - 'USER': 'cltbld', 11:46:26 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:26 INFO - '_': '/tools/buildbot/bin/python'} 11:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:46:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:46:27 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:46:27 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:46:27 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:46:27 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:46:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:46:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:46:27 INFO - warning: no files found matching '*.txt' 11:46:27 INFO - no previously-included directories found matching 'build' 11:46:27 INFO - no previously-included directories found matching 'dist' 11:46:27 INFO - no previously-included directories found matching '.git*' 11:46:27 INFO - Installing collected packages: jsonschema, functools32 11:46:28 INFO - Running setup.py install for functools32 11:46:28 INFO - warning: no files found matching '*.txt' 11:46:28 INFO - no previously-included directories found matching 'build' 11:46:28 INFO - no previously-included directories found matching 'dist' 11:46:28 INFO - no previously-included directories found matching '.git*' 11:46:28 INFO - Successfully installed jsonschema functools32 11:46:28 INFO - Cleaning up... 11:46:28 INFO - Return code: 0 11:46:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:46:28 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:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:28 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:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:28 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:28 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:46:28 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:46:28 INFO - Using env: {'DISPLAY': ':0', 11:46:28 INFO - 'HOME': '/home/cltbld', 11:46:28 INFO - 'LANG': 'en_US.UTF-8', 11:46:28 INFO - 'LANGUAGE': 'en_US:en', 11:46:28 INFO - 'LOGNAME': 'cltbld', 11:46:28 INFO - 'MAIL': '/var/mail/cltbld', 11:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:28 INFO - 'MOZ_NO_REMOTE': '1', 11:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:28 INFO - 'NO_EM_RESTART': '1', 11:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:28 INFO - 'PWD': '/builds/slave/test', 11:46:28 INFO - 'SHELL': '/bin/bash', 11:46:28 INFO - 'SHLVL': '1', 11:46:28 INFO - 'TERM': 'linux', 11:46:28 INFO - 'TMOUT': '86400', 11:46:28 INFO - 'USER': 'cltbld', 11:46:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:28 INFO - '_': '/tools/buildbot/bin/python'} 11:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:46:28 INFO - Cleaning up... 11:46:28 INFO - Return code: 0 11:46:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:46:28 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:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:28 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:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:28 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:28 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:46:28 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:46:28 INFO - Using env: {'DISPLAY': ':0', 11:46:28 INFO - 'HOME': '/home/cltbld', 11:46:28 INFO - 'LANG': 'en_US.UTF-8', 11:46:28 INFO - 'LANGUAGE': 'en_US:en', 11:46:28 INFO - 'LOGNAME': 'cltbld', 11:46:28 INFO - 'MAIL': '/var/mail/cltbld', 11:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:28 INFO - 'MOZ_NO_REMOTE': '1', 11:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:28 INFO - 'NO_EM_RESTART': '1', 11:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:28 INFO - 'PWD': '/builds/slave/test', 11:46:28 INFO - 'SHELL': '/bin/bash', 11:46:28 INFO - 'SHLVL': '1', 11:46:28 INFO - 'TERM': 'linux', 11:46:28 INFO - 'TMOUT': '86400', 11:46:28 INFO - 'USER': 'cltbld', 11:46:28 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:28 INFO - '_': '/tools/buildbot/bin/python'} 11:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:46:28 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:46:28 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:46:28 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:46:28 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:46:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:46:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:46:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:46:30 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:46:30 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:46:30 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:46:30 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:46:30 INFO - Downloading docopt-0.6.1.tar.gz 11:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:46:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:46:30 INFO - Running setup.py install for blobuploader 11:46:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:46:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:46:30 INFO - Running setup.py install for requests 11:46:30 INFO - Running setup.py install for docopt 11:46:30 INFO - Successfully installed blobuploader requests docopt 11:46:30 INFO - Cleaning up... 11:46:30 INFO - Return code: 0 11:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:30 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:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:30 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:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:30 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:30 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:46:30 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:46:30 INFO - Using env: {'DISPLAY': ':0', 11:46:30 INFO - 'HOME': '/home/cltbld', 11:46:30 INFO - 'LANG': 'en_US.UTF-8', 11:46:30 INFO - 'LANGUAGE': 'en_US:en', 11:46:30 INFO - 'LOGNAME': 'cltbld', 11:46:30 INFO - 'MAIL': '/var/mail/cltbld', 11:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:30 INFO - 'MOZ_NO_REMOTE': '1', 11:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:30 INFO - 'NO_EM_RESTART': '1', 11:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:30 INFO - 'PWD': '/builds/slave/test', 11:46:30 INFO - 'SHELL': '/bin/bash', 11:46:30 INFO - 'SHLVL': '1', 11:46:30 INFO - 'TERM': 'linux', 11:46:30 INFO - 'TMOUT': '86400', 11:46:30 INFO - 'USER': 'cltbld', 11:46:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:30 INFO - '_': '/tools/buildbot/bin/python'} 11:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:31 INFO - Running setup.py (path:/tmp/pip-YlRutv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:31 INFO - Running setup.py (path:/tmp/pip-mPzLyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:31 INFO - Running setup.py (path:/tmp/pip-Los0mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:31 INFO - Running setup.py (path:/tmp/pip-hSraY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:31 INFO - Running setup.py (path:/tmp/pip-AQwXbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:31 INFO - Running setup.py (path:/tmp/pip-5XnSee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:31 INFO - Running setup.py (path:/tmp/pip-Otm5yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:31 INFO - Running setup.py (path:/tmp/pip-Oj14FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:31 INFO - Running setup.py (path:/tmp/pip-PLTkPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:31 INFO - Running setup.py (path:/tmp/pip-nO2YC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:31 INFO - Running setup.py (path:/tmp/pip-otmyNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:31 INFO - Running setup.py (path:/tmp/pip-_zwm_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:31 INFO - Running setup.py (path:/tmp/pip-nkTZJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:31 INFO - Running setup.py (path:/tmp/pip-omamHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:32 INFO - Running setup.py (path:/tmp/pip-EA5nT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:32 INFO - Running setup.py (path:/tmp/pip-u1fMI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:32 INFO - Running setup.py (path:/tmp/pip-Ie1jNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:46:32 INFO - Running setup.py install for manifestparser 11:46:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:46:32 INFO - Running setup.py install for mozcrash 11:46:32 INFO - Running setup.py install for mozdebug 11:46:32 INFO - Running setup.py install for mozdevice 11:46:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:46:32 INFO - Running setup.py install for mozfile 11:46:32 INFO - Running setup.py install for mozhttpd 11:46:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:46:32 INFO - Running setup.py install for mozinfo 11:46:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:46:32 INFO - Running setup.py install for mozInstall 11:46:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Running setup.py install for mozleak 11:46:33 INFO - Running setup.py install for mozlog 11:46:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Running setup.py install for moznetwork 11:46:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Running setup.py install for mozprocess 11:46:33 INFO - Running setup.py install for mozprofile 11:46:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Running setup.py install for mozrunner 11:46:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:46:33 INFO - Running setup.py install for mozscreenshot 11:46:33 INFO - Running setup.py install for moztest 11:46:33 INFO - Running setup.py install for mozversion 11:46:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:46:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:46:34 INFO - Cleaning up... 11:46:34 INFO - Return code: 0 11:46:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:34 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:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:34 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:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:34 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:34 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:46:34 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:46:34 INFO - Using env: {'DISPLAY': ':0', 11:46:34 INFO - 'HOME': '/home/cltbld', 11:46:34 INFO - 'LANG': 'en_US.UTF-8', 11:46:34 INFO - 'LANGUAGE': 'en_US:en', 11:46:34 INFO - 'LOGNAME': 'cltbld', 11:46:34 INFO - 'MAIL': '/var/mail/cltbld', 11:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:34 INFO - 'MOZ_NO_REMOTE': '1', 11:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:34 INFO - 'NO_EM_RESTART': '1', 11:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:34 INFO - 'PWD': '/builds/slave/test', 11:46:34 INFO - 'SHELL': '/bin/bash', 11:46:34 INFO - 'SHLVL': '1', 11:46:34 INFO - 'TERM': 'linux', 11:46:34 INFO - 'TMOUT': '86400', 11:46:34 INFO - 'USER': 'cltbld', 11:46:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:34 INFO - '_': '/tools/buildbot/bin/python'} 11:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:34 INFO - Running setup.py (path:/tmp/pip-LW7DpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:34 INFO - Running setup.py (path:/tmp/pip-4E2Js2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:34 INFO - Running setup.py (path:/tmp/pip-sg3ent-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:34 INFO - Running setup.py (path:/tmp/pip-rNMLUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:34 INFO - Running setup.py (path:/tmp/pip-uw3QAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:34 INFO - Running setup.py (path:/tmp/pip-H6kYOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:34 INFO - Running setup.py (path:/tmp/pip-8DC7NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:34 INFO - Running setup.py (path:/tmp/pip-mcL6KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:34 INFO - Running setup.py (path:/tmp/pip-EmCy4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:34 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:46:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:34 INFO - Running setup.py (path:/tmp/pip-8dLRHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:35 INFO - Running setup.py (path:/tmp/pip-EOsYrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:35 INFO - Running setup.py (path:/tmp/pip-q6VZlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:35 INFO - Running setup.py (path:/tmp/pip-hwdY_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:35 INFO - Running setup.py (path:/tmp/pip-KCf_Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:35 INFO - Running setup.py (path:/tmp/pip-wOWg2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:35 INFO - Running setup.py (path:/tmp/pip-nLYeSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:35 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:46:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:35 INFO - Running setup.py (path:/tmp/pip-9z749b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:35 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:46:35 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:46:35 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:46:35 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:46:35 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:46:35 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:46:35 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:46:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:36 INFO - Downloading blessings-1.6.tar.gz 11:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:46:36 INFO - Installing collected packages: blessings 11:46:36 INFO - Running setup.py install for blessings 11:46:36 INFO - Successfully installed blessings 11:46:36 INFO - Cleaning up... 11:46:36 INFO - Return code: 0 11:46:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:46:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:37 INFO - Reading from file tmpfile_stdout 11:46:37 INFO - Current package versions: 11:46:37 INFO - argparse == 1.2.1 11:46:37 INFO - blessings == 1.6 11:46:37 INFO - blobuploader == 1.2.4 11:46:37 INFO - docopt == 0.6.1 11:46:37 INFO - functools32 == 3.2.3-2 11:46:37 INFO - jsonschema == 2.5.1 11:46:37 INFO - manifestparser == 1.1 11:46:37 INFO - mozInstall == 1.13 11:46:37 INFO - mozcrash == 1.0 11:46:37 INFO - mozdebug == 0.1 11:46:37 INFO - mozdevice == 0.51 11:46:37 INFO - mozfile == 1.2 11:46:37 INFO - mozhttpd == 0.7 11:46:37 INFO - mozinfo == 0.10 11:46:37 INFO - mozleak == 0.1 11:46:37 INFO - mozlog == 3.5 11:46:37 INFO - moznetwork == 0.27 11:46:37 INFO - mozprocess == 0.25 11:46:37 INFO - mozprofile == 0.28 11:46:37 INFO - mozrunner == 6.13 11:46:37 INFO - mozscreenshot == 0.1 11:46:37 INFO - mozsystemmonitor == 0.3 11:46:37 INFO - moztest == 0.8 11:46:37 INFO - mozversion == 1.4 11:46:37 INFO - psutil == 3.1.1 11:46:37 INFO - requests == 1.2.3 11:46:37 INFO - wsgiref == 0.1.2 11:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:37 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:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:37 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:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:37 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 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46:37 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:46:37 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:46:37 INFO - Using env: {'DISPLAY': ':0', 11:46:37 INFO - 'HOME': '/home/cltbld', 11:46:37 INFO - 'LANG': 'en_US.UTF-8', 11:46:37 INFO - 'LANGUAGE': 'en_US:en', 11:46:37 INFO - 'LOGNAME': 'cltbld', 11:46:37 INFO - 'MAIL': '/var/mail/cltbld', 11:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:37 INFO - 'MOZ_NO_REMOTE': '1', 11:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:37 INFO - 'NO_EM_RESTART': '1', 11:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:37 INFO - 'PWD': '/builds/slave/test', 11:46:37 INFO - 'SHELL': '/bin/bash', 11:46:37 INFO - 'SHLVL': '1', 11:46:37 INFO - 'TERM': 'linux', 11:46:37 INFO - 'TMOUT': '86400', 11:46:37 INFO - 'USER': 'cltbld', 11:46:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:37 INFO - '_': '/tools/buildbot/bin/python'} 11:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:37 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:46:37 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:46:37 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:46:37 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:46:37 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:46:37 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:46:37 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:46:37 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:46:37 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:46:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:46:38 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:46:38 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:46:38 INFO - Installing collected packages: simplejson 11:46:38 INFO - Running setup.py install for simplejson 11:46:38 INFO - building 'simplejson._speedups' extension 11:46:38 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:46:39 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:46:39 INFO - Successfully installed simplejson 11:46:39 INFO - Cleaning up... 11:46:39 INFO - Return code: 0 11:46:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:46: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:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46: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:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe711f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11e0d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', '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:46: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', 'jsonschema'] in /builds/slave/test/build 11:46: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 jsonschema 11:46:39 INFO - Using env: {'DISPLAY': ':0', 11:46:39 INFO - 'HOME': '/home/cltbld', 11:46:39 INFO - 'LANG': 'en_US.UTF-8', 11:46:39 INFO - 'LANGUAGE': 'en_US:en', 11:46:39 INFO - 'LOGNAME': 'cltbld', 11:46:39 INFO - 'MAIL': '/var/mail/cltbld', 11:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:39 INFO - 'MOZ_NO_REMOTE': '1', 11:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:39 INFO - 'NO_EM_RESTART': '1', 11:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:39 INFO - 'PWD': '/builds/slave/test', 11:46:39 INFO - 'SHELL': '/bin/bash', 11:46:39 INFO - 'SHLVL': '1', 11:46:39 INFO - 'TERM': 'linux', 11:46:39 INFO - 'TMOUT': '86400', 11:46:39 INFO - 'USER': 'cltbld', 11:46:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:39 INFO - '_': '/tools/buildbot/bin/python'} 11:46:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:46:39 INFO - Cleaning up... 11:46:39 INFO - Return code: 0 11:46:39 INFO - Running post-action listener: _resource_record_post_action 11:46:39 INFO - Running post-action listener: _start_resource_monitoring 11:46:39 INFO - Starting resource monitoring. 11:46:39 INFO - [mozharness: 2017-08-04 18:46:39.811991Z] Finished create-virtualenv step (success) 11:46:39 INFO - [mozharness: 2017-08-04 18:46:39.812936Z] Running install step. 11:46:39 INFO - Running pre-action listener: _resource_record_pre_action 11:46:39 INFO - Running main action method: install 11:46:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:40 INFO - Reading from file tmpfile_stdout 11:46:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:46:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:46:40 INFO - Reading from file tmpfile_stdout 11:46:40 INFO - Output received: 11:46:40 INFO - Usage: mozinstall [options] installer 11:46:40 INFO - Options: 11:46:40 INFO - -h, --help show this help message and exit 11:46:40 INFO - -d DEST, --destination=DEST 11:46:40 INFO - Directory to install application into. [default: 11:46:40 INFO - "/builds/slave/test"] 11:46:40 INFO - --app=APP Application being installed. [default: firefox] 11:46:40 INFO - mkdir: /builds/slave/test/build/application 11:46:40 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:46:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:46:57 INFO - Reading from file tmpfile_stdout 11:46:57 INFO - Output received: 11:46:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:46:57 INFO - Running post-action listener: _resource_record_post_action 11:46:57 INFO - [mozharness: 2017-08-04 18:46:57.980103Z] Finished install step (success) 11:46:57 INFO - [mozharness: 2017-08-04 18:46:57.980384Z] Running setup-mitmproxy step. 11:46:57 INFO - Running pre-action listener: _resource_record_pre_action 11:46:57 INFO - Running main action method: setup_mitmproxy 11:46:57 INFO - Skipping: mitmproxy is not required 11:46:57 INFO - Running post-action listener: _resource_record_post_action 11:46:57 INFO - [mozharness: 2017-08-04 18:46:57.981569Z] Finished setup-mitmproxy step (success) 11:46:57 INFO - [mozharness: 2017-08-04 18:46:57.981791Z] Running run-tests step. 11:46:57 INFO - Running pre-action listener: _resource_record_pre_action 11:46:57 INFO - Running pre-action listener: _set_gcov_prefix 11:46:57 INFO - Running main action method: run_tests 11:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:46:57 INFO - Python 2.7.3 11:46:57 INFO - Return code: 0 11:46:57 INFO - grabbing minidump binary from tooltool 11:46: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:46:57 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 0x11ddeb0>, '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 0x11dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11df240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:46:57 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:46:57 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:46:57 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:46:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:46:58 INFO - Return code: 0 11:46:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:46:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:46:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:46:58 INFO - ENV: RUST_BACKTRACE is now 1 11:46:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:46:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:46:58 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/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:46:58 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/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --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:46:58 INFO - Using env: {'DISPLAY': ':0', 11:46:58 INFO - 'HOME': '/home/cltbld', 11:46:58 INFO - 'LANG': 'en_US.UTF-8', 11:46:58 INFO - 'LANGUAGE': 'en_US:en', 11:46:58 INFO - 'LOGNAME': 'cltbld', 11:46:58 INFO - 'MAIL': '/var/mail/cltbld', 11:46:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:46:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:58 INFO - 'MOZ_NO_REMOTE': '1', 11:46:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:58 INFO - 'NO_EM_RESTART': '1', 11:46:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:58 INFO - 'PWD': '/builds/slave/test', 11:46:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:46:58 INFO - 'RUST_BACKTRACE': '1', 11:46:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:46:58 INFO - 'SHELL': '/bin/bash', 11:46:58 INFO - 'SHLVL': '1', 11:46:58 INFO - 'TERM': 'linux', 11:46:58 INFO - 'TMOUT': '86400', 11:46:58 INFO - 'USER': 'cltbld', 11:46:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196', 11:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:58 INFO - '_': '/tools/buildbot/bin/python'} 11:46:58 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/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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:46:58 INFO - mozversion application_buildid: 20170804172933 11:46:58 INFO - mozversion application_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:46:58 INFO - mozversion application_display_name: Nightly 11:46:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:46:58 INFO - mozversion application_name: Firefox 11:46:58 INFO - mozversion application_remotingname: firefox 11:46:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:46:58 INFO - mozversion application_vendor: Mozilla 11:46:58 INFO - mozversion application_version: 57.0a1 11:46:58 INFO - mozversion platform_buildid: 20170804172933 11:46:58 INFO - mozversion platform_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:46:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:46:58 INFO - mozversion platform_version: 57.0a1 11:46:58 INFO - using testdate: 1501872418 11:46:58 INFO - actual date: 1501872418 11:46:58 INFO - starting webserver on 'localhost:46596' 11:46:58 INFO - SUITE-START | Running 2 tests 11:46:58 INFO - TEST-START | dromaeo_css 11:46:58 INFO - Initialising browser for dromaeo_css test... 11:46:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html -profile /tmp/tmp7cnOv6/profile 11:46:58 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html) 11:47:05 INFO - TEST-INFO | 3313: exit 0 11:47:05 INFO - Browser initialized. 11:47:05 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:05 INFO - TEST-INFO | started process 3525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7cnOv6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:06 INFO - PID 3525 | 11:47:06 INFO - PID 3525 | (/builds/slave/test/build/application/firefox/firefox:3575): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:47:06 INFO - PID 3525 | 11:47:17 INFO - PID 3525 | RSS: Main: 164700160 11:47:17 INFO - PID 3525 | 11:50:14 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46596/tests/dromaeo/cssquery-ext.html) 11:50:16 INFO - PID 3525 | RSS: Main: 167456768 11:50:16 INFO - PID 3525 | 11:53:18 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-ext.html (next: http://localhost:46596/tests/dromaeo/cssquery-jquery.html) 11:53:19 INFO - PID 3525 | RSS: Main: 164593664 11:53:19 INFO - PID 3525 | 11:56:20 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46596/tests/dromaeo/cssquery-mootools.html) 11:56:21 INFO - PID 3525 | RSS: Main: 166764544 11:56:21 INFO - PID 3525 | 11:59:23 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46596/tests/dromaeo/cssquery-prototype.html) 11:59:23 INFO - PID 3525 | RSS: Main: 164982784 11:59:23 INFO - PID 3525 | 12:02:26 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46596/tests/dromaeo/cssquery-yui.html) 12:02:27 INFO - PID 3525 | RSS: Main: 168464384 12:02:27 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | Cycle 1(1): loaded http://localhost:46596/tests/dromaeo/cssquery-yui.html (next: http://localhost:46596/tests/dromaeo/cssquery-dojo.html) 12:05:29 INFO - PID 3525 | RSS: Main: 169537536 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | __start_tp_report 12:05:29 INFO - PID 3525 | _x_x_mozilla_page_load 12:05:29 INFO - PID 3525 | _x_x_mozilla_page_load_details 12:05:29 INFO - PID 3525 | |i|pagename|runs| 12:05:29 INFO - PID 3525 | |0;dojo.html;3383.4079036168678;3431.3137372525493;3449.6205417404067;3451.4477683570635;3467.739919506037;6186.628802271867;6194.132821405007;6194.194754681891;6238.376162383759;6251.062340648905;6071.514278857692;6130.662813545253;6131.908021379683;6168.4448399644025;6168.62988220707;5417.59368047396;5428.212909128184;5457.099578569531;5466.207399927008;5561.304836895388;5538.723063846812;5570.832875013756;5575.581831362664;5593.608447408683;5612.607117501777;5299.947000529984;5476.863078423032;5532.695701736403;5547.140193270049;5557.027520183972;5394.433584473652;5435.2934118564335;5467.562594992431;5508.55931525477;5522.834314970557;5431.755570999315;5459.808906688287;5484.780608775644;5503.091989821674;5506.944930550683;6027.698615069273;6089.756409743605;6116.204893363879;6127.448529632355;6186.041163619646;6677.031830384615;6699.229588597276;6702.497312701518;6709.5303328767;6725.865482690368;6746.257911629717;6798.354156355138;6820.079289295931;6843.828904277383;6856.485763567753;6223.968880155616;6253.187085678833;6286.402791734778;6317.178766760338;6325.746970121189;6762.985552167214;6767.120274364301;6799.660016999131;6814.488913331421;6825.5222134451105;6558.409743123047;6562.114114594564;6604.96697516519;6640.667966601651;6647.4349680276755;6698.665066746643;6722.462203023746;6742.258351581322;6789.898151527731;6804.795856124324;6486.610803351814;6596.0105984102765;6598.86802263952;6671.166104236971;6712.630805305755;6538.346165383424;6610.0745895574655;6614.735410583523;6627.1716035495565;6641.933580664228;4854.732241309604;4918.975405123023;4929.2359684248995;4934.679245849008;4938.234573641092;4174.895627609334;4281.7002809803635;4322.135572885435;4338.8047537860875;4353.542877997828;6442.130312407859;6469.870602587922;6471;6492.350764923564;6496.123023391876;6546.869062618721;6617.86764264712;6641.335866413417;6727.764528241488;6805.353491418307;6312.905306420407;6344.460720838781;6374.266959299647;6430.7749228776765;6454.935450645434;5504.2018907258225;5520.392756796749;5540.279763630702;5543.750531226105;5544.473275038865;7125.786226413215;7185.856282874418;7212.891806622905;7213.3868621167785;7217.133943926658;6696.363845434676;6699.129113215446;6712.2616512184595;6774.356436138559;6783.660816959034;6937.236903940461;7019.333163349678;7023.508354415142;7045.2954704531185;7094.751683691046;6521.608703477807;6522.543421960418;6524.282328943717;6525.249596296487;6531.902021469777;6634.237062737847;6648.335166483506;6656.23453302857;6683.43190828785;6693.196816382066;6440.484761218998;6473.255575608865;6473.579217350857;6479.384458476437;6486.805395838132;5812.505936995402;6401.583897046677;6454.19322584677;6464.256610489666;6601.141851559267;6495.512836537373;6496.058071579689;6578.572392794453;6579.243387010555;6589.934100659124;6428.292887782433;6477.611343319416;6493.188351456068;6523.054157147092;6609.768658096944;6294;6362.109304697438;6363.649999250086;6364.459020983269;6368.745250190126 12:05:29 INFO - PID 3525 | |1;ext.html;843.4250966032373;890.2521881619439;932.2868005975428;950.1828427552308;956.8086382723457;42204.577954220484;43038.784806075964;43154.56845431545;43164;43212.351814722766;39739.40390894132;40119;40178.39732404016;40308.59691403085;40336.39495407571;6421.229452465699;6536.444402225817;6543.443807276387;6549.901751473732;6554.639494827783;6568.3103274156;6647.700853461606;6655.800325990203;6659.933400666004;6662.100616416795;6666.600003999752;6693.866122677544;7247.166575843793;7395.186529481753;7406.259374062604;7319;7361.374283185909;7372.3364897159245;7390.224026477196;7391.371733402613;7066.152061752623;7240.167380751228;7252.311030452099;7306.488545801796;7307.817304567375;40489.39265911013;40750.79624601888;40840.183196336206;40863.38704919429;40889.59110408917;3505.94741078884;3566.0906468850535;3573.6605022522817;3574.195805943642;3579.0157706630625;32252.677473225438;32300.515492267634;32442.83778581092;32478.837605812056;32588.67411325904;5030.094582975063;5085.059264036166;5102.336696229467;5103.897922041576;5104.9744751276;217755;217907;218516.9074154635;218634;218669;51761;51895.48104518982;51960.74019629878;52028;52162.21756673653;54030.7298463513;54112;54122;54172.729136354064;54358;16517.174141292886;16788.6642267154;16794.496165115066;16800.0759958201;16810.159492025596;13532.255725935169;13624;13631.86368136306;13636.863631363758;13638.727225455634;15065.774013389808;15140.545783626509;15202.923985380003;15269.618259543378;15342;5899.764009439575;6067.150598916155;6099.756009759649;6132.386761323921;6150.907736383958;1097.286763603664;1110.0786347331696;1110.6612483192541;1116.0903863351343;1122.0911062039775;25239.495210095694;25387.238382848544;25463.61804572933;25503;25610.231693048867;1205.2708111592535;1208.2750349790056;1216.738401243737;1217.945192466341;1219.7438537906962;13165.934170329087;13194.472221111047;13236;13346.46614135443;13349.199048057148;285237;288779;288983;289475;290603;52795;54286.72856635691;57897;58930.41069589249;59219.703901480214;1515.143943671844;1520.597041783928;1523.404764755177;1536.0937047142015;1541.3757428241356;30425;30543;30578;31126.68873311238;31513.684863151077;54813.725931370085;55499;55513.722431387585;55526.44473555374;55529;236238;238573;238952;239203;239942;38000.23999520049;38284.617153828105;38570.6142938567;38570.6142938567;38572.80713596414;46315.073698525164;46395;46633;46686.76656616831;47171;34794.478082828275;35097;35151.64848351484;35179.29641407209;35640.28719425649;33861.492077618364;34274.657253428144;34394.31211375808;34499;35190.472142917366;38874;39061.609383906936;39247.2150556993;39286.41070384004;39743.40384894171;33624.66375336313;33829;33832.66167338295;34348;34405;25549.87225063863;26363.736362636897;26437.86781066159;26555.867220663775;27044 12:05:29 INFO - PID 3525 | |2;jquery.html;553.6014069869692;554.7337278106511;568.8776912963712;576.1185386358873;586.5278450847069;22577.209797657084;23279.534409311804;23569.05723771049;23602.819859007024;23631.5273694526;26941.86529067352;27379.31551711203;27559.862200688967;27564.724352756468;27592.86203568979;6361.554691171608;6498.70755815987;6500.089987401768;6506.056621789838;6508.967455162718;5715.9428405716035;5996.97001514994;6185.752569897221;6422.197225346832;6476.514261430388;6136.048912418582;6143;6152.600080994744;6164.938350616504;6165.845853853667;6133.539984501158;6158.5381096417495;6160.075988601723;6161.722722477454;6165.414285642834;5708.942910570882;5735.1684005818925;5736.311642602873;5741.856453588652;5742.0238559445;30163.3410162441;31119.844400778078;31644.841775791203;32204.355912881845;32518.674813252037;2236.1837929155904;2260.400993736661;2269.137727663494;2269.965950510727;2272.261515007629;20281;20928.162873485042;20947.68578471324;20979.475513112142;20979.580408391746;2177.618916689573;2244.3154837774473;2248.730152381708;2315.2591170825176;2422.8061755059553;157272.21363893108;161017;161155;161171;161294;15284.312205950759;15828.52514424569;15863.920680396524;16116.75824862628;16566.76348692935;24051.879740601536;24477.51044979126;24515.87742061314;24522.754772452405;24528;10702.571897124184;10802.837957430645;10900.34597924127;10904.50929708165;11109.000569846257;10157.441340726184;10213.182945364353;10220.284580079324;10260.897391025994;10496.790064198673;9392.718218453458;9773.31586788918;9851.901480985242;9989.350692204984;10006.649767258112;2566.384067823709;2577.7164511903675;2676.34429564754;2680.9463810724064;2716.7231401241384;1017.1303535477208;1042.7132538551807;1058.3544038136731;1059.6238335390826;1066.6000249906285;21828.23601173983;21996.89001555014;22175;22308;22334.88832555827;1126.594426006637;1134.5235001299475;1135.0408904475705;1135.437958210691;1136.3068528197794;12240.326782026896;14537;15544.611384715472;15635.322176650854;16033.43882964114;632464;639381;641987;665989;666117;130000.34999824941;132860.33569832088;140277;140812;143267;1302.6808431934237;1317.571789168505;1341.8926485881302;1351.6350585341902;1352.6077437543001;23128.84355782238;23754.168604098773;23869.16457924034;23935;24122.75877241275;67524.6623766878;68570;68573.3142668587;69320;69802.65098674475;80083;80378.5981070091;80512.59743701245;81275;81608.59195703984;13240.86759132435;13904.721905562035;15280.77078843796;15500.379984800482;15679.372825086868;24544.877275613508;25388.365290867878;25867.22398328053;25907.093251736853;25988.74011259939;20084.497887552927;20205;20294.59410811746;20453.897730511253;20501.07745151442;17669.293228270726;18808.52978675544;18931;18968;19232;21347.25284615031;21457.570848583255;21643.35069947904;21789.673154903005;22007.889960550096;15217.77173342423;15356.616084597528;15467;15646.765298520304;15729.213539323217;20505.38483845487;20720.689189661865;20731.4817129573;20805.479863003548;20818.68771968452 12:05:29 INFO - PID 3525 | |3;mootools.html;1401.6005438450043;1440.2510694438893;1442.502336693841;1464.7436698577746;1473.3811799044406;15181.772273415907;15894.841051589481;15959.361625534964;15965.281562329694;16007.67984640308;15854.762178567331;16203.432879849208;16263.593410164753;16264.918675406607;16271.349146034145;2776.4030733392265;2805.424887897976;2825.9152225433168;2829.066408085337;2832.22113918673;2705.6753189617275;2708.8103832731717;2719.4697034078363;2784.916452506418;2786.5680819472914;2776.597393377959;2794.7903907206937;2797.580362945554;2798.720127987195;2799.0902956539207;2654.5089158505643;2676.611891275764;2688.7445692659167;2701.7433343832304;2702.2568793581727;2647.6293318935363;2648.2717252755456;2669.733026697315;2676.157010541673;2686.865656717176;14473.855261447461;14529;14563.271836408243;14585.197814120325;14616.049956752777;7638.770836874903;7837.960810195969;8030.277275045274;8100.554469504175;8128.187181281884;5354.330708661418;5473.151661492475;5560;5600.915986260209;5624.21261023457;1833.2483681690576;1866.990665046666;1873.5128866494674;1901.5341241395947;1910.6656335141433;26730.331741706417;26919.461610767674;26928.596071058753;26929.384236945847;26936.73063269362;7081.858362832714;7136.821579460451;7213.350798428167;7308.1230252369;7354.338109570164;18296.908515457602;18461.446156615322;18466.169022394024;18478.353257635918;18496.537586560444;7717.073951125901;7847.6468558914985;7937.642806073625;7964.123946365895;8019.558924259105;7281.890771638429;7494.21310762373;7496.0255166827965;7501.887471687929;7507.099148102263;5054.69671819692;5446.264754258124;5566.610337276433;5622.943770562242;5658.151277308437;1548.2413617327654;1565.585119943216;1639.065732532469;1642.4005238088012;1659.468969929611;928.3547934185676;955.2739917662626;956.9808603827885;958.4153666263713;969.060011788564;8046.1551537088935;8079.111297757242;8161.918380816116;8207.7948051298;8223.753287401387;1017.5929628148651;1035.8756949166147;1040.3757745352727;1044.1072882685346;1045.6653870761436;4891.6575839691595;4902.28916807061;4982.177940639754;4990.750462476862;5015.272785446163;21925.23261685865;22005.449863753533;22162.88918555397;22179;22254.109835606396;21598.56802863934;21708.131674732835;21909.12363505442;21920.89039554824;21956.23153189631;12026.939865300617;12339.568115115928;12342;12484.188527745486;12486.625401237978;9604.95197524008;9684.41893486393;9686.031396860539;9752.756181095529;9842.360246583949;19043.42869713911;19370.322038728576;19453.805461945198;19494.902525487283;19535.609287814448;19348.8065119347;19560;19582;19595.31416400419;20038.298659546846;12984.935075324564;13104.606861794162;13220.537281195113;13255.270960097287;13289.468421263042;12640.747185056063;14536.709265814414;14785.704285914006;14803.259837008321;14815.85184148188;9609.423434593948;11387.886121139014;11487.138464615355;11799.76400472003;11987.100967427652;11607.419629018685;11663.941680291544;11684.88315116838;11801.704957376134;11837.348945808064;10295.330803497749;10563.313384629975;10571.5242814072;10575.101116405192;10577.100946419641;7344.596047217241;7508.962455187689;7579;7613.390928725578;7988.880166797387;7609.315161635479;7798.181190975093;7908.960455197687;8144.1448647893485;8270.421070525006 12:05:29 INFO - PID 3525 | |4;prototype.html;509.551594596755;511.1744532579883;539.487486887457;546.7430307755353;551.5201774456224;6144.385561443859;6195.628262304265;6229.501639868811;6234.158388617535;6269.655168965716;6098.237720284965;6141;6152.81541553753;6167.7841275555365;6176.598521096125;4924.187509061001;4933.802647894098;4937.382827146597;4959.305697202377;4973.776180071887;4653.162430762462;4813.253945638414;4884.804607815701;4918.336024636664;4920.8031678732805;4759.833405830796;4762;4763.689985254048;4773.785179666906;4783.880402989918;4786.56920877121;4790.473047964721;4797.424309082898;4812.398450193726;4829.879253018667;4357.891052723676;4361.280388735855;4365.738055716635;4379.474463064421;4394.274944634131;5973.522118230575;6000.459958603747;6015.789447369365;6028.97507423739;6048.60684055535;5745;5751.367349591542;5755.740991655385;5784.13238014297;5800.433882851648;6490.156279683611;6524.608523488559;6550.312217217219;6559;6607;4947.257911313296;4952.158133117378;4954.628402869799;4955.281484184809;4958.652894297401;6640.203175618908;6668.83327916806;6795.932040679629;6844.589324640538;6864.906203607848;5387.488188622075;5419.918701219485;5427.317531565227;5440;5472.315960504937;5575.665460072409;5582.302212223472;5590.217369568264;5597.45315881273;5614.736684246093;5893.911591326134;5920.934231838224;5943.673097979653;5977.79077732286;5981.491573216325;6543.411093001652;6560.376764207393;6570.357410647338;6632.43624291931;6639.336066393322;1919.1767820570515;1921.7693876734602;1956.1197461142542;1956.227290220355;1960.6078784242923;1336.2583766009764;1389.589566589912;1390;1410.2243765928904;1416.6529200345776;6263.530235232376;6278.277998030194;6289.119523266746;6332.810015699536;6344.619322840552;6548.377904099103;6605.273419923805;6648.900266496006;6688.86622267552;6705.195376554844;6126.23422072241;6349.111124442582;6378.872422551616;6382.585131966407;6398.360163983658;3512.613612502623;3518.1556426457464;3527.3421491898766;3553.857845686195;3554.804485753308;6825.965870170717;7044.542104763174;7050.15398152225;7069.505134640526;7091.858162836715;6833.487488438387;6853.280405557444;6855.828604284933;6898.448124150156;6912.239653638096;7136.857262854714;7172.103487064117;7173.784786456415;7182.168547020477;7219.819504512324;6462.578232788779;6569.770058047945;6682.899756503753;6709.4632429404555;6727.629980351127;6564.146660934048;6584.242812076481;6592.307807680317;6609.966950165219;6646.83382915431;7088.184858741311;7097.7160913562875;7109;7129.108861392326;7140;5449.700266485382;5465.9726701366235;5473.917891231555;5493.587980901369;5523.25436066142;6389.297177310399;6407.903881441689;6617.702203400955;6651.068850360856;6667.566608170453;6380.298167201511;6435.935640643721;6472.5145614080075;6478.935210647834;6488.675566221765;6358.523110766619;6392.520560957853;6418.614883107029;6456.741730330734;6518.902216466851;6470.255920569195;6478.6760661967655;6481.967590162019;6512.3162067982175;6529.738810447719;6491.350864913471;6492.48060155177;6524.368907773057;6589.835254118685;6610.10763546915;6275.086098739928;6275.560710750204;6302.716377763103;6330.430261276507;6356.459700925288 12:05:29 INFO - PID 3525 | |5;yui.html;908.7682640926563;924.2605915267789;937.7093101138644;942.8255772682054;943.9622415103388;18324;19325;19373.418797436083;19387.903060484714;19887.602247955034;18980.43058708241;18997.430077097673;19002.049897505105;19151.904240478812;19182.61634767304;1021.80074885397;1068.6687126990657;1069.6042464288225;1081.2593373539112;1110.211749657744;1088.3415533602176;1089.0634054712941;1094.874089479712;1095.3099547285199;1098.02824500317;1138.9544418223302;1142.8285757136455;1147.5409836065558;1153.284963322741;1155.537784886044;1131.553036550562;1135.659302209338;1135.9091272698206;1140.7661429407035;1148.5405837664916;836.7657056024323;837.660747397305;839.4501601450999;845.9957700211521;846.2003406780594;19508.414747557596;20077;20202.79797202024;20236.797632023638;20408.897955510274;21339;21343.466413339636;21374.251901183383;21704.891475542678;21745.456363590878;15805.683886322324;15888.205589720583;16002.119883406407;16132.677346453005;16268.918655406766;3667.8166091695307;3676.9080772980888;3690.5940346561856;3699.408094704834;3700.518932538753;136674;138344;138434.30782846123;138739;142399.99999999895;16643.916780416264;16793.580160496087;17013.48959531216;17092.145392730316;17109.572260693334;31827.522587161213;32190.35619287601;32817.17957051045;32957.835210823796;33095.834520827244;9118.452892826452;9158.95420522893;9305.441673499612;9384.62461501546;9402.858957115648;3985.362342025262;4116.1767646470225;4186.665066794649;4248.915021699549;4278.786060697015;5575.832725018256;5712.228849105318;5733.971330143323;5745.1382292656435;5753.223314852441;1167.9591214307459;1184.6090790039266;1190.8511436070492;1192.7316353820495;1193.7015746063485;678.7149397253165;694.3611877073004;696.0047132600329;706.4454403293493;717.447565374669;12753.790959577971;13339.266340351374;14072.718545629235;14522.273886305642;14832.92583537097;734.2217249715319;734.4821900560092;740.5852722475431;743.0303453992484;745.1914672580311;6144.201253836973;6343.524235682342;6376.39424254695;6454.612723236621;6780.38976492118;120882.39558802325;122945;124475;126693;128212;108317;112313;112729;113924;115982;94921.5253923726;102056;103551.4822425868;103606;103895.4805225969;13754.243516606282;14347.497837575635;14455.421783128557;14538.563843084725;14587.635309117357;46878.29682554833;47045.29432058454;47495;47678;48062.5193748058;59434.70282648732;60717.392826072944;61416;62927.37072629398;75762;18873.811261887753;19100.617987640446;19115.522111947314;19328.71006934869;19357.70963435578;19834.801651983296;20306.898465507576;21647.13411463524;22234.77765222392;23014.42463938415;18262.36081737133;18451.630967380308;18580.44258672242;20496.48758780983;21741.347759567238;20031.799682002995;20795.480112997295;20900.268490602757;20935.790642093383;21811.454713632287;19062;20396.694049588972;20605.38183854487;20607.381778546667;20752.169913203303;13357;13963.720725585228;14290.285485725464;14404.783928241295;14624.415023398944;14780.48268310604;15367;15495.767563486783;15807.209639518209;16062.759058613896 12:05:29 INFO - PID 3525 | __end_tp_report 12:05:29 INFO - PID 3525 | __start_cc_report 12:05:29 INFO - PID 3525 | _x_x_mozilla_cycle_collect,338 12:05:29 INFO - PID 3525 | __end_cc_report 12:05:29 INFO - PID 3525 | __startTimestamp1501873529464__endTimestamp 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | ------- Summary: start ------- 12:05:29 INFO - PID 3525 | Number of tests: 6 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#0] dojo.html Cycles:165 Average:6156.14 Median:6469.87 stddev:793.89 (12.3%) stddev-sans-first:765.94 12:05:29 INFO - PID 3525 | Values: 3383.4 3431.3 3449.6 3451.4 3467.7 6186.6 6194.1 6194.2 6238.4 6251.1 6071.5 6130.7 6131.9 6168.4 6168.6 5417.6 5428.2 5457.1 5466.2 5561.3 5538.7 5570.8 5575.6 5593.6 5612.6 5299.9 5476.9 5532.7 5547.1 5557.0 5394.4 5435.3 5467.6 5508.6 5522.8 5431.8 5459.8 5484.8 5503.1 5506.9 6027.7 6089.8 6116.2 6127.4 6186.0 6677.0 6699.2 6702.5 6709.5 6725.9 6746.3 6798.4 6820.1 6843.8 6856.5 6224.0 6253.2 6286.4 6317.2 6325.7 6763.0 6767.1 6799.7 6814.5 6825.5 6558.4 6562.1 6605.0 6640.7 6647.4 6698.7 6722.5 6742.3 6789.9 6804.8 6486.6 6596.0 6598.9 6671.2 6712.6 6538.3 6610.1 6614.7 6627.2 6641.9 4854.7 4919.0 4929.2 4934.7 4938.2 4174.9 4281.7 4322.1 4338.8 4353.5 6442.1 6469.9 6471.0 6492.4 6496.1 6546.9 6617.9 6641.3 6727.8 6805.4 6312.9 6344.5 6374.3 6430.8 6454.9 5504.2 5520.4 5540.3 5543.8 5544.5 7125.8 7185.9 7212.9 7213.4 7217.1 6696.4 6699.1 6712.3 6774.4 6783.7 6937.2 7019.3 7023.5 7045.3 7094.8 6521.6 6522.5 6524.3 6525.2 6531.9 6634.2 6648.3 6656.2 6683.4 6693.2 6440.5 6473.3 6473.6 6479.4 6486.8 5812.5 6401.6 6454.2 6464.3 6601.1 6495.5 6496.1 6578.6 6579.2 6589.9 6428.3 6477.6 6493.2 6523.1 6609.8 6294.0 6362.1 6363.6 6364.5 6368.7 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#1] ext.html Cycles:180 Average:42877.90 Median:38142.43 stddev:65167.70 (170.9%) stddev-sans-first:65274.09 12:05:29 INFO - PID 3525 | Values: 843.4 890.3 932.3 950.2 956.8 42204.6 43038.8 43154.6 43164.0 43212.4 39739.4 40119.0 40178.4 40308.6 40336.4 6421.2 6536.4 6543.4 6549.9 6554.6 6568.3 6647.7 6655.8 6659.9 6662.1 6666.6 6693.9 7247.2 7395.2 7406.3 7319.0 7361.4 7372.3 7390.2 7391.4 7066.2 7240.2 7252.3 7306.5 7307.8 40489.4 40750.8 40840.2 40863.4 40889.6 3505.9 3566.1 3573.7 3574.2 3579.0 32252.7 32300.5 32442.8 32478.8 32588.7 5030.1 5085.1 5102.3 5103.9 5105.0 217755.0 217907.0 218516.9 218634.0 218669.0 51761.0 51895.5 51960.7 52028.0 52162.2 54030.7 54112.0 54122.0 54172.7 54358.0 16517.2 16788.7 16794.5 16800.1 16810.2 13532.3 13624.0 13631.9 13636.9 13638.7 15065.8 15140.5 15202.9 15269.6 15342.0 5899.8 6067.2 6099.8 6132.4 6150.9 1097.3 1110.1 1110.7 1116.1 1122.1 25239.5 25387.2 25463.6 25503.0 25610.2 1205.3 1208.3 1216.7 1217.9 1219.7 13165.9 13194.5 13236.0 13346.5 13349.2 285237.0 288779.0 288983.0 289475.0 290603.0 52795.0 54286.7 57897.0 58930.4 59219.7 1515.1 1520.6 1523.4 1536.1 1541.4 30425.0 30543.0 30578.0 31126.7 31513.7 54813.7 55499.0 55513.7 55526.4 55529.0 236238.0 238573.0 238952.0 239203.0 239942.0 38000.2 38284.6 38570.6 38570.6 38572.8 46315.1 46395.0 46633.0 46686.8 47171.0 34794.5 35097.0 35151.6 35179.3 35640.3 33861.5 34274.7 34394.3 34499.0 35190.5 38874.0 39061.6 39247.2 39286.4 39743.4 33624.7 33829.0 33832.7 34348.0 34405.0 25549.9 26363.7 26437.9 26555.9 27044.0 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#2] jquery.html Cycles:180 Average:41964.37 Median:12418.81 stddev:108608.92 (874.6%) stddev-sans-first:108869.09 12:05:29 INFO - PID 3525 | Values: 553.6 554.7 568.9 576.1 586.5 22577.2 23279.5 23569.1 23602.8 23631.5 26941.9 27379.3 27559.9 27564.7 27592.9 6361.6 6498.7 6500.1 6506.1 6509.0 5715.9 5997.0 6185.8 6422.2 6476.5 6136.0 6143.0 6152.6 6164.9 6165.8 6133.5 6158.5 6160.1 6161.7 6165.4 5708.9 5735.2 5736.3 5741.9 5742.0 30163.3 31119.8 31644.8 32204.4 32518.7 2236.2 2260.4 2269.1 2270.0 2272.3 20281.0 20928.2 20947.7 20979.5 20979.6 2177.6 2244.3 2248.7 2315.3 2422.8 157272.2 161017.0 161155.0 161171.0 161294.0 15284.3 15828.5 15863.9 16116.8 16566.8 24051.9 24477.5 24515.9 24522.8 24528.0 10702.6 10802.8 10900.3 10904.5 11109.0 10157.4 10213.2 10220.3 10260.9 10496.8 9392.7 9773.3 9851.9 9989.4 10006.6 2566.4 2577.7 2676.3 2680.9 2716.7 1017.1 1042.7 1058.4 1059.6 1066.6 21828.2 21996.9 22175.0 22308.0 22334.9 1126.6 1134.5 1135.0 1135.4 1136.3 12240.3 14537.0 15544.6 15635.3 16033.4 632464.0 639381.0 641987.0 665989.0 666117.0 130000.3 132860.3 140277.0 140812.0 143267.0 1302.7 1317.6 1341.9 1351.6 1352.6 23128.8 23754.2 23869.2 23935.0 24122.8 67524.7 68570.0 68573.3 69320.0 69802.7 80083.0 80378.6 80512.6 81275.0 81608.6 13240.9 13904.7 15280.8 15500.4 15679.4 24544.9 25388.4 25867.2 25907.1 25988.7 20084.5 20205.0 20294.6 20453.9 20501.1 17669.3 18808.5 18931.0 18968.0 19232.0 21347.3 21457.6 21643.4 21789.7 22007.9 15217.8 15356.6 15467.0 15646.8 15729.2 20505.4 20720.7 20731.5 20805.5 20818.7 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#3] mootools.html Cycles:180 Average:9683.28 Median:2651.39 stddev:6872.19 (259.2%) stddev-sans-first:6863.30 12:05:29 INFO - PID 3525 | Values: 1401.6 1440.3 1442.5 1464.7 1473.4 15181.8 15894.8 15959.4 15965.3 16007.7 15854.8 16203.4 16263.6 16264.9 16271.3 2776.4 2805.4 2825.9 2829.1 2832.2 2705.7 2708.8 2719.5 2784.9 2786.6 2776.6 2794.8 2797.6 2798.7 2799.1 2654.5 2676.6 2688.7 2701.7 2702.3 2647.6 2648.3 2669.7 2676.2 2686.9 14473.9 14529.0 14563.3 14585.2 14616.0 7638.8 7838.0 8030.3 8100.6 8128.2 5354.3 5473.2 5560.0 5600.9 5624.2 1833.2 1867.0 1873.5 1901.5 1910.7 26730.3 26919.5 26928.6 26929.4 26936.7 7081.9 7136.8 7213.4 7308.1 7354.3 18296.9 18461.4 18466.2 18478.4 18496.5 7717.1 7847.6 7937.6 7964.1 8019.6 7281.9 7494.2 7496.0 7501.9 7507.1 5054.7 5446.3 5566.6 5622.9 5658.2 1548.2 1565.6 1639.1 1642.4 1659.5 928.4 955.3 957.0 958.4 969.1 8046.2 8079.1 8161.9 8207.8 8223.8 1017.6 1035.9 1040.4 1044.1 1045.7 4891.7 4902.3 4982.2 4990.8 5015.3 21925.2 22005.4 22162.9 22179.0 22254.1 21598.6 21708.1 21909.1 21920.9 21956.2 12026.9 12339.6 12342.0 12484.2 12486.6 9605.0 9684.4 9686.0 9752.8 9842.4 19043.4 19370.3 19453.8 19494.9 19535.6 19348.8 19560.0 19582.0 19595.3 20038.3 12984.9 13104.6 13220.5 13255.3 13289.5 12640.7 14536.7 14785.7 14803.3 14815.9 9609.4 11387.9 11487.1 11799.8 11987.1 11607.4 11663.9 11684.9 11801.7 11837.3 10295.3 10563.3 10571.5 10575.1 10577.1 7344.6 7509.0 7579.0 7613.4 7988.9 7609.3 7798.2 7909.0 8144.1 8270.4 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#4] prototype.html Cycles:180 Average:5611.42 Median:6266.59 stddev:1556.53 (24.8%) stddev-sans-first:1513.06 12:05:29 INFO - PID 3525 | Values: 509.6 511.2 539.5 546.7 551.5 6144.4 6195.6 6229.5 6234.2 6269.7 6098.2 6141.0 6152.8 6167.8 6176.6 4924.2 4933.8 4937.4 4959.3 4973.8 4653.2 4813.3 4884.8 4918.3 4920.8 4759.8 4762.0 4763.7 4773.8 4783.9 4786.6 4790.5 4797.4 4812.4 4829.9 4357.9 4361.3 4365.7 4379.5 4394.3 5973.5 6000.5 6015.8 6029.0 6048.6 5745.0 5751.4 5755.7 5784.1 5800.4 6490.2 6524.6 6550.3 6559.0 6607.0 4947.3 4952.2 4954.6 4955.3 4958.7 6640.2 6668.8 6795.9 6844.6 6864.9 5387.5 5419.9 5427.3 5440.0 5472.3 5575.7 5582.3 5590.2 5597.5 5614.7 5893.9 5920.9 5943.7 5977.8 5981.5 6543.4 6560.4 6570.4 6632.4 6639.3 1919.2 1921.8 1956.1 1956.2 1960.6 1336.3 1389.6 1390.0 1410.2 1416.7 6263.5 6278.3 6289.1 6332.8 6344.6 6548.4 6605.3 6648.9 6688.9 6705.2 6126.2 6349.1 6378.9 6382.6 6398.4 3512.6 3518.2 3527.3 3553.9 3554.8 6826.0 7044.5 7050.2 7069.5 7091.9 6833.5 6853.3 6855.8 6898.4 6912.2 7136.9 7172.1 7173.8 7182.2 7219.8 6462.6 6569.8 6682.9 6709.5 6727.6 6564.1 6584.2 6592.3 6610.0 6646.8 7088.2 7097.7 7109.0 7129.1 7140.0 5449.7 5466.0 5473.9 5493.6 5523.3 6389.3 6407.9 6617.7 6651.1 6667.6 6380.3 6435.9 6472.5 6478.9 6488.7 6358.5 6392.5 6418.6 6456.7 6518.9 6470.3 6478.7 6482.0 6512.3 6529.7 6491.4 6492.5 6524.4 6589.8 6610.1 6275.1 6275.6 6302.7 6330.4 6356.5 12:05:29 INFO - PID 3525 | 12:05:29 INFO - PID 3525 | [#5] yui.html Cycles:180 Average:25887.66 Median:19380.66 stddev:36017.25 (185.8%) stddev-sans-first:36069.46 12:05:29 INFO - PID 3525 | Values: 908.8 924.3 937.7 942.8 944.0 18324.0 19325.0 19373.4 19387.9 19887.6 18980.4 18997.4 19002.0 19151.9 19182.6 1021.8 1068.7 1069.6 1081.3 1110.2 1088.3 1089.1 1094.9 1095.3 1098.0 1139.0 1142.8 1147.5 1153.3 1155.5 1131.6 1135.7 1135.9 1140.8 1148.5 836.8 837.7 839.5 846.0 846.2 19508.4 20077.0 20202.8 20236.8 20408.9 21339.0 21343.5 21374.3 21704.9 21745.5 15805.7 15888.2 16002.1 16132.7 16268.9 3667.8 3676.9 3690.6 3699.4 3700.5 136674.0 138344.0 138434.3 138739.0 142400.0 16643.9 16793.6 17013.5 17092.1 17109.6 31827.5 32190.4 32817.2 32957.8 33095.8 9118.5 9159.0 9305.4 9384.6 9402.9 3985.4 4116.2 4186.7 4248.9 4278.8 5575.8 5712.2 5734.0 5745.1 5753.2 1168.0 1184.6 1190.9 1192.7 1193.7 678.7 694.4 696.0 706.4 717.4 12753.8 13339.3 14072.7 14522.3 14832.9 734.2 734.5 740.6 743.0 745.2 6144.2 6343.5 6376.4 6454.6 6780.4 120882.4 122945.0 124475.0 126693.0 128212.0 108317.0 112313.0 112729.0 113924.0 115982.0 94921.5 102056.0 103551.5 103606.0 103895.5 13754.2 14347.5 14455.4 14538.6 14587.6 46878.3 47045.3 47495.0 47678.0 48062.5 59434.7 60717.4 61416.0 62927.4 75762.0 18873.8 19100.6 19115.5 19328.7 19357.7 19834.8 20306.9 21647.1 22234.8 23014.4 18262.4 18451.6 18580.4 20496.5 21741.3 20031.8 20795.5 20900.3 20935.8 21811.5 19062.0 20396.7 20605.4 20607.4 20752.2 13357.0 13963.7 14290.3 14404.8 14624.4 14780.5 15367.0 15495.8 15807.2 16062.8 12:05:29 INFO - PID 3525 | -------- Summary: end -------- 12:05:29 INFO - PID 3525 | 12:05:30 INFO - TEST-INFO | 3525: exit 0 12:05:30 INFO - TEST-OK | dromaeo_css | took 1111704ms 12:05:30 INFO - TEST-START | kraken 12:05:30 INFO - Initialising browser for kraken test... 12:05:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html -profile /tmp/tmpM1mwXX/profile 12:05:30 INFO - TEST-INFO | started process 3886 (/builds/slave/test/build/application/firefox/firefox http://localhost:46596/getInfo.html) 12:05:35 INFO - TEST-INFO | 3886: exit 0 12:05:35 INFO - Browser initialized. 12:05:35 INFO - Running cycle 1/1 for kraken test... 12:05:35 INFO - TEST-INFO | started process 4095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM1mwXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:05:36 INFO - PID 4095 | 12:05:36 INFO - PID 4095 | (/builds/slave/test/build/application/firefox/firefox:4144): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:05:36 INFO - PID 4095 | 12:05:47 INFO - PID 4095 | RSS: Main: 164339712 12:05:47 INFO - PID 4095 | 12:05:49 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-beat-detection) 12:05:50 INFO - PID 4095 | RSS: Main: 170340352 12:05:50 INFO - PID 4095 | 12:05:53 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-dft) 12:05:53 INFO - PID 4095 | RSS: Main: 170803200 12:05:53 INFO - PID 4095 | 12:05:56 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-fft) 12:05:57 INFO - PID 4095 | RSS: Main: 164458496 12:05:57 INFO - PID 4095 | 12:05:59 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46596/tests/kraken/driver.html?testName=audio-oscillator) 12:06:00 INFO - PID 4095 | RSS: Main: 165793792 12:06:00 INFO - PID 4095 | 12:06:02 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:02 INFO - PID 4095 | RSS: Main: 165691392 12:06:02 INFO - PID 4095 | 12:06:05 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:06 INFO - PID 4095 | RSS: Main: 168558592 12:06:06 INFO - PID 4095 | 12:06:09 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46596/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:10 INFO - PID 4095 | RSS: Main: 170749952 12:06:10 INFO - PID 4095 | 12:06:13 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46596/tests/kraken/driver.html?testName=json-parse-financial) 12:06:13 INFO - PID 4095 | RSS: Main: 169193472 12:06:13 INFO - PID 4095 | 12:06:15 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:15 INFO - PID 4095 | RSS: Main: 168685568 12:06:15 INFO - PID 4095 | 12:06:17 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:18 INFO - PID 4095 | RSS: Main: 168525824 12:06:18 INFO - PID 4095 | 12:06:20 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:06:20 INFO - PID 4095 | RSS: Main: 165453824 12:06:20 INFO - PID 4095 | 12:06:23 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:06:24 INFO - PID 4095 | RSS: Main: 165928960 12:06:24 INFO - PID 4095 | 12:06:27 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:06:27 INFO - PID 4095 | RSS: Main: 166400000 12:06:27 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | Cycle 1(1): loaded http://localhost:46596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46596/tests/kraken/driver.html?testName=ai-astar) 12:06:29 INFO - PID 4095 | RSS: Main: 167993344 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | __start_tp_report 12:06:29 INFO - PID 4095 | _x_x_mozilla_page_load 12:06:29 INFO - PID 4095 | _x_x_mozilla_page_load_details 12:06:29 INFO - PID 4095 | |i|pagename|runs| 12:06:29 INFO - PID 4095 | |0;ai-astar;98;107;98;106;106;106;111;98;105;107 12:06:29 INFO - PID 4095 | |1;audio-beat-detection;142;112;146;171;115;140;143;118;167;112 12:06:29 INFO - PID 4095 | |2;audio-dft;163;162;162;164;161;161;162;162;165;167 12:06:29 INFO - PID 4095 | |3;audio-fft;75;75;74;166;75;75;74;73;156;76 12:06:29 INFO - PID 4095 | |4;audio-oscillator;77;77;127;78;77;78;133;79;77;126 12:06:29 INFO - PID 4095 | |5;imaging-gaussian-blur;113;113;113;116;117;114;114;114;114;113 12:06:29 INFO - PID 4095 | |6;imaging-darkroom;150;150;148;148;148;147;148;149;148;149 12:06:29 INFO - PID 4095 | |7;imaging-desaturate;95;98;94;94;94;94;94;94;94;94 12:06:29 INFO - PID 4095 | |8;json-parse-financial;47;49;46;46;46;48;46;47;47;47 12:06:29 INFO - PID 4095 | |9;json-stringify-tinderbox;56;56;55;56;56;56;56;56;56;56 12:06:29 INFO - PID 4095 | |10;stanford-crypto-aes;77;76;77;76;75;75;81;75;76;75 12:06:29 INFO - PID 4095 | |11;stanford-crypto-ccm;121;122;121;115;118;115;124;122;114;160 12:06:29 INFO - PID 4095 | |12;stanford-crypto-pbkdf2;174;162;166;163;181;165;165;173;166;163 12:06:29 INFO - PID 4095 | |13;stanford-crypto-sha256-iterative;65;63;61;66;61;60;62;62;61;60 12:06:29 INFO - PID 4095 | __end_tp_report 12:06:29 INFO - PID 4095 | __start_cc_report 12:06:29 INFO - PID 4095 | _x_x_mozilla_cycle_collect,841 12:06:29 INFO - PID 4095 | __end_cc_report 12:06:29 INFO - PID 4095 | __startTimestamp1501873589694__endTimestamp 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | ------- Summary: start ------- 12:06:29 INFO - PID 4095 | Number of tests: 14 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#0] ai-astar Cycles:10 Average:104.20 Median:109.00 stddev:4.57 (4.2%) stddev-sans-first:4.26 12:06:29 INFO - PID 4095 | Values: 98.0 107.0 98.0 106.0 106.0 106.0 111.0 98.0 105.0 107.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:142.50 stddev:21.86 (15.3%) stddev-sans-first:23.10 12:06:29 INFO - PID 4095 | Values: 142.0 112.0 146.0 171.0 115.0 140.0 143.0 118.0 167.0 112.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:1.91 (1.2%) stddev-sans-first:2.03 12:06:29 INFO - PID 4095 | Values: 163.0 162.0 162.0 164.0 161.0 161.0 162.0 162.0 165.0 167.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#3] audio-fft Cycles:10 Average:91.90 Median:75.00 stddev:36.50 (48.7%) stddev-sans-first:38.20 12:06:29 INFO - PID 4095 | Values: 75.0 75.0 74.0 166.0 75.0 75.0 74.0 73.0 156.0 76.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:77.00 stddev:24.75 (32.1%) stddev-sans-first:25.58 12:06:29 INFO - PID 4095 | Values: 77.0 77.0 127.0 78.0 77.0 78.0 133.0 79.0 77.0 126.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.37 (1.2%) stddev-sans-first:1.39 12:06:29 INFO - PID 4095 | Values: 113.0 113.0 113.0 116.0 117.0 114.0 114.0 114.0 114.0 113.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 12:06:29 INFO - PID 4095 | Values: 150.0 150.0 148.0 148.0 148.0 147.0 148.0 149.0 148.0 149.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.27 (1.4%) stddev-sans-first:1.33 12:06:29 INFO - PID 4095 | Values: 95.0 98.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:0.99 (2.1%) stddev-sans-first:1.05 12:06:29 INFO - PID 4095 | Values: 47.0 49.0 46.0 46.0 46.0 48.0 46.0 47.0 47.0 47.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 12:06:29 INFO - PID 4095 | Values: 56.0 56.0 55.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:76.00 stddev:1.83 (2.4%) stddev-sans-first:1.92 12:06:29 INFO - PID 4095 | Values: 77.0 76.0 77.0 76.0 75.0 75.0 81.0 75.0 76.0 75.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:121.50 stddev:13.39 (11.0%) stddev-sans-first:14.18 12:06:29 INFO - PID 4095 | Values: 121.0 122.0 121.0 115.0 118.0 115.0 124.0 122.0 114.0 160.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:166.00 stddev:6.16 (3.7%) stddev-sans-first:6.11 12:06:29 INFO - PID 4095 | Values: 174.0 162.0 166.0 163.0 181.0 165.0 165.0 173.0 166.0 163.0 12:06:29 INFO - PID 4095 | 12:06:29 INFO - PID 4095 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.02 (3.3%) stddev-sans-first:1.86 12:06:29 INFO - PID 4095 | Values: 65.0 63.0 61.0 66.0 61.0 60.0 62.0 62.0 61.0 60.0 12:06:29 INFO - PID 4095 | -------- Summary: end -------- 12:06:29 INFO - PID 4095 | 12:06:30 INFO - PID 4095 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:06:30 INFO - TEST-INFO | 4095: exit 0 12:06:30 INFO - TEST-OK | kraken | took 60147ms 12:06:30 INFO - SUITE-END | took 1171s 12:06:30 INFO - Completed test suite (00:19:31) 12:06:30 INFO - javascript benchmark 12:06:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8930.555123711112, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.4079036168678, 3431.3137372525493, 3449.6205417404067, 3451.4477683570635, 3467.739919506037, 6186.628802271867, 6194.132821405007, 6194.194754681891, 6238.376162383759, 6251.062340648905, 6071.514278857692, 6130.662813545253, 6131.908021379683, 6168.4448399644025, 6168.62988220707, 5417.59368047396, 5428.212909128184, 5457.099578569531, 5466.207399927008, 5561.304836895388, 5538.723063846812, 5570.832875013756, 5575.581831362664, 5593.608447408683, 5612.607117501777, 5299.947000529984, 5476.863078423032, 5532.695701736403, 5547.140193270049, 5557.027520183972, 5394.433584473652, 5435.2934118564335, 5467.562594992431, 5508.55931525477, 5522.834314970557, 5431.755570999315, 5459.808906688287, 5484.780608775644, 5503.091989821674, 5506.944930550683, 6027.698615069273, 6089.756409743605, 6116.204893363879, 6127.448529632355, 6186.041163619646, 6677.031830384615, 6699.229588597276, 6702.497312701518, 6709.5303328767, 6725.865482690368, 6746.257911629717, 6798.354156355138, 6820.079289295931, 6843.828904277383, 6856.485763567753, 6223.968880155616, 6253.187085678833, 6286.402791734778, 6317.178766760338, 6325.746970121189, 6762.985552167214, 6767.120274364301, 6799.660016999131, 6814.488913331421, 6825.5222134451105, 6558.409743123047, 6562.114114594564, 6604.96697516519, 6640.667966601651, 6647.4349680276755, 6698.665066746643, 6722.462203023746, 6742.258351581322, 6789.898151527731, 6804.795856124324, 6486.610803351814, 6596.0105984102765, 6598.86802263952, 6671.166104236971, 6712.630805305755, 6538.346165383424, 6610.0745895574655, 6614.735410583523, 6627.1716035495565, 6641.933580664228, 4854.732241309604, 4918.975405123023, 4929.2359684248995, 4934.679245849008, 4938.234573641092, 4174.895627609334, 4281.7002809803635, 4322.135572885435, 4338.8047537860875, 4353.542877997828, 6442.130312407859, 6469.870602587922, 6471.0, 6492.350764923564, 6496.123023391876, 6546.869062618721, 6617.86764264712, 6641.335866413417, 6727.764528241488, 6805.353491418307, 6312.905306420407, 6344.460720838781, 6374.266959299647, 6430.7749228776765, 6454.935450645434, 5504.2018907258225, 5520.392756796749, 5540.279763630702, 5543.750531226105, 5544.473275038865, 7125.786226413215, 7185.856282874418, 7212.891806622905, 7213.3868621167785, 7217.133943926658, 6696.363845434676, 6699.129113215446, 6712.2616512184595, 6774.356436138559, 6783.660816959034, 6937.236903940461, 7019.333163349678, 7023.508354415142, 7045.2954704531185, 7094.751683691046, 6521.608703477807, 6522.543421960418, 6524.282328943717, 6525.249596296487, 6531.902021469777, 6634.237062737847, 6648.335166483506, 6656.23453302857, 6683.43190828785, 6693.196816382066, 6440.484761218998, 6473.255575608865, 6473.579217350857, 6479.384458476437, 6486.805395838132, 5812.505936995402, 6401.583897046677, 6454.19322584677, 6464.256610489666, 6601.141851559267, 6495.512836537373, 6496.058071579689, 6578.572392794453, 6579.243387010555, 6589.934100659124, 6428.292887782433, 6477.611343319416, 6493.188351456068, 6523.054157147092, 6609.768658096944, 6294.0, 6362.109304697438, 6363.649999250086, 6364.459020983269, 6368.745250190126], "value": 6095.337430931557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.4250966032373, 890.2521881619439, 932.2868005975428, 950.1828427552308, 956.8086382723457, 42204.577954220484, 43038.784806075964, 43154.56845431545, 43164.0, 43212.351814722766, 39739.40390894132, 40119.0, 40178.39732404016, 40308.59691403085, 40336.39495407571, 6421.229452465699, 6536.444402225817, 6543.443807276387, 6549.901751473732, 6554.639494827783, 6568.3103274156, 6647.700853461606, 6655.800325990203, 6659.933400666004, 6662.100616416795, 6666.600003999752, 6693.866122677544, 7247.166575843793, 7395.186529481753, 7406.259374062604, 7319.0, 7361.374283185909, 7372.3364897159245, 7390.224026477196, 7391.371733402613, 7066.152061752623, 7240.167380751228, 7252.311030452099, 7306.488545801796, 7307.817304567375, 40489.39265911013, 40750.79624601888, 40840.183196336206, 40863.38704919429, 40889.59110408917, 3505.94741078884, 3566.0906468850535, 3573.6605022522817, 3574.195805943642, 3579.0157706630625, 32252.677473225438, 32300.515492267634, 32442.83778581092, 32478.837605812056, 32588.67411325904, 5030.094582975063, 5085.059264036166, 5102.336696229467, 5103.897922041576, 5104.9744751276, 217755.0, 217907.0, 218516.9074154635, 218634.0, 218669.0, 51761.0, 51895.48104518982, 51960.74019629878, 52028.0, 52162.21756673653, 54030.7298463513, 54112.0, 54122.0, 54172.729136354064, 54358.0, 16517.174141292886, 16788.6642267154, 16794.496165115066, 16800.0759958201, 16810.159492025596, 13532.255725935169, 13624.0, 13631.86368136306, 13636.863631363758, 13638.727225455634, 15065.774013389808, 15140.545783626509, 15202.923985380003, 15269.618259543378, 15342.0, 5899.764009439575, 6067.150598916155, 6099.756009759649, 6132.386761323921, 6150.907736383958, 1097.286763603664, 1110.0786347331696, 1110.6612483192541, 1116.0903863351343, 1122.0911062039775, 25239.495210095694, 25387.238382848544, 25463.61804572933, 25503.0, 25610.231693048867, 1205.2708111592535, 1208.2750349790056, 1216.738401243737, 1217.945192466341, 1219.7438537906962, 13165.934170329087, 13194.472221111047, 13236.0, 13346.46614135443, 13349.199048057148, 285237.0, 288779.0, 288983.0, 289475.0, 290603.0, 52795.0, 54286.72856635691, 57897.0, 58930.41069589249, 59219.703901480214, 1515.143943671844, 1520.597041783928, 1523.404764755177, 1536.0937047142015, 1541.3757428241356, 30425.0, 30543.0, 30578.0, 31126.68873311238, 31513.684863151077, 54813.725931370085, 55499.0, 55513.722431387585, 55526.44473555374, 55529.0, 236238.0, 238573.0, 238952.0, 239203.0, 239942.0, 38000.23999520049, 38284.617153828105, 38570.6142938567, 38570.6142938567, 38572.80713596414, 46315.073698525164, 46395.0, 46633.0, 46686.76656616831, 47171.0, 34794.478082828275, 35097.0, 35151.64848351484, 35179.29641407209, 35640.28719425649, 33861.492077618364, 34274.657253428144, 34394.31211375808, 34499.0, 35190.472142917366, 38874.0, 39061.609383906936, 39247.2150556993, 39286.41070384004, 39743.40384894171, 33624.66375336313, 33829.0, 33832.66167338295, 34348.0, 34405.0, 25549.87225063863, 26363.736362636897, 26437.86781066159, 26555.867220663775, 27044.0], "value": 18303.28682426248, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6014069869692, 554.7337278106511, 568.8776912963712, 576.1185386358873, 586.5278450847069, 22577.209797657084, 23279.534409311804, 23569.05723771049, 23602.819859007024, 23631.5273694526, 26941.86529067352, 27379.31551711203, 27559.862200688967, 27564.724352756468, 27592.86203568979, 6361.554691171608, 6498.70755815987, 6500.089987401768, 6506.056621789838, 6508.967455162718, 5715.9428405716035, 5996.97001514994, 6185.752569897221, 6422.197225346832, 6476.514261430388, 6136.048912418582, 6143.0, 6152.600080994744, 6164.938350616504, 6165.845853853667, 6133.539984501158, 6158.5381096417495, 6160.075988601723, 6161.722722477454, 6165.414285642834, 5708.942910570882, 5735.1684005818925, 5736.311642602873, 5741.856453588652, 5742.0238559445, 30163.3410162441, 31119.844400778078, 31644.841775791203, 32204.355912881845, 32518.674813252037, 2236.1837929155904, 2260.400993736661, 2269.137727663494, 2269.965950510727, 2272.261515007629, 20281.0, 20928.162873485042, 20947.68578471324, 20979.475513112142, 20979.580408391746, 2177.618916689573, 2244.3154837774473, 2248.730152381708, 2315.2591170825176, 2422.8061755059553, 157272.21363893108, 161017.0, 161155.0, 161171.0, 161294.0, 15284.312205950759, 15828.52514424569, 15863.920680396524, 16116.75824862628, 16566.76348692935, 24051.879740601536, 24477.51044979126, 24515.87742061314, 24522.754772452405, 24528.0, 10702.571897124184, 10802.837957430645, 10900.34597924127, 10904.50929708165, 11109.000569846257, 10157.441340726184, 10213.182945364353, 10220.284580079324, 10260.897391025994, 10496.790064198673, 9392.718218453458, 9773.31586788918, 9851.901480985242, 9989.350692204984, 10006.649767258112, 2566.384067823709, 2577.7164511903675, 2676.34429564754, 2680.9463810724064, 2716.7231401241384, 1017.1303535477208, 1042.7132538551807, 1058.3544038136731, 1059.6238335390826, 1066.6000249906285, 21828.23601173983, 21996.89001555014, 22175.0, 22308.0, 22334.88832555827, 1126.594426006637, 1134.5235001299475, 1135.0408904475705, 1135.437958210691, 1136.3068528197794, 12240.326782026896, 14537.0, 15544.611384715472, 15635.322176650854, 16033.43882964114, 632464.0, 639381.0, 641987.0, 665989.0, 666117.0, 130000.34999824941, 132860.33569832088, 140277.0, 140812.0, 143267.0, 1302.6808431934237, 1317.571789168505, 1341.8926485881302, 1351.6350585341902, 1352.6077437543001, 23128.84355782238, 23754.168604098773, 23869.16457924034, 23935.0, 24122.75877241275, 67524.6623766878, 68570.0, 68573.3142668587, 69320.0, 69802.65098674475, 80083.0, 80378.5981070091, 80512.59743701245, 81275.0, 81608.59195703984, 13240.86759132435, 13904.721905562035, 15280.77078843796, 15500.379984800482, 15679.372825086868, 24544.877275613508, 25388.365290867878, 25867.22398328053, 25907.093251736853, 25988.74011259939, 20084.497887552927, 20205.0, 20294.59410811746, 20453.897730511253, 20501.07745151442, 17669.293228270726, 18808.52978675544, 18931.0, 18968.0, 19232.0, 21347.25284615031, 21457.570848583255, 21643.35069947904, 21789.673154903005, 22007.889960550096, 15217.77173342423, 15356.616084597528, 15467.0, 15646.765298520304, 15729.213539323217, 20505.38483845487, 20720.689189661865, 20731.4817129573, 20805.479863003548, 20818.68771968452], "value": 12973.227665345816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.6005438450043, 1440.2510694438893, 1442.502336693841, 1464.7436698577746, 1473.3811799044406, 15181.772273415907, 15894.841051589481, 15959.361625534964, 15965.281562329694, 16007.67984640308, 15854.762178567331, 16203.432879849208, 16263.593410164753, 16264.918675406607, 16271.349146034145, 2776.4030733392265, 2805.424887897976, 2825.9152225433168, 2829.066408085337, 2832.22113918673, 2705.6753189617275, 2708.8103832731717, 2719.4697034078363, 2784.916452506418, 2786.5680819472914, 2776.597393377959, 2794.7903907206937, 2797.580362945554, 2798.720127987195, 2799.0902956539207, 2654.5089158505643, 2676.611891275764, 2688.7445692659167, 2701.7433343832304, 2702.2568793581727, 2647.6293318935363, 2648.2717252755456, 2669.733026697315, 2676.157010541673, 2686.865656717176, 14473.855261447461, 14529.0, 14563.271836408243, 14585.197814120325, 14616.049956752777, 7638.770836874903, 7837.960810195969, 8030.277275045274, 8100.554469504175, 8128.187181281884, 5354.330708661418, 5473.151661492475, 5560.0, 5600.915986260209, 5624.21261023457, 1833.2483681690576, 1866.990665046666, 1873.5128866494674, 1901.5341241395947, 1910.6656335141433, 26730.331741706417, 26919.461610767674, 26928.596071058753, 26929.384236945847, 26936.73063269362, 7081.858362832714, 7136.821579460451, 7213.350798428167, 7308.1230252369, 7354.338109570164, 18296.908515457602, 18461.446156615322, 18466.169022394024, 18478.353257635918, 18496.537586560444, 7717.073951125901, 7847.6468558914985, 7937.642806073625, 7964.123946365895, 8019.558924259105, 7281.890771638429, 7494.21310762373, 7496.0255166827965, 7501.887471687929, 7507.099148102263, 5054.69671819692, 5446.264754258124, 5566.610337276433, 5622.943770562242, 5658.151277308437, 1548.2413617327654, 1565.585119943216, 1639.065732532469, 1642.4005238088012, 1659.468969929611, 928.3547934185676, 955.2739917662626, 956.9808603827885, 958.4153666263713, 969.060011788564, 8046.1551537088935, 8079.111297757242, 8161.918380816116, 8207.7948051298, 8223.753287401387, 1017.5929628148651, 1035.8756949166147, 1040.3757745352727, 1044.1072882685346, 1045.6653870761436, 4891.6575839691595, 4902.28916807061, 4982.177940639754, 4990.750462476862, 5015.272785446163, 21925.23261685865, 22005.449863753533, 22162.88918555397, 22179.0, 22254.109835606396, 21598.56802863934, 21708.131674732835, 21909.12363505442, 21920.89039554824, 21956.23153189631, 12026.939865300617, 12339.568115115928, 12342.0, 12484.188527745486, 12486.625401237978, 9604.95197524008, 9684.41893486393, 9686.031396860539, 9752.756181095529, 9842.360246583949, 19043.42869713911, 19370.322038728576, 19453.805461945198, 19494.902525487283, 19535.609287814448, 19348.8065119347, 19560.0, 19582.0, 19595.31416400419, 20038.298659546846, 12984.935075324564, 13104.606861794162, 13220.537281195113, 13255.270960097287, 13289.468421263042, 12640.747185056063, 14536.709265814414, 14785.704285914006, 14803.259837008321, 14815.85184148188, 9609.423434593948, 11387.886121139014, 11487.138464615355, 11799.76400472003, 11987.100967427652, 11607.419629018685, 11663.941680291544, 11684.88315116838, 11801.704957376134, 11837.348945808064, 10295.330803497749, 10563.313384629975, 10571.5242814072, 10575.101116405192, 10577.100946419641, 7344.596047217241, 7508.962455187689, 7579.0, 7613.390928725578, 7988.880166797387, 7609.315161635479, 7798.181190975093, 7908.960455197687, 8144.1448647893485, 8270.421070525006], "value": 6921.057849232297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.551594596755, 511.1744532579883, 539.487486887457, 546.7430307755353, 551.5201774456224, 6144.385561443859, 6195.628262304265, 6229.501639868811, 6234.158388617535, 6269.655168965716, 6098.237720284965, 6141.0, 6152.81541553753, 6167.7841275555365, 6176.598521096125, 4924.187509061001, 4933.802647894098, 4937.382827146597, 4959.305697202377, 4973.776180071887, 4653.162430762462, 4813.253945638414, 4884.804607815701, 4918.336024636664, 4920.8031678732805, 4759.833405830796, 4762.0, 4763.689985254048, 4773.785179666906, 4783.880402989918, 4786.56920877121, 4790.473047964721, 4797.424309082898, 4812.398450193726, 4829.879253018667, 4357.891052723676, 4361.280388735855, 4365.738055716635, 4379.474463064421, 4394.274944634131, 5973.522118230575, 6000.459958603747, 6015.789447369365, 6028.97507423739, 6048.60684055535, 5745.0, 5751.367349591542, 5755.740991655385, 5784.13238014297, 5800.433882851648, 6490.156279683611, 6524.608523488559, 6550.312217217219, 6559.0, 6607.0, 4947.257911313296, 4952.158133117378, 4954.628402869799, 4955.281484184809, 4958.652894297401, 6640.203175618908, 6668.83327916806, 6795.932040679629, 6844.589324640538, 6864.906203607848, 5387.488188622075, 5419.918701219485, 5427.317531565227, 5440.0, 5472.315960504937, 5575.665460072409, 5582.302212223472, 5590.217369568264, 5597.45315881273, 5614.736684246093, 5893.911591326134, 5920.934231838224, 5943.673097979653, 5977.79077732286, 5981.491573216325, 6543.411093001652, 6560.376764207393, 6570.357410647338, 6632.43624291931, 6639.336066393322, 1919.1767820570515, 1921.7693876734602, 1956.1197461142542, 1956.227290220355, 1960.6078784242923, 1336.2583766009764, 1389.589566589912, 1390.0, 1410.2243765928904, 1416.6529200345776, 6263.530235232376, 6278.277998030194, 6289.119523266746, 6332.810015699536, 6344.619322840552, 6548.377904099103, 6605.273419923805, 6648.900266496006, 6688.86622267552, 6705.195376554844, 6126.23422072241, 6349.111124442582, 6378.872422551616, 6382.585131966407, 6398.360163983658, 3512.613612502623, 3518.1556426457464, 3527.3421491898766, 3553.857845686195, 3554.804485753308, 6825.965870170717, 7044.542104763174, 7050.15398152225, 7069.505134640526, 7091.858162836715, 6833.487488438387, 6853.280405557444, 6855.828604284933, 6898.448124150156, 6912.239653638096, 7136.857262854714, 7172.103487064117, 7173.784786456415, 7182.168547020477, 7219.819504512324, 6462.578232788779, 6569.770058047945, 6682.899756503753, 6709.4632429404555, 6727.629980351127, 6564.146660934048, 6584.242812076481, 6592.307807680317, 6609.966950165219, 6646.83382915431, 7088.184858741311, 7097.7160913562875, 7109.0, 7129.108861392326, 7140.0, 5449.700266485382, 5465.9726701366235, 5473.917891231555, 5493.587980901369, 5523.25436066142, 6389.297177310399, 6407.903881441689, 6617.702203400955, 6651.068850360856, 6667.566608170453, 6380.298167201511, 6435.935640643721, 6472.5145614080075, 6478.935210647834, 6488.675566221765, 6358.523110766619, 6392.520560957853, 6418.614883107029, 6456.741730330734, 6518.902216466851, 6470.255920569195, 6478.6760661967655, 6481.967590162019, 6512.3162067982175, 6529.738810447719, 6491.350864913471, 6492.48060155177, 6524.368907773057, 6589.835254118685, 6610.10763546915, 6275.086098739928, 6275.560710750204, 6302.716377763103, 6330.430261276507, 6356.459700925288], "value": 5167.900049430215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.7682640926563, 924.2605915267789, 937.7093101138644, 942.8255772682054, 943.9622415103388, 18324.0, 19325.0, 19373.418797436083, 19387.903060484714, 19887.602247955034, 18980.43058708241, 18997.430077097673, 19002.049897505105, 19151.904240478812, 19182.61634767304, 1021.80074885397, 1068.6687126990657, 1069.6042464288225, 1081.2593373539112, 1110.211749657744, 1088.3415533602176, 1089.0634054712941, 1094.874089479712, 1095.3099547285199, 1098.02824500317, 1138.9544418223302, 1142.8285757136455, 1147.5409836065558, 1153.284963322741, 1155.537784886044, 1131.553036550562, 1135.659302209338, 1135.9091272698206, 1140.7661429407035, 1148.5405837664916, 836.7657056024323, 837.660747397305, 839.4501601450999, 845.9957700211521, 846.2003406780594, 19508.414747557596, 20077.0, 20202.79797202024, 20236.797632023638, 20408.897955510274, 21339.0, 21343.466413339636, 21374.251901183383, 21704.891475542678, 21745.456363590878, 15805.683886322324, 15888.205589720583, 16002.119883406407, 16132.677346453005, 16268.918655406766, 3667.8166091695307, 3676.9080772980888, 3690.5940346561856, 3699.408094704834, 3700.518932538753, 136674.0, 138344.0, 138434.30782846123, 138739.0, 142399.99999999895, 16643.916780416264, 16793.580160496087, 17013.48959531216, 17092.145392730316, 17109.572260693334, 31827.522587161213, 32190.35619287601, 32817.17957051045, 32957.835210823796, 33095.834520827244, 9118.452892826452, 9158.95420522893, 9305.441673499612, 9384.62461501546, 9402.858957115648, 3985.362342025262, 4116.1767646470225, 4186.665066794649, 4248.915021699549, 4278.786060697015, 5575.832725018256, 5712.228849105318, 5733.971330143323, 5745.1382292656435, 5753.223314852441, 1167.9591214307459, 1184.6090790039266, 1190.8511436070492, 1192.7316353820495, 1193.7015746063485, 678.7149397253165, 694.3611877073004, 696.0047132600329, 706.4454403293493, 717.447565374669, 12753.790959577971, 13339.266340351374, 14072.718545629235, 14522.273886305642, 14832.92583537097, 734.2217249715319, 734.4821900560092, 740.5852722475431, 743.0303453992484, 745.1914672580311, 6144.201253836973, 6343.524235682342, 6376.39424254695, 6454.612723236621, 6780.38976492118, 120882.39558802325, 122945.0, 124475.0, 126693.0, 128212.0, 108317.0, 112313.0, 112729.0, 113924.0, 115982.0, 94921.5253923726, 102056.0, 103551.4822425868, 103606.0, 103895.4805225969, 13754.243516606282, 14347.497837575635, 14455.421783128557, 14538.563843084725, 14587.635309117357, 46878.29682554833, 47045.29432058454, 47495.0, 47678.0, 48062.5193748058, 59434.70282648732, 60717.392826072944, 61416.0, 62927.37072629398, 75762.0, 18873.811261887753, 19100.617987640446, 19115.522111947314, 19328.71006934869, 19357.70963435578, 19834.801651983296, 20306.898465507576, 21647.13411463524, 22234.77765222392, 23014.42463938415, 18262.36081737133, 18451.630967380308, 18580.44258672242, 20496.48758780983, 21741.347759567238, 20031.799682002995, 20795.480112997295, 20900.268490602757, 20935.790642093383, 21811.454713632287, 19062.0, 20396.694049588972, 20605.38183854487, 20607.381778546667, 20752.169913203303, 13357.0, 13963.720725585228, 14290.285485725464, 14404.783928241295, 14624.415023398944, 14780.48268310604, 15367.0, 15495.767563486783, 15807.209639518209, 16062.759058613896], "value": 9798.994114296347, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1477.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 98.0, 106.0, 106.0, 106.0, 111.0, 98.0, 105.0, 107.0], "value": 104.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 146.0, 171.0, 115.0, 140.0, 143.0, 118.0, 167.0, 112.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 161.0, 161.0, 162.0, 162.0, 165.0, 167.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 166.0, 75.0, 75.0, 74.0, 73.0, 156.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 127.0, 78.0, 77.0, 78.0, 133.0, 79.0, 77.0, 126.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 116.0, 117.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 49.0, 46.0, 46.0, 46.0, 48.0, 46.0, 47.0, 47.0, 47.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 76.0, 75.0, 75.0, 81.0, 75.0, 76.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 121.0, 115.0, 118.0, 115.0, 124.0, 122.0, 114.0, 160.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 162.0, 166.0, 163.0, 181.0, 165.0, 165.0, 173.0, 166.0, 163.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 61.0, 66.0, 61.0, 60.0, 62.0, 62.0, 61.0, 60.0], "value": 62.1, "unit": "score"}]}]} 12:06:30 INFO - Return code: 0 12:06:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:06:30 INFO - # TBPL SUCCESS # 12:06:30 INFO - Running post-action listener: _package_coverage_data 12:06:30 INFO - Running post-action listener: _resource_record_post_action 12:06:30 INFO - [mozharness: 2017-08-04 19:06:30.502210Z] Finished run-tests step (success) 12:06:30 INFO - Running post-run listener: _resource_record_post_run 12:06:30 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 6447104; Write bytes: 435015680; Read time: 3604; Write time: 339428 12:06:30 INFO - TinderboxPrint: CPU usage
13.1% 12:06:30 INFO - TinderboxPrint: I/O read bytes / time
6,447,104 / 3,604 12:06:30 INFO - TinderboxPrint: I/O write bytes / time
435,015,680 / 339,428 12:06:30 INFO - TinderboxPrint: CPU idle
8,245.0 (86.9%) 12:06:30 INFO - TinderboxPrint: CPU user
1,191.9 (12.6%) 12:06:30 INFO - TinderboxPrint: Swap in / out
0 / 0 12:06:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119164928; Read time: 0; Write time: 92536 12:06:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:06:30 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4071424; Write bytes: 315850752; Read time: 2992; Write time: 246892 12:06:31 INFO - Running post-run listener: _upload_blobber_files 12:06:31 INFO - Blob upload gear active. 12:06:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:06:31 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 12:06:31 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'] 12:06:31 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 12:06:31 INFO - (blobuploader) - INFO - Open directory for files ... 12:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:06:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:32 INFO - (blobuploader) - INFO - Done attempting. 12:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:06:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:40 INFO - (blobuploader) - INFO - Done attempting. 12:06:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:06:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:41 INFO - (blobuploader) - INFO - Done attempting. 12:06:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:06:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:06:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:42 INFO - (blobuploader) - INFO - Done attempting. 12:06:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:06:42 INFO - Return code: 0 12:06:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:06:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:06:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b63ed6bc8620d73458915721aade113398ea9235a36302d494dc6ad0b2c2180ce30a044149f2f488e4833694ca089705092820265c7a13b86ac947e3178921", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c201140810b0a4aae6363a7aaccba3265ed4937d044c0b3ccf757bda8732cb5642dac502d8871165993b8dc409cd3730d146a1d6a079995fe4ac29f1d19fe60f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdebb58fe1f0b3a4370f842cec8c5b46935a2577fb89b1220c712126afd5e78ac9ea1ab24f3273493ba271a2073cbf5fe98beb9291fbc02f61d691e79362807e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e31610ec8345ceb283696a921217d19c5eca861354c161e9a27f1c2122001b38a16902c163b8493cfdea94c55df1617ffa44d99335a7ef48bbb450e404814d"} 12:06:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:06:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:06:42 INFO - Contents: 12:06:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b63ed6bc8620d73458915721aade113398ea9235a36302d494dc6ad0b2c2180ce30a044149f2f488e4833694ca089705092820265c7a13b86ac947e3178921", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c201140810b0a4aae6363a7aaccba3265ed4937d044c0b3ccf757bda8732cb5642dac502d8871165993b8dc409cd3730d146a1d6a079995fe4ac29f1d19fe60f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdebb58fe1f0b3a4370f842cec8c5b46935a2577fb89b1220c712126afd5e78ac9ea1ab24f3273493ba271a2073cbf5fe98beb9291fbc02f61d691e79362807e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e31610ec8345ceb283696a921217d19c5eca861354c161e9a27f1c2122001b38a16902c163b8493cfdea94c55df1617ffa44d99335a7ef48bbb450e404814d"} 12:06:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:06:42 INFO - Copying logs to upload dir... 12:06:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:06:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.329959 ========= master_lag: 0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-04 12:06:42.350491) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 12:06:42.353675) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b63ed6bc8620d73458915721aade113398ea9235a36302d494dc6ad0b2c2180ce30a044149f2f488e4833694ca089705092820265c7a13b86ac947e3178921", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c201140810b0a4aae6363a7aaccba3265ed4937d044c0b3ccf757bda8732cb5642dac502d8871165993b8dc409cd3730d146a1d6a079995fe4ac29f1d19fe60f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdebb58fe1f0b3a4370f842cec8c5b46935a2577fb89b1220c712126afd5e78ac9ea1ab24f3273493ba271a2073cbf5fe98beb9291fbc02f61d691e79362807e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e31610ec8345ceb283696a921217d19c5eca861354c161e9a27f1c2122001b38a16902c163b8493cfdea94c55df1617ffa44d99335a7ef48bbb450e404814d"} build_url:https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/KFlhWM79RY6N1TxtxvhXpg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34b63ed6bc8620d73458915721aade113398ea9235a36302d494dc6ad0b2c2180ce30a044149f2f488e4833694ca089705092820265c7a13b86ac947e3178921", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c201140810b0a4aae6363a7aaccba3265ed4937d044c0b3ccf757bda8732cb5642dac502d8871165993b8dc409cd3730d146a1d6a079995fe4ac29f1d19fe60f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cdebb58fe1f0b3a4370f842cec8c5b46935a2577fb89b1220c712126afd5e78ac9ea1ab24f3273493ba271a2073cbf5fe98beb9291fbc02f61d691e79362807e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56e31610ec8345ceb283696a921217d19c5eca861354c161e9a27f1c2122001b38a16902c163b8493cfdea94c55df1617ffa44d99335a7ef48bbb450e404814d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 12:06:42.378277) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 12:06:42.378600) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501872343.252850-761051196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 12:06:42.462390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 12:06:42.462711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 12:06:42.463001) ========= ========= Total master_lag: 0.49 =========