builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1501000629.55 results: success (0) revision: 32d9d1e81cc607320a36391845917f645f7a7f72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.551820) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.552275) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.552561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.572478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.572735) ========= 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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 09:37:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 208K=0.06s 2017-07-25 09:37:10 (208 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.160200 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.749045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.749364) ========= 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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:09.798722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 09:37:09.802102) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32d9d1e81cc607320a36391845917f645f7a7f72 --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 32d9d1e81cc607320a36391845917f645f7a7f72 --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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 09:37:10,529 truncating revision to first 12 chars 2017-07-25 09:37:10,529 Setting DEBUG logging. 2017-07-25 09:37:10,529 attempt 1/10 2017-07-25 09:37:10,529 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32d9d1e81cc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 09:37:11,896 unpacking tar archive at: mozilla-central-32d9d1e81cc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.826675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-25 09:37:11.644587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:11.644914) ========= script_repo_revision: 32d9d1e81cc607320a36391845917f645f7a7f72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:11.645303) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:11.645579) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 09:37:11.654088) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-25 09:37:11.654356) ========= /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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:37:12 INFO - MultiFileLogger online at 20170725 09:37:12 in /builds/slave/test 09:37:12 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 09:37:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:12 INFO - {'append_to_log': False, 09:37:12 INFO - 'base_work_dir': '/builds/slave/test', 09:37:12 INFO - 'blob_upload_branch': 'Firefox', 09:37:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:12 INFO - 'branch': 'Firefox', 09:37:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:12 INFO - 'code_coverage': False, 09:37:12 INFO - 'config_files': ('talos/linux_config.py',), 09:37:12 INFO - 'default_actions': ('clobber', 09:37:12 INFO - 'read-buildbot-config', 09:37:12 INFO - 'download-and-extract', 09:37:12 INFO - 'populate-webroot', 09:37:12 INFO - 'create-virtualenv', 09:37:12 INFO - 'install', 09:37:12 INFO - 'setup-mitmproxy', 09:37:12 INFO - 'run-tests'), 09:37:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:12 INFO - 'disable_ccov_upload': False, 09:37:12 INFO - 'download_minidump_stackwalk': True, 09:37:12 INFO - 'download_symbols': 'ondemand', 09:37:12 INFO - 'enable_stylo': False, 09:37:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:12 INFO - 'gecko_profile': False, 09:37:12 INFO - 'gecko_profile_interval': 0, 09:37:12 INFO - 'installer_path': 'installer.exe', 09:37:12 INFO - 'log_level': 'info', 09:37:12 INFO - 'log_name': 'talos', 09:37:12 INFO - 'log_to_console': True, 09:37:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:37:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:37:12 INFO - 'opt_config_files': (), 09:37:12 INFO - 'pip_index': False, 09:37:12 INFO - 'suite': 'dromaeojs-e10s', 09:37:12 INFO - 'system_bits': '32', 09:37:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:12 INFO - 'title': 'talos-linux64-ix-021', 09:37:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:12 INFO - 'use_talos_json': True, 09:37:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:12 INFO - 'work_dir': 'build'} 09:37:12 INFO - [mozharness: 2017-07-25 16:37:12.489183Z] Running clobber step. 09:37:12 INFO - Running pre-action listener: _resource_record_pre_action 09:37:12 INFO - Running main action method: clobber 09:37:12 INFO - rmtree: /builds/slave/test/build 09:37:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:13 INFO - Running post-action listener: _resource_record_post_action 09:37:13 INFO - [mozharness: 2017-07-25 16:37:13.512137Z] Finished clobber step (success) 09:37:13 INFO - [mozharness: 2017-07-25 16:37:13.512239Z] Running read-buildbot-config step. 09:37:13 INFO - Running pre-action listener: _resource_record_pre_action 09:37:13 INFO - Running main action method: read_buildbot_config 09:37:13 INFO - Using buildbot properties: 09:37:13 INFO - { 09:37:13 INFO - "project": "", 09:37:13 INFO - "product": "firefox", 09:37:13 INFO - "who": "cbook@mozilla.com", 09:37:13 INFO - "installer_path": "public/build/target.tar.bz2", 09:37:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:37:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 09:37:13 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:37:13 INFO - "stage_platform": "linux64-stylosequential", 09:37:13 INFO - "basedir": "/builds/slave/test", 09:37:13 INFO - "buildnumber": 1, 09:37:13 INFO - "platform": "ubuntu64_hw_styloseq", 09:37:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:37:13 INFO - "slavebuilddir": "test", 09:37:13 INFO - "taskId": "JavB13THQkCcwKmgJq0QsQ", 09:37:13 INFO - "branch": "mozilla-central", 09:37:13 INFO - "script_repo_revision": "production", 09:37:13 INFO - "revision": "32d9d1e81cc607320a36391845917f645f7a7f72", 09:37:13 INFO - "slavename": "talos-linux64-ix-021", 09:37:13 INFO - "repo_path": "mozilla-central" 09:37:13 INFO - } 09:37:13 INFO - Finding installer, test and symbols from parent task. 09:37:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JavB13THQkCcwKmgJq0QsQ'}, attempt #1 09:37:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JavB13THQkCcwKmgJq0QsQ'}, attempt #1 09:37:14 INFO - Task dependencies: fWUCQvL-S1mphvFnR8y4xA 09:37:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA'}, attempt #1 09:37:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 09:37:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/test_packages.json 09:37:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.crashreporter-symbols.zip 09:37:14 INFO - Running post-action listener: _resource_record_post_action 09:37:14 INFO - [mozharness: 2017-07-25 16:37:14.900882Z] Finished read-buildbot-config step (success) 09:37:14 INFO - [mozharness: 2017-07-25 16:37:14.901103Z] Running download-and-extract step. 09:37:14 INFO - Running pre-action listener: _resource_record_pre_action 09:37:14 INFO - Running main action method: download_and_extract 09:37:14 INFO - mkdir: /builds/slave/test/build/tests 09:37:14 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')]} 09:37:14 INFO - trying https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.test_packages.json 09:37:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:37:15 INFO - Downloaded 989 bytes. 09:37:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:37:15 INFO - Using the following test package requirements: 09:37:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:37:15 INFO - u'common': [u'target.common.tests.zip'], 09:37:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:37:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:37:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:37:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:37:15 INFO - u'mozbase': [u'target.common.tests.zip'], 09:37:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:37:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:37:15 INFO - u'web-platform': [u'target.common.tests.zip', 09:37:15 INFO - u'target.web-platform.tests.tar.gz'], 09:37:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:37:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:37:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip 09:37:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:37:15 INFO - Fetch https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip into memory 09:37:16 INFO - Content-Length response header: 72762047 09:37:16 INFO - Bytes received: 72762047 09:37:27 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:37:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip 09:37:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:37:27 INFO - Fetch https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.common.tests.zip into memory 09:37:29 INFO - Content-Length response header: 72762047 09:37:29 INFO - Bytes received: 72762047 09:37:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.talos.tests.zip 09:37:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:37:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.talos.tests.zip into memory 09:37:42 INFO - Content-Length response header: 14498866 09:37:42 INFO - Bytes received: 14498866 09:37:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:42 INFO - trying https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 09:37:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:37:43 INFO - Downloaded 62041065 bytes. 09:37:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 09:37:43 INFO - mkdir: /builds/slave/test/properties 09:37:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:43 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:43 INFO - Contents: 09:37:43 INFO - build_url:https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 09:37:43 INFO - Running post-action listener: _resource_record_post_action 09:37:43 INFO - Running post-action listener: set_extra_try_arguments 09:37:43 INFO - [mozharness: 2017-07-25 16:37:43.539317Z] Finished download-and-extract step (success) 09:37:43 INFO - [mozharness: 2017-07-25 16:37:43.539415Z] Running populate-webroot step. 09:37:43 INFO - Running pre-action listener: _resource_record_pre_action 09:37:43 INFO - Running main action method: populate_webroot 09:37:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:37:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:37:43 INFO - 'tests': ['damp', 'tps']}, 09:37:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:37:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:37:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:37:43 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:43 INFO - 'ts_paint', 09:37:43 INFO - 'tpaint', 09:37:43 INFO - 'sessionrestore', 09:37:43 INFO - 'sessionrestore_many_windows', 09:37:43 INFO - 'sessionrestore_no_auto_restore', 09:37:43 INFO - 'tabpaint']}, 09:37:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 09:37:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 09:37:43 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:37:43 INFO - 'talos_options': ['--mitmproxy', 09:37:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:37:43 INFO - '--firstNonBlankPaint'], 09:37:43 INFO - 'tests': ['quantum_pageload_google', 09:37:43 INFO - 'quantum_pageload_youtube', 09:37:43 INFO - 'quantum_pageload_amazon', 09:37:43 INFO - 'quantum_pageload_facebook']}, 09:37:43 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:37:43 INFO - 'talos_options': ['--stylo', 09:37:43 INFO - '--mitmproxy', 09:37:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:37:43 INFO - '--firstNonBlankPaint'], 09:37:43 INFO - 'tests': ['quantum_pageload_google', 09:37:43 INFO - 'quantum_pageload_youtube', 09:37:43 INFO - 'quantum_pageload_amazon', 09:37:43 INFO - 'quantum_pageload_facebook']}, 09:37:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:43 INFO - 'tsvgr_opacity', 09:37:43 INFO - 'tart', 09:37:43 INFO - 'tscrollx', 09:37:43 INFO - 'cart', 09:37:43 INFO - 'tsvg_static']}, 09:37:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:37:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:37:43 INFO - 'talos_options': ['--xperf_path', 09:37:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:43 INFO - 'tests': ['tp5n']}}} 09:37:43 INFO - Running post-action listener: _resource_record_post_action 09:37:43 INFO - [mozharness: 2017-07-25 16:37:43.546713Z] Finished populate-webroot step (success) 09:37:43 INFO - [mozharness: 2017-07-25 16:37:43.546804Z] Running create-virtualenv step. 09:37:43 INFO - Running pre-action listener: _resource_record_pre_action 09:37:43 INFO - Running main action method: create_virtualenv 09:37:43 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:37:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:37:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:43 INFO - Using real prefix '/usr' 09:37:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:44 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:46 INFO - Installing pip.................done. 09:37:46 INFO - Return code: 0 09:37:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:37:46 INFO - Reading from file tmpfile_stdout 09:37:46 INFO - Output received: 09:37:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:37:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:37:46 INFO - Using env: {'DISPLAY': ':0', 09:37:46 INFO - 'HOME': '/home/cltbld', 09:37:46 INFO - 'LANG': 'en_US.UTF-8', 09:37:46 INFO - 'LANGUAGE': 'en_US:en', 09:37:46 INFO - 'LOGNAME': 'cltbld', 09:37:46 INFO - 'MAIL': '/var/mail/cltbld', 09:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:46 INFO - 'MOZ_NO_REMOTE': '1', 09:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:46 INFO - 'NO_EM_RESTART': '1', 09:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:46 INFO - 'PWD': '/builds/slave/test', 09:37:46 INFO - 'SHELL': '/bin/bash', 09:37:46 INFO - 'SHLVL': '1', 09:37:46 INFO - 'TERM': 'linux', 09:37:46 INFO - 'TMOUT': '86400', 09:37:46 INFO - 'USER': 'cltbld', 09:37:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:46 INFO - '_': '/tools/buildbot/bin/python'} 09:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:37:46 INFO - Cleaning up... 09:37:46 INFO - Return code: 0 09:37:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:37:46 INFO - Using env: {'DISPLAY': ':0', 09:37:46 INFO - 'HOME': '/home/cltbld', 09:37:46 INFO - 'LANG': 'en_US.UTF-8', 09:37:46 INFO - 'LANGUAGE': 'en_US:en', 09:37:46 INFO - 'LOGNAME': 'cltbld', 09:37:46 INFO - 'MAIL': '/var/mail/cltbld', 09:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:46 INFO - 'MOZ_NO_REMOTE': '1', 09:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:46 INFO - 'NO_EM_RESTART': '1', 09:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:46 INFO - 'PWD': '/builds/slave/test', 09:37:46 INFO - 'SHELL': '/bin/bash', 09:37:46 INFO - 'SHLVL': '1', 09:37:46 INFO - 'TERM': 'linux', 09:37:46 INFO - 'TMOUT': '86400', 09:37:46 INFO - 'USER': 'cltbld', 09:37:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:46 INFO - '_': '/tools/buildbot/bin/python'} 09:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:46 INFO - Downloading/unpacking psutil>=3.1.1 09:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:48 INFO - Installing collected packages: psutil 09:37:48 INFO - Running setup.py install for psutil 09:37:48 INFO - building 'psutil._psutil_linux' extension 09:37:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:37:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:37:48 INFO - building 'psutil._psutil_posix' extension 09:37:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:37:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:37:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:48 INFO - Successfully installed psutil 09:37:48 INFO - Cleaning up... 09:37:48 INFO - Return code: 0 09:37:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37: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')]} 09:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:48 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:48 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 09:37:48 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 09:37:48 INFO - Using env: {'DISPLAY': ':0', 09:37:48 INFO - 'HOME': '/home/cltbld', 09:37:48 INFO - 'LANG': 'en_US.UTF-8', 09:37:48 INFO - 'LANGUAGE': 'en_US:en', 09:37:48 INFO - 'LOGNAME': 'cltbld', 09:37:48 INFO - 'MAIL': '/var/mail/cltbld', 09:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:48 INFO - 'MOZ_NO_REMOTE': '1', 09:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:48 INFO - 'NO_EM_RESTART': '1', 09:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:48 INFO - 'PWD': '/builds/slave/test', 09:37:48 INFO - 'SHELL': '/bin/bash', 09:37:48 INFO - 'SHLVL': '1', 09:37:48 INFO - 'TERM': 'linux', 09:37:48 INFO - 'TMOUT': '86400', 09:37:48 INFO - 'USER': 'cltbld', 09:37:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:48 INFO - '_': '/tools/buildbot/bin/python'} 09:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:50 INFO - Installing collected packages: mozsystemmonitor 09:37:50 INFO - Running setup.py install for mozsystemmonitor 09:37:50 INFO - Successfully installed mozsystemmonitor 09:37:50 INFO - Cleaning up... 09:37:50 INFO - Return code: 0 09:37:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:50 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')]} 09:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:50 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')]} 09:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:50 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:50 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 09:37:50 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 09:37:50 INFO - Using env: {'DISPLAY': ':0', 09:37:50 INFO - 'HOME': '/home/cltbld', 09:37:50 INFO - 'LANG': 'en_US.UTF-8', 09:37:50 INFO - 'LANGUAGE': 'en_US:en', 09:37:50 INFO - 'LOGNAME': 'cltbld', 09:37:50 INFO - 'MAIL': '/var/mail/cltbld', 09:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:50 INFO - 'MOZ_NO_REMOTE': '1', 09:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:50 INFO - 'NO_EM_RESTART': '1', 09:37:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:50 INFO - 'PWD': '/builds/slave/test', 09:37:50 INFO - 'SHELL': '/bin/bash', 09:37:50 INFO - 'SHLVL': '1', 09:37:50 INFO - 'TERM': 'linux', 09:37:50 INFO - 'TMOUT': '86400', 09:37:50 INFO - 'USER': 'cltbld', 09:37:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:50 INFO - '_': '/tools/buildbot/bin/python'} 09:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:50 INFO - Downloading/unpacking jsonschema==2.5.1 09:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:51 INFO - warning: no files found matching '*.txt' 09:37:51 INFO - no previously-included directories found matching 'build' 09:37:51 INFO - no previously-included directories found matching 'dist' 09:37:51 INFO - no previously-included directories found matching '.git*' 09:37:51 INFO - Installing collected packages: jsonschema, functools32 09:37:51 INFO - Running setup.py install for functools32 09:37:51 INFO - warning: no files found matching '*.txt' 09:37:51 INFO - no previously-included directories found matching 'build' 09:37:51 INFO - no previously-included directories found matching 'dist' 09:37:51 INFO - no previously-included directories found matching '.git*' 09:37:51 INFO - Successfully installed jsonschema functools32 09:37:51 INFO - Cleaning up... 09:37:51 INFO - Return code: 0 09:37:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:51 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:51 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 09:37:51 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 09:37:51 INFO - Using env: {'DISPLAY': ':0', 09:37:51 INFO - 'HOME': '/home/cltbld', 09:37:51 INFO - 'LANG': 'en_US.UTF-8', 09:37:51 INFO - 'LANGUAGE': 'en_US:en', 09:37:51 INFO - 'LOGNAME': 'cltbld', 09:37:51 INFO - 'MAIL': '/var/mail/cltbld', 09:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:51 INFO - 'MOZ_NO_REMOTE': '1', 09:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:51 INFO - 'NO_EM_RESTART': '1', 09:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:51 INFO - 'PWD': '/builds/slave/test', 09:37:51 INFO - 'SHELL': '/bin/bash', 09:37:51 INFO - 'SHLVL': '1', 09:37:51 INFO - 'TERM': 'linux', 09:37:51 INFO - 'TMOUT': '86400', 09:37:51 INFO - 'USER': 'cltbld', 09:37:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:51 INFO - '_': '/tools/buildbot/bin/python'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:52 INFO - Cleaning up... 09:37:52 INFO - Return code: 0 09:37:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:37:52 INFO - Using env: {'DISPLAY': ':0', 09:37:52 INFO - 'HOME': '/home/cltbld', 09:37:52 INFO - 'LANG': 'en_US.UTF-8', 09:37:52 INFO - 'LANGUAGE': 'en_US:en', 09:37:52 INFO - 'LOGNAME': 'cltbld', 09:37:52 INFO - 'MAIL': '/var/mail/cltbld', 09:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:52 INFO - 'MOZ_NO_REMOTE': '1', 09:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:52 INFO - 'NO_EM_RESTART': '1', 09:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:52 INFO - 'PWD': '/builds/slave/test', 09:37:52 INFO - 'SHELL': '/bin/bash', 09:37:52 INFO - 'SHLVL': '1', 09:37:52 INFO - 'TERM': 'linux', 09:37:52 INFO - 'TMOUT': '86400', 09:37:52 INFO - 'USER': 'cltbld', 09:37:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:52 INFO - '_': '/tools/buildbot/bin/python'} 09:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:53 INFO - Downloading docopt-0.6.1.tar.gz 09:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:53 INFO - Running setup.py install for blobuploader 09:37:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:54 INFO - Running setup.py install for requests 09:37:54 INFO - Running setup.py install for docopt 09:37:54 INFO - Successfully installed blobuploader requests docopt 09:37:54 INFO - Cleaning up... 09:37:54 INFO - Return code: 0 09:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:54 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')]} 09:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:54 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')]} 09:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:54 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:54 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 09:37:54 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 09:37:54 INFO - Using env: {'DISPLAY': ':0', 09:37:54 INFO - 'HOME': '/home/cltbld', 09:37:54 INFO - 'LANG': 'en_US.UTF-8', 09:37:54 INFO - 'LANGUAGE': 'en_US:en', 09:37:54 INFO - 'LOGNAME': 'cltbld', 09:37:54 INFO - 'MAIL': '/var/mail/cltbld', 09:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:54 INFO - 'MOZ_NO_REMOTE': '1', 09:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:54 INFO - 'NO_EM_RESTART': '1', 09:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:54 INFO - 'PWD': '/builds/slave/test', 09:37:54 INFO - 'SHELL': '/bin/bash', 09:37:54 INFO - 'SHLVL': '1', 09:37:54 INFO - 'TERM': 'linux', 09:37:54 INFO - 'TMOUT': '86400', 09:37:54 INFO - 'USER': 'cltbld', 09:37:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:54 INFO - '_': '/tools/buildbot/bin/python'} 09:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:54 INFO - Running setup.py (path:/tmp/pip-xIJbaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:54 INFO - Running setup.py (path:/tmp/pip-p7nqxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:54 INFO - Running setup.py (path:/tmp/pip-4jQhnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:54 INFO - Running setup.py (path:/tmp/pip-mKTsTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:55 INFO - Running setup.py (path:/tmp/pip-OTsA7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:55 INFO - Running setup.py (path:/tmp/pip-ZhZYzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:55 INFO - Running setup.py (path:/tmp/pip-LvIbGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:55 INFO - Running setup.py (path:/tmp/pip-sbXoUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:55 INFO - Running setup.py (path:/tmp/pip-BoAvfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:55 INFO - Running setup.py (path:/tmp/pip-pdEL4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:55 INFO - Running setup.py (path:/tmp/pip-SVVXNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:55 INFO - Running setup.py (path:/tmp/pip-TDXNjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:55 INFO - Running setup.py (path:/tmp/pip-NRe0K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:55 INFO - Running setup.py (path:/tmp/pip-BTGEji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:55 INFO - Running setup.py (path:/tmp/pip-k0VMtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:55 INFO - Running setup.py (path:/tmp/pip-piEAG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:55 INFO - Running setup.py (path:/tmp/pip-TmkUR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:55 INFO - Running setup.py install for manifestparser 09:37:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for mozcrash 09:37:56 INFO - Running setup.py install for mozdebug 09:37:56 INFO - Running setup.py install for mozdevice 09:37:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for mozfile 09:37:56 INFO - Running setup.py install for mozhttpd 09:37:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for mozinfo 09:37:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for mozInstall 09:37:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for mozleak 09:37:56 INFO - Running setup.py install for mozlog 09:37:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:56 INFO - Running setup.py install for moznetwork 09:37:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Running setup.py install for mozprocess 09:37:57 INFO - Running setup.py install for mozprofile 09:37:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Running setup.py install for mozrunner 09:37:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Running setup.py install for mozscreenshot 09:37:57 INFO - Running setup.py install for moztest 09:37:57 INFO - Running setup.py install for mozversion 09:37:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:57 INFO - Cleaning up... 09:37:57 INFO - Return code: 0 09:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37: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')]} 09:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:57 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:37:57 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 09:37:57 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 09:37:57 INFO - Using env: {'DISPLAY': ':0', 09:37:57 INFO - 'HOME': '/home/cltbld', 09:37:57 INFO - 'LANG': 'en_US.UTF-8', 09:37:57 INFO - 'LANGUAGE': 'en_US:en', 09:37:57 INFO - 'LOGNAME': 'cltbld', 09:37:57 INFO - 'MAIL': '/var/mail/cltbld', 09:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:57 INFO - 'MOZ_NO_REMOTE': '1', 09:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:57 INFO - 'NO_EM_RESTART': '1', 09:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:57 INFO - 'PWD': '/builds/slave/test', 09:37:57 INFO - 'SHELL': '/bin/bash', 09:37:57 INFO - 'SHLVL': '1', 09:37:57 INFO - 'TERM': 'linux', 09:37:57 INFO - 'TMOUT': '86400', 09:37:57 INFO - 'USER': 'cltbld', 09:37:57 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:57 INFO - '_': '/tools/buildbot/bin/python'} 09:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:57 INFO - Running setup.py (path:/tmp/pip-uyLnPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:58 INFO - Running setup.py (path:/tmp/pip-hpBTE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:58 INFO - Running setup.py (path:/tmp/pip-QpDhcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:58 INFO - Running setup.py (path:/tmp/pip-mOn3Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:58 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)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:58 INFO - Running setup.py (path:/tmp/pip-0oaBv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:58 INFO - Running setup.py (path:/tmp/pip-7MnqPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:58 INFO - Running setup.py (path:/tmp/pip-ejfvFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:58 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)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:58 INFO - Running setup.py (path:/tmp/pip-0Kwu0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:58 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)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:58 INFO - Running setup.py (path:/tmp/pip-Wp36bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:58 INFO - Running setup.py (path:/tmp/pip-la1Zqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:58 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)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:58 INFO - Running setup.py (path:/tmp/pip-fIjDoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:58 INFO - Running setup.py (path:/tmp/pip-EnMLdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:58 INFO - Running setup.py (path:/tmp/pip-t4PT9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:58 INFO - Running setup.py (path:/tmp/pip-ItXJDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:58 INFO - Running setup.py (path:/tmp/pip-iD0Ofo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:59 INFO - Running setup.py (path:/tmp/pip-F10fn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:59 INFO - Running setup.py (path:/tmp/pip-2S6ksR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:37:59 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)) 09:37:59 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)) 09:37:59 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)) 09:37:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:00 INFO - Downloading blessings-1.6.tar.gz 09:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:38:00 INFO - Installing collected packages: blessings 09:38:00 INFO - Running setup.py install for blessings 09:38:00 INFO - Successfully installed blessings 09:38:00 INFO - Cleaning up... 09:38:00 INFO - Return code: 0 09:38:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:00 INFO - Reading from file tmpfile_stdout 09:38:00 INFO - Current package versions: 09:38:00 INFO - argparse == 1.2.1 09:38:00 INFO - blessings == 1.6 09:38:00 INFO - blobuploader == 1.2.4 09:38:00 INFO - docopt == 0.6.1 09:38:00 INFO - functools32 == 3.2.3-2 09:38:00 INFO - jsonschema == 2.5.1 09:38:00 INFO - manifestparser == 1.1 09:38:00 INFO - mozInstall == 1.13 09:38:00 INFO - mozcrash == 1.0 09:38:00 INFO - mozdebug == 0.1 09:38:00 INFO - mozdevice == 0.51 09:38:00 INFO - mozfile == 1.2 09:38:00 INFO - mozhttpd == 0.7 09:38:00 INFO - mozinfo == 0.10 09:38:00 INFO - mozleak == 0.1 09:38:00 INFO - mozlog == 3.5 09:38:00 INFO - moznetwork == 0.27 09:38:00 INFO - mozprocess == 0.25 09:38:00 INFO - mozprofile == 0.28 09:38:00 INFO - mozrunner == 6.13 09:38:00 INFO - mozscreenshot == 0.1 09:38:00 INFO - mozsystemmonitor == 0.3 09:38:00 INFO - moztest == 0.8 09:38:00 INFO - mozversion == 1.4 09:38:00 INFO - psutil == 3.1.1 09:38:00 INFO - requests == 1.2.3 09:38:00 INFO - wsgiref == 0.1.2 09:38:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:00 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:38:00 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 09:38:00 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 09:38:00 INFO - Using env: {'DISPLAY': ':0', 09:38:00 INFO - 'HOME': '/home/cltbld', 09:38:00 INFO - 'LANG': 'en_US.UTF-8', 09:38:00 INFO - 'LANGUAGE': 'en_US:en', 09:38:00 INFO - 'LOGNAME': 'cltbld', 09:38:00 INFO - 'MAIL': '/var/mail/cltbld', 09:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:00 INFO - 'MOZ_NO_REMOTE': '1', 09:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:00 INFO - 'NO_EM_RESTART': '1', 09:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:00 INFO - 'PWD': '/builds/slave/test', 09:38:00 INFO - 'SHELL': '/bin/bash', 09:38:00 INFO - 'SHLVL': '1', 09:38:00 INFO - 'TERM': 'linux', 09:38:00 INFO - 'TMOUT': '86400', 09:38:00 INFO - 'USER': 'cltbld', 09:38:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:00 INFO - '_': '/tools/buildbot/bin/python'} 09:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:38:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:02 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:38:02 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 09:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:38:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 09:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:38:02 INFO - Installing collected packages: marionette-driver, simplejson 09:38:02 INFO - Running setup.py install for marionette-driver 09:38:02 INFO - Running setup.py install for simplejson 09:38:02 INFO - building 'simplejson._speedups' extension 09:38:02 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 09:38:03 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 09:38:03 INFO - Successfully installed marionette-driver simplejson 09:38:03 INFO - Cleaning up... 09:38:03 INFO - Return code: 0 09:38:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:38:03 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')]} 09:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:03 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')]} 09:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:03 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 0xe351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1001a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a4d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, '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': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:38:03 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 09:38:03 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 09:38:03 INFO - Using env: {'DISPLAY': ':0', 09:38:03 INFO - 'HOME': '/home/cltbld', 09:38:03 INFO - 'LANG': 'en_US.UTF-8', 09:38:03 INFO - 'LANGUAGE': 'en_US:en', 09:38:03 INFO - 'LOGNAME': 'cltbld', 09:38:03 INFO - 'MAIL': '/var/mail/cltbld', 09:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:03 INFO - 'MOZ_NO_REMOTE': '1', 09:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:03 INFO - 'NO_EM_RESTART': '1', 09:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:03 INFO - 'PWD': '/builds/slave/test', 09:38:03 INFO - 'SHELL': '/bin/bash', 09:38:03 INFO - 'SHLVL': '1', 09:38:03 INFO - 'TERM': 'linux', 09:38:03 INFO - 'TMOUT': '86400', 09:38:03 INFO - 'USER': 'cltbld', 09:38:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:03 INFO - '_': '/tools/buildbot/bin/python'} 09:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:38:03 INFO - Cleaning up... 09:38:03 INFO - Return code: 0 09:38:03 INFO - Running post-action listener: _resource_record_post_action 09:38:03 INFO - Running post-action listener: _start_resource_monitoring 09:38:03 INFO - Starting resource monitoring. 09:38:03 INFO - [mozharness: 2017-07-25 16:38:03.758055Z] Finished create-virtualenv step (success) 09:38:03 INFO - [mozharness: 2017-07-25 16:38:03.758577Z] Running install step. 09:38:03 INFO - Running pre-action listener: _resource_record_pre_action 09:38:03 INFO - Running main action method: install 09:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:38:03 INFO - Reading from file tmpfile_stdout 09:38:03 INFO - Detecting whether we're running mozinstall >=1.0... 09:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:38:04 INFO - Reading from file tmpfile_stdout 09:38:04 INFO - Output received: 09:38:04 INFO - Usage: mozinstall [options] installer 09:38:04 INFO - Options: 09:38:04 INFO - -h, --help show this help message and exit 09:38:04 INFO - -d DEST, --destination=DEST 09:38:04 INFO - Directory to install application into. [default: 09:38:04 INFO - "/builds/slave/test"] 09:38:04 INFO - --app=APP Application being installed. [default: firefox] 09:38:04 INFO - mkdir: /builds/slave/test/build/application 09:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:38:22 INFO - Reading from file tmpfile_stdout 09:38:22 INFO - Output received: 09:38:22 INFO - /builds/slave/test/build/application/firefox/firefox 09:38:22 INFO - Running post-action listener: _resource_record_post_action 09:38:22 INFO - [mozharness: 2017-07-25 16:38:22.097114Z] Finished install step (success) 09:38:22 INFO - [mozharness: 2017-07-25 16:38:22.097369Z] Running setup-mitmproxy step. 09:38:22 INFO - Running pre-action listener: _resource_record_pre_action 09:38:22 INFO - Running main action method: setup_mitmproxy 09:38:22 INFO - Skipping: mitmproxy is not required 09:38:22 INFO - Running post-action listener: _resource_record_post_action 09:38:22 INFO - [mozharness: 2017-07-25 16:38:22.098500Z] Finished setup-mitmproxy step (success) 09:38:22 INFO - [mozharness: 2017-07-25 16:38:22.098721Z] Running run-tests step. 09:38:22 INFO - Running pre-action listener: _resource_record_pre_action 09:38:22 INFO - Running pre-action listener: _set_gcov_prefix 09:38:22 INFO - Running main action method: run_tests 09:38:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:38:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:38:22 INFO - Python 2.7.3 09:38:22 INFO - Return code: 0 09:38:22 INFO - grabbing minidump binary from tooltool 09:38:22 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')]} 09:38:22 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 0x11a1eb0>, '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 0x11a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11a3240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:38:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:38:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:38:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:38:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:38:22 INFO - Return code: 0 09:38:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:38:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:38:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:38:22 INFO - ENV: RUST_BACKTRACE is now 1 09:38:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:38:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:38:22 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/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:38:22 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/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:38:22 INFO - Using env: {'DISPLAY': ':0', 09:38:22 INFO - 'HOME': '/home/cltbld', 09:38:22 INFO - 'LANG': 'en_US.UTF-8', 09:38:22 INFO - 'LANGUAGE': 'en_US:en', 09:38:22 INFO - 'LOGNAME': 'cltbld', 09:38:22 INFO - 'MAIL': '/var/mail/cltbld', 09:38:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:38:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:22 INFO - 'MOZ_NO_REMOTE': '1', 09:38:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:22 INFO - 'NO_EM_RESTART': '1', 09:38:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:22 INFO - 'PWD': '/builds/slave/test', 09:38:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:38:22 INFO - 'RUST_BACKTRACE': '1', 09:38:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:38:22 INFO - 'SHELL': '/bin/bash', 09:38:22 INFO - 'SHLVL': '1', 09:38:22 INFO - 'STYLO_FORCE_ENABLED': '1', 09:38:22 INFO - 'TERM': 'linux', 09:38:22 INFO - 'TMOUT': '86400', 09:38:22 INFO - 'USER': 'cltbld', 09:38:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505', 09:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:22 INFO - '_': '/tools/buildbot/bin/python'} 09:38:22 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/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:38:22 INFO - mozversion application_buildid: 20170725154251 09:38:22 INFO - mozversion application_changeset: 32d9d1e81cc607320a36391845917f645f7a7f72 09:38:22 INFO - mozversion application_display_name: Nightly 09:38:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:38:22 INFO - mozversion application_name: Firefox 09:38:22 INFO - mozversion application_remotingname: firefox 09:38:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:38:22 INFO - mozversion application_vendor: Mozilla 09:38:22 INFO - mozversion application_version: 56.0a1 09:38:22 INFO - mozversion platform_buildid: 20170725154251 09:38:22 INFO - mozversion platform_changeset: 32d9d1e81cc607320a36391845917f645f7a7f72 09:38:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:38:22 INFO - mozversion platform_version: 56.0a1 09:38:22 INFO - using testdate: 1501000702 09:38:22 INFO - actual date: 1501000702 09:38:22 INFO - starting webserver on 'localhost:45461' 09:38:22 INFO - SUITE-START | Running 2 tests 09:38:22 INFO - TEST-START | dromaeo_css 09:38:22 INFO - Initialising browser for dromaeo_css test... 09:38:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45461/getInfo.html -profile /tmp/tmpUtmDPQ/profile 09:38:22 INFO - TEST-INFO | started process 21650 (/builds/slave/test/build/application/firefox/firefox http://localhost:45461/getInfo.html) 09:38:29 INFO - TEST-INFO | 21650: exit 0 09:38:30 INFO - Browser initialized. 09:38:30 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:30 INFO - TEST-INFO | started process 21875 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUtmDPQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:31 INFO - PID 21875 | 09:38:31 INFO - PID 21875 | (/builds/slave/test/build/application/firefox/firefox:21930): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:38:31 INFO - PID 21875 | 09:38:41 INFO - PID 21875 | RSS: Main: 174395392 09:38:41 INFO - PID 21875 | 09:41:41 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45461/tests/dromaeo/cssquery-ext.html) 09:41:42 INFO - PID 21875 | RSS: Main: 175308800 09:41:42 INFO - PID 21875 | 09:44:44 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-ext.html (next: http://localhost:45461/tests/dromaeo/cssquery-jquery.html) 09:44:44 INFO - PID 21875 | RSS: Main: 171712512 09:44:44 INFO - PID 21875 | 09:47:46 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45461/tests/dromaeo/cssquery-mootools.html) 09:47:47 INFO - PID 21875 | RSS: Main: 174661632 09:47:47 INFO - PID 21875 | 09:50:49 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45461/tests/dromaeo/cssquery-prototype.html) 09:50:49 INFO - PID 21875 | RSS: Main: 173469696 09:50:49 INFO - PID 21875 | 09:53:53 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45461/tests/dromaeo/cssquery-yui.html) 09:53:54 INFO - PID 21875 | RSS: Main: 174792704 09:53:54 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | Cycle 1(1): loaded http://localhost:45461/tests/dromaeo/cssquery-yui.html (next: http://localhost:45461/tests/dromaeo/cssquery-dojo.html) 09:56:56 INFO - PID 21875 | RSS: Main: 177647616 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | __start_tp_report 09:56:56 INFO - PID 21875 | _x_x_mozilla_page_load 09:56:56 INFO - PID 21875 | _x_x_mozilla_page_load_details 09:56:56 INFO - PID 21875 | |i|pagename|runs| 09:56:56 INFO - PID 21875 | |0;dojo.html;3112.393083348748;3134.5454909038185;3135.435621588113;3145.1508092814934;3177.412178746932;6070.150178974947;6297.433231009209;6312.589681670694;6314.7474101035905;6327.114204011431;6032.517398608112;6149.4772944299675;6155.507559395249;6158.6612736299485;6162.291336496304;5597.972010139943;5617.691026993513;5638.4361563843495;5648.124540696199;5684.971575142118;5651.9152212716635;5670.206171136044;5673.546116310686;5697.914531282034;5759.654420734749;5644.604877658566;5688.63023903447;5725.570582206351;5756.769729210827;5765.394633563478;5565.30433695788;5655.095184770417;5675.858103547403;5709.685967271777;5729.799457019005;5475.425080366544;5553.305836770403;5598.104303311491;5644.74598643062;5681.9431805681825;6060.33336333003;6080.604760690541;6118.632882027048;6122.96938515309;6179.19670442844;6530.44491218247;6584.880570303012;6657.068010478537;6697.162854643169;6716.361945615159;6630.370114839083;6671.833204169935;6798.422134118557;6805.251422343587;6806.149231346082;6226.034964580497;6252.843678908018;6312.431881130628;6323.683815809237;6327.8418039548915;6856.005879147496;6901.068355771907;6941.652917354112;6975.128108986377;6993.405560527311;6562.475001999924;6588.901166482507;6630.86738265232;6667.266600673922;6670.7665231716655;6629.303923088007;6644.501662375341;6693.665316734144;6725.630090345078;6732.091167692299;6418.101465794793;6632.403083722488;6639.966800165968;6721.899171512431;6738.326167383222;6516.478681705452;6578.703958321887;6580.473562115019;6582.572132811352;6594.769183078569;5302.575793936476;5305.124654431976;5327.706976116273;5373.408925018245;5381.67709937405;4516.412866327422;4579.702319349299;4595.701279416827;4613.63090952723;4626.236670949323;5670.631408958405;5738.655680659091;5764.250647415809;5777.364489906107;5820.923129221108;6642.7342906284175;6671.199456065303;6673.799786006428;6675;6688.097106890605;5748.281464816898;5750.827475175752;5811.622244554091;5830.096335068071;5842.649441033552;5810.709464526757;5890.204822349014;5892.734826932712;5901.232839730807;5905.232319798484;6448.580842245239;6462.935370646327;6486.513511486657;6546.639934803631;6566.409023187936;6566.376194261537;6642.568233064835;6651.16860392451;6753.15585551806;6759.493038022069;6515.511336649865;6525.575837570543;6561;6580.473562115115;6583.539152259296;6571.96714016446;6607.47140228771;6627.039079333566;6656.633885136171;6681.599104053772;6606.240282367397;6681.799546013627;6698.129243198353;6754.425873800782;6843.110395648534;6513.902291465537;6540.672966351759;6558.934410655832;6563.474922006323;6567.277599464151;6470.838229044123;6481.125048118443;6487.059376390492;6573.211214654272;6589.308122647053;6235.688215589294;6353.078803573363;6383.489320854228;6387.616742995435;6490.415862572202;6460.192475940507;6522.445592124533;6528;6604.636744979072;6652;6322.747090116344;6382.170317858649;6427.939390000597;6452.677366131768;6484.481241500763 09:56:56 INFO - PID 21875 | |1;ext.html;847.2882778466092;866.3762091294268;890.8307421589898;897.6319708919344;1176.6234804862447;31742.84128579357;32416;43193.92015199618;43868.56131438685;44100.55899441004;43502;44164.11671766563;44209.77895110528;44274;44297.7785111074;5947.583669143161;6078.787242446515;7684.116326622426;7753.573553454557;7872.606369681522;7703.8074048148965;7912.367010639164;7912.367010639164;7915.643796029164;7916.604169791487;7819.5308281503;7854.293113619773;7899.526028438283;7911.723089691862;7922.445428819985;7791.766247012571;7869.134395216522;7877.842443151162;7878.054633444023;7879.172686867911;7715.498492597963;7723.189065148191;7758.883616745753;7769.766906992742;7782.844343113106;40020;40108;40164;40191.598084019075;40215.597844021475;3515.6484351564895;3536.5579302587175;3571.499990001402;3573.392523271024;3582.158192824684;31804.20489487758;31812.6818731812;31879.52180717291;32123.35753284921;32126.196845078826;4822.252550854623;5032.043911656773;5040;5040.899182016376;5064.544191022789;184804;185386;185555;186515;187306.06346968314;50239;50341.49658503368;50358.49641503611;50408;50777.74611126921;52916.470835291926;52923.206151907754;53095;53151.20273195828;53203;16674.166291685367;16880.662386752196;17034.74447883283;17053.40313089061;17061.31754729822;11815.172937894265;12014.879851201551;12827.871721282854;13059.21644701321;14031.438742450391;13262.336883155996;13422.597322080353;13430.664233394047;13588.38852251651;13647.727045459234;5209.453007434241;5281.973590132025;5298.178782288752;5307.363116426053;5358.705271210121;1009.7223263602422;1010.1363334349026;1018.0786388318584;1027.9434631095212;1031.8761748590066;22523.211687590854;28761.280967975967;29179.95955964935;29672.2581935449;29742.10773676793;1091.5536913589367;1104.3373975614568;1111.349860331699;1127.9097672186206;1130.9773804524027;12397.814032789516;12558.87441125577;12597.788776243271;12600.936995315147;12679.492820287085;235408;237537;237592;237593;238693;55211;55214;55282;55357.72321138449;55400.168997464265;1498.9400423983136;1504.608801711541;1507.4949891786155;1521.786949827003;1524.4511975688965;22012.547644607803;22024.11903523841;22276.554468910206;22885.31344059681;23067.769322307235;51255.74372128116;54120.188197177864;54170.45829541654;54376.72811635916;54495;204494;205932;206452;206585;206780;31553;31992.200194995312;34762;36427;36576.26847463089;45576.54423455723;45768;46005.309920350555;46007.769961151316;46419.30371044505;31225.8438707805;32427.837860811487;33206.83396583002;33826.66173338235;33987;31905;32674.83662581672;32729.50905736368;32983.83508082444;33097.17257068593;36603;36626.26747464982;36683.44974825433;36693.816530917175;36844.447333289485;29616.555751664175;31518.212044699067;31586.842065790443;31884.521732173573;31975.840120800178;22611.773882260968;23219.651705224773;23804.166854160023;23815.166469173495;24351.51296974015 09:56:56 INFO - PID 21875 | |2;jquery.html;595.7616953218712;597.2206270816582;598.6029283814354;601.2814686449692;620.9565330426869;22015.779842201595;22577.661335079985;22904;22981.540369192648;22993.08027678893;26077;26551.86724066377;26611.866940665317;26643.333916652093;26672;6486.3513648635235;6617.272100068989;6637.1703537057865;6637.46900247979;6638.800835974905;6251.749930002795;6529.902051469232;6571.835704107388;6580.80257592273;6595.142631457904;6510.414062734353;6517.250516190627;6528.804135875931;6532.216134063919;6542.280349161612;6463.256725476536;6487.772927947546;6512.479001679854;6513.609183449008;6552.770653027145;6039.969800151015;6061.272647282311;6082.5742198046155;6092.756289748405;6127.172831667713;27614.309642258904;28923.56614650782;29578.85210573955;29760.36318002509;29772;1908.4847091285415;1936.0126335568962;1938.7188857615567;1939.524816419972;1944.6402415553168;18488.2604695812;19048.61902761951;19069.237230510764;19090.71363929528;19098;2364.609839376501;2390.6653068570413;2395.772401621843;2404.507076049406;2444.340028192396;127531;131830;131972;133269.33365333112;134198;14010.789838152436;14978.850211497745;15100.471483498244;15318.846811531965;15404.229788510755;22245.888770556045;23612.29163125109;23631.409214769767;23713;23788.52422951566;9953.651622193333;10055.296129271028;10063.748406289902;10218.540165692562;10313.174946004301;9296.95351523238;9371;9428.669996550088;9450.196733277611;9451.102145296185;9459.290553208537;9480.668176613786;9574.521273936276;9598.616055357847;9699.526620711815;2550.821442499044;2614.254937342886;2620.6331113644105;2657.0833062593374;2823.6046953426535;957.8467445208734;965.2712202287228;970.2383628851459;992.528548939248;993.2401712689798;19484.90257548703;19609.705854412194;19798.604027919362;20017.699734503993;20162.596748064956;998.9500524973722;1038.6676263595728;1062.3625824505234;1065.717584840018;1068.732816795801;10677.83983240252;10855.51150198243;11307.604233851776;13029.15310504814;13837.377318020714;477554;485102;485985;493957;498608;111883;113358;114602;115812;116409;1281.4169552853616;1303.4981532110205;1326.6285440076795;1335;1338.9933050334687;20593.176272949513;21217.893910530347;21704.457388565414;21741.565168696852;21825.454363641034;42539.635058331085;47830.521694782605;48957.26564101613;54966.450335496134;59912.40087599068;64087.35912640814;65794.67102664456;66214.33785662275;67690.66154669393;67776.32223677897;14596;14883.330250138553;14894.553163405115;14996.47512337063;15051.397944082551;21807.23674671379;21820;21837.4540636479;22167.77832221657;22236.555268894856;17401.47795566135;18081.457556273333;18110.456686299432;18113.45659630213;18147.546311341794;15268.618284542976;15309.311081001604;15993;16371.09958952269;16998.57503562421;17793.466196014142;17943.461696149137;18461.907690461463;18559.422449091977;18566.257349705862;14741.11553306805;14824.888133390255;14829.703405931605;14913.701725965202;14924.925375373054;15326.310316035582;17947.73078403851;17969.820301796815;18019.369322073664;18147.274109036018 09:56:56 INFO - PID 21875 | |3;mootools.html;1343.8588948160443;1395.1907893421817;1412.2373918084236;1412.9010969232154;1419.7515434798913;13540.593782186537;13791.931040344783;14186.645333866658;14328.21194834285;14357.569272921803;13862.653433664163;14628.122312661248;14637.26813659318;14666;14667.11997280164;2753.518134326495;2790.2884764385053;2791.916242512728;2795.0357126791223;2804.649418822647;2633.631291619175;2803.074985254861;2804.1867858321166;2804.5372513535244;2807.0035137526193;2740.3012231880944;2754.118682021754;2774.4589804988036;2791.6929137794828;2792.371716363822;2662.068276103358;2686.1001564475923;2696.36635390683;2706.9458610827774;2729.6997330293652;2636.973630263692;2675.919722408331;2687.005807851088;2688.690800557941;2690.6367640368494;13642.590722278348;13828.723425531534;13936.303184840819;13972.720545589133;14010;7539.283768042027;7791.571463569501;7803;7821.96089019557;7827.412944029221;4994.076095922266;5152.896942061176;5205.193195054772;5230.320058392423;5317.1492561190025;1719.8710096742668;1724.862011039114;1730.4462571976972;1773.4945540521019;1789.5168304557826;21450.14199432021;21506.89246553773;21561.137554497956;21676.891615541823;21744;6782.796516104525;6831.521793474509;7111.857762844714;7169.749058782918;7172.892406613905;15694.058356498646;15710.371585136467;15769.448069317748;15781.210939452982;15787.368505259661;7258.963705181546;7451.2921272479025;7477.962610186914;7487.138979017483;7494.812629684301;6803.081583986197;6933.68798404073;6942.097527321517;6984.965075174591;7015.89476157858;4956;5054.21659642756;5077.898442031213;5132.127538318495;5166.147585648401;1495.5588101510082;1498.5654160293393;1513.8940274180702;1517.0442621148607;1525.9847401525842;854.2055888024197;856.2379482260793;858.4205661178679;878.3851304087165;901.9774505637412;6933.861322773516;6935.375816176467;7059.5764254144915;7118.216996130422;7157.57054576727;713.4684659928387;726.1105146195973;977.8386566216494;996.1681995533811;1002.4737013068052;4808.663393562487;5019.648624596243;5213.296205012351;5419.756110975016;5427.841634738237;18399.26402943894;19791.505212369804;19852.801471985385;19857.801421985885;19859.801401985795;19013.33453329127;19264.518387040436;19378.418647440598;19465.513362165777;19505;10653.573857045787;10819.513121909533;10897.509612067475;10973.890261097447;10979.286346387618;7679.846403072019;7813.726519571787;8025.719099831478;8147.79630509242;8366.874496882674;16151.838481615034;16599.253033613757;16758.66482670364;17016.234269458153;17093.145342732565;16711.832881671027;17350.65298693994;17352.219150138022;17569;17610.119494025505;11529.423528823692;11798.587049453228;11806;11809.291442513477;11822.940885295518;11646.825297620711;12233.755324893631;12320.075994300285;12320.938395307967;12363.072769542141;9634.9036509634;10149.39103653783;10282.177425806067;10328.277020608786;10426.478676066015;9591.376560523544;9914.504274786088;10077.798444031225;10083.949580252052;10227.02843229892;9228.261739060725;9401.52992350366;9561.282903782105;9661.227101831695;9661.565229564545;6452.290248072803;6771.119754431892;6791.966040169767;6800.6599670017295;6933.826654333682;6499.902501462577;6581.506387020897;6860.965695171492;6947.096877405905;6948.444124469929 09:56:56 INFO - PID 21875 | |4;prototype.html;501.41835470853806;503.56441677948584;528.3342987835327;531.1925872673534;535.2853939990113;6171.413715697002;6219.937800621992;6237.46981506572;6238.282597501288;6265.968670156654;5913.85215369616;6109.480694141003;6144.784932527363;6169.4755945744555;6176.938230617692;4920.114379411704;4943.456219815817;4948.703077815343;4966.130927087764;4969.180085285923;4794.808207671689;4916.148633792392;4928.359313289286;4972.403311602613;5005.799768009275;4886.51134886512;4888.951110488885;4891.559759621633;4897.926531102036;4938.506149385051;4872.756362181876;4898.5591296783105;4906.215005599087;4909.3126962225315;4936.555709986083;4390.736555806629;4431.468223813131;4449.488308844459;4453.866384008485;4459.799309031101;5972.343042265347;6007.729652165663;6105.908411373833;6135.478484328793;6152.354002829683;5655.981923253813;5668.631538949955;5707.200991861143;5720.056190728525;5750.568707346965;6415.326390728953;6429.935700642981;6441.677916104223;6441.967790161066;6531.967340163316;4860.246661767396;4884.951150488485;4907.484714105003;4908.7300198489065;4919.360483137205;6844.110265665432;6851.07510486083;6882.621455819878;6920.273371296042;6941.826454338682;4963.875903102451;4978.228374601942;4993.675411098267;5017.724025178577;5035.244713292962;5027.572656324253;5092.872678183075;5103.209002604603;5146.536811686891;5172.19830926207;5661.603687741818;5719.685417302005;5726;5751.584334579403;5777.393373695785;6510.609363438209;6567.671616419256;6591.319213600501;6605.438537724252;6615.941449368078;1644.629958259406;1717.3645751072183;1730.368415528323;1761.3042848074938;1771.7253825657044;1036.6993571864225;1225.7609766095525;1225.982434579297;1238.2756087688622;1250.337321219755;5559.8888022239325;5567.582431317586;5675.602707810496;5752.33848107473;5764.596478246483;6636.30318816527;6646.933530664632;6660.500462465335;6687.859884836903;6709.563878347892;5645.181448689999;5665.150227465913;5705.263052700405;5719.370869204384;5758.596898217084;3488.587122215507;3542.468629705513;3574.98212508941;3577.3918433865783;3589.120665436985;6277.560570760094;6406.903896441557;6418.486521078303;6445.291017988017;6457.903131453032;6794.932050679528;6884.51808373419;6886.139232595926;6890.93109068913;6941.132358455193;6440.774572889926;6489.1888513935755;6505.772297969548;6546.18172728409;6550.639714815636;6618.8345291368105;6649.46804255668;6675.699593518206;6676.261293675558;6707.798766037026;6584.736610535717;6591.802245932629;6621.900671490028;6636.170478690164;6656.900146497709;6415.871682566416;6448.967755161382;6471.385218404244;6523.7716679915975;6541.345865413611;4971.552560269593;4990.476000019946;4997.775100120576;5005.174146265826;5043.823466178666;6591.901121483085;6729.932700672931;6828.863422731617;6833.248342682202;6844.726210951506;6331.810045698637;6398.5201109916015;6413.326600706859;6414.903776443451;6440.25937017249;6338.080978258219;6403.96798016007;6530.67346632676;6541.215054193527;6595.67021648906;6303.212098487689;6322.178116844781;6334.00478849161;6383.553151279366;6487.481001519773;6491.772787952399;6541.901871471837;6555.623853715436;6628.6022838627905;6639.634820084942;5585.245991791218;5972.671503067373;6213.782517611862;6254.874902502015;6277.591956522811 09:56:56 INFO - PID 21875 | |5;yui.html;914.300560071545;919.90800919908;938.6855403439847;947.540442885201;947.9146876781089;20459.99999999998;22465.55068898621;22469.55060898785;22481.55036899261;22513.437164070907;18991.430257092274;19711.901440492813;19796.60406791867;19830.305939292128;19871.205151793947;1034.2966782587819;1059.110347308261;1059.8887116852736;1059.9417032063234;1060.9893901061007;1016.9694909152737;1047.6909311753013;1053.0627741310202;1055.530289021386;1059.0838924330476;1102.8070087734654;1104.276698762308;1112.866456025278;1112.8720197177306;1114.6711720042606;1106.0543235533582;1107.5403707461394;1108.7948729485072;1108.8447617333538;1110.3116068037828;811.419834818102;815.8123631564773;816.3632366753941;816.8325493273865;817.3624572833199;18042.548936276566;18075.638487230182;18163.54591135232;18515.814841851545;20170.89914550418;19941.40175794714;20383.388498345073;20630.17479300826;20749.688754668692;20779;15758.921205393899;15891.841081589268;16007.599810004727;16045.839541604551;16089.517314480585;3570.1788588624763;3592.1558433768046;3595.94606080909;3596.982015089934;3612.8193590320643;119390;121099;121279.39360303231;125699.37150314281;127183;15626.296816643278;15629.765553516707;15761;15893.046417215004;15990.840091598935;29941.850290748407;30108.096757097323;30211.546826797614;30234.697653023628;30350.392992140034;8348.165183481604;8775.868361974575;8790.164934331227;8806.295496360275;8861.689840855539;3752.7560708553856;3771.773693578394;3794.5636251830842;3803.695704343646;3830.367989281793;5199.948000519947;5337.386200586904;5732.856678582985;6040.214772079602;6103.809757097323;1086.6794295682635;1117.1956191542076;1117.5027112934665;1128.142611615162;1135.0579019413867;653.6372313366032;659.4073160948186;681.4003676764415;708.6775517139689;709.9787006389713;11495.54017839277;12144.939275303743;12663.176893501894;12872.806907896389;13046.54337098197;675.9932400676029;691.3466773898617;695.3533214110926;707.1372925031557;716.6954044531053;5468.4531546845;5642.971785141048;5716.485516303469;5832.154337621021;5839.42333575931;104906;105148.47425762822;105992;106128;108480.57597120112;90248.00874282487;91457.54271228734;91667.54166229126;93177;93473.5326323364;79555.20444795478;83442.58278708567;86096.56951715202;86286.56856715676;86313;10579.5239214234;11070.612528561462;11140.665780026613;11390.487428065591;11465.254758440675;36390.99999999894;37247.57890737093;37473.437898432094;37689.43465848069;38846.80576597099;64397;65369.34630653823;66092.0086198717;66174.66912665406;70540.29459705338;18973;19138.425847224604;19312.517187070436;19434.125464353856;19467;20107;20334.491637709176;20475.59048819045;21437.892810535846;21506;18964.241430343183;19058.332958346393;19404.61190776205;19556.11997460146;19585.216591336757;18823.152958117193;19008.619827603095;19107.617847643247;19505.902470487556;19686.40940771779;18074.096295184925;18393.908030459763;18517.44447666572;19279;19310.227590896207;13990.510332138327;13994.650133746738;14087.366068526735;14220.146791192561;14233.715325693634;14375.640608984859;14389.7841532375;14884.330205140577;15177.317020733874;15351.539453816404 09:56:56 INFO - PID 21875 | __end_tp_report 09:56:56 INFO - PID 21875 | __start_cc_report 09:56:56 INFO - PID 21875 | _x_x_mozilla_cycle_collect,364 09:56:56 INFO - PID 21875 | __end_cc_report 09:56:56 INFO - PID 21875 | __startTimestamp1501001816433__endTimestamp 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | ------- Summary: start ------- 09:56:56 INFO - PID 21875 | Number of tests: 6 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#0] dojo.html Cycles:165 Average:6138.52 Median:6427.94 stddev:739.38 (11.5%) stddev-sans-first:702.50 09:56:56 INFO - PID 21875 | Values: 3112.4 3134.5 3135.4 3145.2 3177.4 6070.2 6297.4 6312.6 6314.7 6327.1 6032.5 6149.5 6155.5 6158.7 6162.3 5598.0 5617.7 5638.4 5648.1 5685.0 5651.9 5670.2 5673.5 5697.9 5759.7 5644.6 5688.6 5725.6 5756.8 5765.4 5565.3 5655.1 5675.9 5709.7 5729.8 5475.4 5553.3 5598.1 5644.7 5681.9 6060.3 6080.6 6118.6 6123.0 6179.2 6530.4 6584.9 6657.1 6697.2 6716.4 6630.4 6671.8 6798.4 6805.3 6806.1 6226.0 6252.8 6312.4 6323.7 6327.8 6856.0 6901.1 6941.7 6975.1 6993.4 6562.5 6588.9 6630.9 6667.3 6670.8 6629.3 6644.5 6693.7 6725.6 6732.1 6418.1 6632.4 6640.0 6721.9 6738.3 6516.5 6578.7 6580.5 6582.6 6594.8 5302.6 5305.1 5327.7 5373.4 5381.7 4516.4 4579.7 4595.7 4613.6 4626.2 5670.6 5738.7 5764.3 5777.4 5820.9 6642.7 6671.2 6673.8 6675.0 6688.1 5748.3 5750.8 5811.6 5830.1 5842.6 5810.7 5890.2 5892.7 5901.2 5905.2 6448.6 6462.9 6486.5 6546.6 6566.4 6566.4 6642.6 6651.2 6753.2 6759.5 6515.5 6525.6 6561.0 6580.5 6583.5 6572.0 6607.5 6627.0 6656.6 6681.6 6606.2 6681.8 6698.1 6754.4 6843.1 6513.9 6540.7 6558.9 6563.5 6567.3 6470.8 6481.1 6487.1 6573.2 6589.3 6235.7 6353.1 6383.5 6387.6 6490.4 6460.2 6522.4 6528.0 6604.6 6652.0 6322.7 6382.2 6427.9 6452.7 6484.5 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#1] ext.html Cycles:180 Average:38817.78 Median:19138.82 stddev:54754.71 (286.1%) stddev-sans-first:54834.08 09:56:56 INFO - PID 21875 | Values: 847.3 866.4 890.8 897.6 1176.6 31742.8 32416.0 43193.9 43868.6 44100.6 43502.0 44164.1 44209.8 44274.0 44297.8 5947.6 6078.8 7684.1 7753.6 7872.6 7703.8 7912.4 7912.4 7915.6 7916.6 7819.5 7854.3 7899.5 7911.7 7922.4 7791.8 7869.1 7877.8 7878.1 7879.2 7715.5 7723.2 7758.9 7769.8 7782.8 40020.0 40108.0 40164.0 40191.6 40215.6 3515.6 3536.6 3571.5 3573.4 3582.2 31804.2 31812.7 31879.5 32123.4 32126.2 4822.3 5032.0 5040.0 5040.9 5064.5 184804.0 185386.0 185555.0 186515.0 187306.1 50239.0 50341.5 50358.5 50408.0 50777.7 52916.5 52923.2 53095.0 53151.2 53203.0 16674.2 16880.7 17034.7 17053.4 17061.3 11815.2 12014.9 12827.9 13059.2 14031.4 13262.3 13422.6 13430.7 13588.4 13647.7 5209.5 5282.0 5298.2 5307.4 5358.7 1009.7 1010.1 1018.1 1027.9 1031.9 22523.2 28761.3 29180.0 29672.3 29742.1 1091.6 1104.3 1111.3 1127.9 1131.0 12397.8 12558.9 12597.8 12600.9 12679.5 235408.0 237537.0 237592.0 237593.0 238693.0 55211.0 55214.0 55282.0 55357.7 55400.2 1498.9 1504.6 1507.5 1521.8 1524.5 22012.5 22024.1 22276.6 22885.3 23067.8 51255.7 54120.2 54170.5 54376.7 54495.0 204494.0 205932.0 206452.0 206585.0 206780.0 31553.0 31992.2 34762.0 36427.0 36576.3 45576.5 45768.0 46005.3 46007.8 46419.3 31225.8 32427.8 33206.8 33826.7 33987.0 31905.0 32674.8 32729.5 32983.8 33097.2 36603.0 36626.3 36683.4 36693.8 36844.4 29616.6 31518.2 31586.8 31884.5 31975.8 22611.8 23219.7 23804.2 23815.2 24351.5 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#2] jquery.html Cycles:180 Average:34278.93 Median:22740.83 stddev:81955.95 (360.4%) stddev-sans-first:82146.83 09:56:56 INFO - PID 21875 | Values: 595.8 597.2 598.6 601.3 621.0 22015.8 22577.7 22904.0 22981.5 22993.1 26077.0 26551.9 26611.9 26643.3 26672.0 6486.4 6617.3 6637.2 6637.5 6638.8 6251.7 6529.9 6571.8 6580.8 6595.1 6510.4 6517.3 6528.8 6532.2 6542.3 6463.3 6487.8 6512.5 6513.6 6552.8 6040.0 6061.3 6082.6 6092.8 6127.2 27614.3 28923.6 29578.9 29760.4 29772.0 1908.5 1936.0 1938.7 1939.5 1944.6 18488.3 19048.6 19069.2 19090.7 19098.0 2364.6 2390.7 2395.8 2404.5 2444.3 127531.0 131830.0 131972.0 133269.3 134198.0 14010.8 14978.9 15100.5 15318.8 15404.2 22245.9 23612.3 23631.4 23713.0 23788.5 9953.7 10055.3 10063.7 10218.5 10313.2 9297.0 9371.0 9428.7 9450.2 9451.1 9459.3 9480.7 9574.5 9598.6 9699.5 2550.8 2614.3 2620.6 2657.1 2823.6 957.8 965.3 970.2 992.5 993.2 19484.9 19609.7 19798.6 20017.7 20162.6 999.0 1038.7 1062.4 1065.7 1068.7 10677.8 10855.5 11307.6 13029.2 13837.4 477554.0 485102.0 485985.0 493957.0 498608.0 111883.0 113358.0 114602.0 115812.0 116409.0 1281.4 1303.5 1326.6 1335.0 1339.0 20593.2 21217.9 21704.5 21741.6 21825.5 42539.6 47830.5 48957.3 54966.5 59912.4 64087.4 65794.7 66214.3 67690.7 67776.3 14596.0 14883.3 14894.6 14996.5 15051.4 21807.2 21820.0 21837.5 22167.8 22236.6 17401.5 18081.5 18110.5 18113.5 18147.5 15268.6 15309.3 15993.0 16371.1 16998.6 17793.5 17943.5 18461.9 18559.4 18566.3 14741.1 14824.9 14829.7 14913.7 14924.9 15326.3 17947.7 17969.8 18019.4 18147.3 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#3] mootools.html Cycles:180 Average:8621.04 Median:2693.50 stddev:5828.50 (216.4%) stddev-sans-first:5819.20 09:56:56 INFO - PID 21875 | Values: 1343.9 1395.2 1412.2 1412.9 1419.8 13540.6 13791.9 14186.6 14328.2 14357.6 13862.7 14628.1 14637.3 14666.0 14667.1 2753.5 2790.3 2791.9 2795.0 2804.6 2633.6 2803.1 2804.2 2804.5 2807.0 2740.3 2754.1 2774.5 2791.7 2792.4 2662.1 2686.1 2696.4 2706.9 2729.7 2637.0 2675.9 2687.0 2688.7 2690.6 13642.6 13828.7 13936.3 13972.7 14010.0 7539.3 7791.6 7803.0 7822.0 7827.4 4994.1 5152.9 5205.2 5230.3 5317.1 1719.9 1724.9 1730.4 1773.5 1789.5 21450.1 21506.9 21561.1 21676.9 21744.0 6782.8 6831.5 7111.9 7169.7 7172.9 15694.1 15710.4 15769.4 15781.2 15787.4 7259.0 7451.3 7478.0 7487.1 7494.8 6803.1 6933.7 6942.1 6985.0 7015.9 4956.0 5054.2 5077.9 5132.1 5166.1 1495.6 1498.6 1513.9 1517.0 1526.0 854.2 856.2 858.4 878.4 902.0 6933.9 6935.4 7059.6 7118.2 7157.6 713.5 726.1 977.8 996.2 1002.5 4808.7 5019.6 5213.3 5419.8 5427.8 18399.3 19791.5 19852.8 19857.8 19859.8 19013.3 19264.5 19378.4 19465.5 19505.0 10653.6 10819.5 10897.5 10973.9 10979.3 7679.8 7813.7 8025.7 8147.8 8366.9 16151.8 16599.3 16758.7 17016.2 17093.1 16711.8 17350.7 17352.2 17569.0 17610.1 11529.4 11798.6 11806.0 11809.3 11822.9 11646.8 12233.8 12320.1 12320.9 12363.1 9634.9 10149.4 10282.2 10328.3 10426.5 9591.4 9914.5 10077.8 10083.9 10227.0 9228.3 9401.5 9561.3 9661.2 9661.6 6452.3 6771.1 6792.0 6800.7 6933.8 6499.9 6581.5 6861.0 6947.1 6948.4 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#4] prototype.html Cycles:180 Average:5474.81 Median:6107.69 stddev:1537.50 (25.2%) stddev-sans-first:1495.82 09:56:56 INFO - PID 21875 | Values: 501.4 503.6 528.3 531.2 535.3 6171.4 6219.9 6237.5 6238.3 6266.0 5913.9 6109.5 6144.8 6169.5 6176.9 4920.1 4943.5 4948.7 4966.1 4969.2 4794.8 4916.1 4928.4 4972.4 5005.8 4886.5 4889.0 4891.6 4897.9 4938.5 4872.8 4898.6 4906.2 4909.3 4936.6 4390.7 4431.5 4449.5 4453.9 4459.8 5972.3 6007.7 6105.9 6135.5 6152.4 5656.0 5668.6 5707.2 5720.1 5750.6 6415.3 6429.9 6441.7 6442.0 6532.0 4860.2 4885.0 4907.5 4908.7 4919.4 6844.1 6851.1 6882.6 6920.3 6941.8 4963.9 4978.2 4993.7 5017.7 5035.2 5027.6 5092.9 5103.2 5146.5 5172.2 5661.6 5719.7 5726.0 5751.6 5777.4 6510.6 6567.7 6591.3 6605.4 6615.9 1644.6 1717.4 1730.4 1761.3 1771.7 1036.7 1225.8 1226.0 1238.3 1250.3 5559.9 5567.6 5675.6 5752.3 5764.6 6636.3 6646.9 6660.5 6687.9 6709.6 5645.2 5665.2 5705.3 5719.4 5758.6 3488.6 3542.5 3575.0 3577.4 3589.1 6277.6 6406.9 6418.5 6445.3 6457.9 6794.9 6884.5 6886.1 6890.9 6941.1 6440.8 6489.2 6505.8 6546.2 6550.6 6618.8 6649.5 6675.7 6676.3 6707.8 6584.7 6591.8 6621.9 6636.2 6656.9 6415.9 6449.0 6471.4 6523.8 6541.3 4971.6 4990.5 4997.8 5005.2 5043.8 6591.9 6729.9 6828.9 6833.2 6844.7 6331.8 6398.5 6413.3 6414.9 6440.3 6338.1 6404.0 6530.7 6541.2 6595.7 6303.2 6322.2 6334.0 6383.6 6487.5 6491.8 6541.9 6555.6 6628.6 6639.6 5585.2 5972.7 6213.8 6254.9 6277.6 09:56:56 INFO - PID 21875 | 09:56:56 INFO - PID 21875 | [#5] yui.html Cycles:180 Average:23278.38 Median:19754.25 stddev:30875.53 (156.3%) stddev-sans-first:30916.47 09:56:56 INFO - PID 21875 | Values: 914.3 919.9 938.7 947.5 947.9 20460.0 22465.6 22469.6 22481.6 22513.4 18991.4 19711.9 19796.6 19830.3 19871.2 1034.3 1059.1 1059.9 1059.9 1061.0 1017.0 1047.7 1053.1 1055.5 1059.1 1102.8 1104.3 1112.9 1112.9 1114.7 1106.1 1107.5 1108.8 1108.8 1110.3 811.4 815.8 816.4 816.8 817.4 18042.5 18075.6 18163.5 18515.8 20170.9 19941.4 20383.4 20630.2 20749.7 20779.0 15758.9 15891.8 16007.6 16045.8 16089.5 3570.2 3592.2 3595.9 3597.0 3612.8 119390.0 121099.0 121279.4 125699.4 127183.0 15626.3 15629.8 15761.0 15893.0 15990.8 29941.9 30108.1 30211.5 30234.7 30350.4 8348.2 8775.9 8790.2 8806.3 8861.7 3752.8 3771.8 3794.6 3803.7 3830.4 5199.9 5337.4 5732.9 6040.2 6103.8 1086.7 1117.2 1117.5 1128.1 1135.1 653.6 659.4 681.4 708.7 710.0 11495.5 12144.9 12663.2 12872.8 13046.5 676.0 691.3 695.4 707.1 716.7 5468.5 5643.0 5716.5 5832.2 5839.4 104906.0 105148.5 105992.0 106128.0 108480.6 90248.0 91457.5 91667.5 93177.0 93473.5 79555.2 83442.6 86096.6 86286.6 86313.0 10579.5 11070.6 11140.7 11390.5 11465.3 36391.0 37247.6 37473.4 37689.4 38846.8 64397.0 65369.3 66092.0 66174.7 70540.3 18973.0 19138.4 19312.5 19434.1 19467.0 20107.0 20334.5 20475.6 21437.9 21506.0 18964.2 19058.3 19404.6 19556.1 19585.2 18823.2 19008.6 19107.6 19505.9 19686.4 18074.1 18393.9 18517.4 19279.0 19310.2 13990.5 13994.7 14087.4 14220.1 14233.7 14375.6 14389.8 14884.3 15177.3 15351.5 09:56:56 INFO - PID 21875 | -------- Summary: end -------- 09:56:56 INFO - PID 21875 | 09:56:57 INFO - TEST-INFO | 21875: exit 0 09:56:57 INFO - TEST-OK | dromaeo_css | took 1114728ms 09:56:57 INFO - TEST-START | kraken 09:56:57 INFO - Initialising browser for kraken test... 09:56:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45461/getInfo.html -profile /tmp/tmpmzv2GV/profile 09:56:57 INFO - TEST-INFO | started process 22245 (/builds/slave/test/build/application/firefox/firefox http://localhost:45461/getInfo.html) 09:57:04 INFO - TEST-INFO | 22245: exit 0 09:57:04 INFO - Browser initialized. 09:57:04 INFO - Running cycle 1/1 for kraken test... 09:57:04 INFO - TEST-INFO | started process 22473 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmzv2GV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:05 INFO - PID 22473 | 09:57:05 INFO - PID 22473 | (/builds/slave/test/build/application/firefox/firefox:22528): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 09:57:05 INFO - PID 22473 | 09:57:15 INFO - PID 22473 | RSS: Main: 171900928 09:57:15 INFO - PID 22473 | 09:57:18 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45461/tests/kraken/driver.html?testName=audio-beat-detection) 09:57:19 INFO - PID 22473 | RSS: Main: 178184192 09:57:19 INFO - PID 22473 | 09:57:22 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45461/tests/kraken/driver.html?testName=audio-dft) 09:57:22 INFO - PID 22473 | RSS: Main: 179175424 09:57:22 INFO - PID 22473 | 09:57:25 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45461/tests/kraken/driver.html?testName=audio-fft) 09:57:26 INFO - PID 22473 | RSS: Main: 173445120 09:57:26 INFO - PID 22473 | 09:57:28 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45461/tests/kraken/driver.html?testName=audio-oscillator) 09:57:29 INFO - PID 22473 | RSS: Main: 174202880 09:57:29 INFO - PID 22473 | 09:57:31 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:31 INFO - PID 22473 | RSS: Main: 174350336 09:57:31 INFO - PID 22473 | 09:57:34 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45461/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:35 INFO - PID 22473 | RSS: Main: 177291264 09:57:35 INFO - PID 22473 | 09:57:39 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45461/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:39 INFO - PID 22473 | RSS: Main: 176893952 09:57:39 INFO - PID 22473 | 09:57:42 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45461/tests/kraken/driver.html?testName=json-parse-financial) 09:57:43 INFO - PID 22473 | RSS: Main: 177876992 09:57:43 INFO - PID 22473 | 09:57:44 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:45 INFO - PID 22473 | RSS: Main: 177516544 09:57:45 INFO - PID 22473 | 09:57:47 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:47 INFO - PID 22473 | RSS: Main: 175263744 09:57:47 INFO - PID 22473 | 09:57:50 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:50 INFO - PID 22473 | RSS: Main: 175202304 09:57:50 INFO - PID 22473 | 09:57:53 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:54 INFO - PID 22473 | RSS: Main: 176066560 09:57:54 INFO - PID 22473 | 09:57:57 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:57 INFO - PID 22473 | RSS: Main: 175366144 09:57:57 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | Cycle 1(1): loaded http://localhost:45461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45461/tests/kraken/driver.html?testName=ai-astar) 09:57:59 INFO - PID 22473 | RSS: Main: 176955392 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | __start_tp_report 09:57:59 INFO - PID 22473 | _x_x_mozilla_page_load 09:57:59 INFO - PID 22473 | _x_x_mozilla_page_load_details 09:57:59 INFO - PID 22473 | |i|pagename|runs| 09:57:59 INFO - PID 22473 | |0;ai-astar;100;110;104;111;111;111;112;100;110;110 09:57:59 INFO - PID 22473 | |1;audio-beat-detection;143;118;144;186;119;149;151;122;171;116 09:57:59 INFO - PID 22473 | |2;audio-dft;164;162;162;163;162;163;167;172;165;164 09:57:59 INFO - PID 22473 | |3;audio-fft;74;75;76;177;75;74;78;90;100;76 09:57:59 INFO - PID 22473 | |4;audio-oscillator;80;81;143;81;82;81;132;82;83;136 09:57:59 INFO - PID 22473 | |5;imaging-gaussian-blur;114;114;114;114;114;117;115;114;114;115 09:57:59 INFO - PID 22473 | |6;imaging-darkroom;149;150;151;152;150;151;149;152;150;152 09:57:59 INFO - PID 22473 | |7;imaging-desaturate;95;94;94;95;94;94;94;93;94;94 09:57:59 INFO - PID 22473 | |8;json-parse-financial;58;56;58;56;56;55;56;55;58;55 09:57:59 INFO - PID 22473 | |9;json-stringify-tinderbox;54;53;54;54;54;55;54;54;55;55 09:57:59 INFO - PID 22473 | |10;stanford-crypto-aes;80;79;79;85;80;87;79;79;78;77 09:57:59 INFO - PID 22473 | |11;stanford-crypto-ccm;135;141;139;125;124;137;125;131;128;194 09:57:59 INFO - PID 22473 | |12;stanford-crypto-pbkdf2;185;175;180;173;194;173;191;171;172;172 09:57:59 INFO - PID 22473 | |13;stanford-crypto-sha256-iterative;71;70;68;68;69;67;67;68;68;70 09:57:59 INFO - PID 22473 | __end_tp_report 09:57:59 INFO - PID 22473 | __start_cc_report 09:57:59 INFO - PID 22473 | _x_x_mozilla_cycle_collect,965 09:57:59 INFO - PID 22473 | __end_cc_report 09:57:59 INFO - PID 22473 | __startTimestamp1501001879973__endTimestamp 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | ------- Summary: start ------- 09:57:59 INFO - PID 22473 | Number of tests: 14 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.50 stddev:4.70 (4.3%) stddev-sans-first:4.02 09:57:59 INFO - PID 22473 | Values: 100.0 110.0 104.0 111.0 111.0 111.0 112.0 100.0 110.0 110.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:146.50 stddev:23.79 (16.2%) stddev-sans-first:25.23 09:57:59 INFO - PID 22473 | Values: 143.0 118.0 144.0 186.0 119.0 149.0 151.0 122.0 171.0 116.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.10 (1.9%) stddev-sans-first:3.28 09:57:59 INFO - PID 22473 | Values: 164.0 162.0 162.0 163.0 162.0 163.0 167.0 172.0 165.0 164.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.50 stddev:31.91 (42.3%) stddev-sans-first:33.35 09:57:59 INFO - PID 22473 | Values: 74.0 75.0 76.0 177.0 75.0 74.0 78.0 90.0 100.0 76.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:81.00 stddev:26.98 (33.3%) stddev-sans-first:27.81 09:57:59 INFO - PID 22473 | Values: 80.0 81.0 143.0 81.0 82.0 81.0 132.0 82.0 83.0 136.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 09:57:59 INFO - PID 22473 | Values: 114.0 114.0 114.0 114.0 114.0 117.0 115.0 114.0 114.0 115.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:1.17 (0.8%) stddev-sans-first:1.09 09:57:59 INFO - PID 22473 | Values: 149.0 150.0 151.0 152.0 150.0 151.0 149.0 152.0 150.0 152.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:57:59 INFO - PID 22473 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:1.25 (2.2%) stddev-sans-first:1.17 09:57:59 INFO - PID 22473 | Values: 58.0 56.0 58.0 56.0 56.0 55.0 56.0 55.0 58.0 55.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 09:57:59 INFO - PID 22473 | Values: 54.0 53.0 54.0 54.0 54.0 55.0 54.0 54.0 55.0 55.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.50 stddev:3.16 (4.0%) stddev-sans-first:3.35 09:57:59 INFO - PID 22473 | Values: 80.0 79.0 79.0 85.0 80.0 87.0 79.0 79.0 78.0 77.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.00 stddev:20.65 (15.2%) stddev-sans-first:21.88 09:57:59 INFO - PID 22473 | Values: 135.0 141.0 139.0 125.0 124.0 137.0 125.0 131.0 128.0 194.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:177.50 stddev:8.53 (4.8%) stddev-sans-first:8.72 09:57:59 INFO - PID 22473 | Values: 185.0 175.0 180.0 173.0 194.0 173.0 191.0 171.0 172.0 172.0 09:57:59 INFO - PID 22473 | 09:57:59 INFO - PID 22473 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.12 09:57:59 INFO - PID 22473 | Values: 71.0 70.0 68.0 68.0 69.0 67.0 67.0 68.0 68.0 70.0 09:57:59 INFO - PID 22473 | -------- Summary: end -------- 09:57:59 INFO - PID 22473 | 09:58:00 INFO - PID 22473 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 09:58:00 INFO - TEST-INFO | 22473: exit 0 09:58:00 INFO - TEST-OK | kraken | took 63538ms 09:58:00 INFO - SUITE-END | took 1178s 09:58:01 INFO - Completed test suite (00:19:38) 09:58:01 INFO - javascript benchmark 09:58:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8493.409690078315, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.393083348748, 3134.5454909038185, 3135.435621588113, 3145.1508092814934, 3177.412178746932, 6070.150178974947, 6297.433231009209, 6312.589681670694, 6314.7474101035905, 6327.114204011431, 6032.517398608112, 6149.4772944299675, 6155.507559395249, 6158.6612736299485, 6162.291336496304, 5597.972010139943, 5617.691026993513, 5638.4361563843495, 5648.124540696199, 5684.971575142118, 5651.9152212716635, 5670.206171136044, 5673.546116310686, 5697.914531282034, 5759.654420734749, 5644.604877658566, 5688.63023903447, 5725.570582206351, 5756.769729210827, 5765.394633563478, 5565.30433695788, 5655.095184770417, 5675.858103547403, 5709.685967271777, 5729.799457019005, 5475.425080366544, 5553.305836770403, 5598.104303311491, 5644.74598643062, 5681.9431805681825, 6060.33336333003, 6080.604760690541, 6118.632882027048, 6122.96938515309, 6179.19670442844, 6530.44491218247, 6584.880570303012, 6657.068010478537, 6697.162854643169, 6716.361945615159, 6630.370114839083, 6671.833204169935, 6798.422134118557, 6805.251422343587, 6806.149231346082, 6226.034964580497, 6252.843678908018, 6312.431881130628, 6323.683815809237, 6327.8418039548915, 6856.005879147496, 6901.068355771907, 6941.652917354112, 6975.128108986377, 6993.405560527311, 6562.475001999924, 6588.901166482507, 6630.86738265232, 6667.266600673922, 6670.7665231716655, 6629.303923088007, 6644.501662375341, 6693.665316734144, 6725.630090345078, 6732.091167692299, 6418.101465794793, 6632.403083722488, 6639.966800165968, 6721.899171512431, 6738.326167383222, 6516.478681705452, 6578.703958321887, 6580.473562115019, 6582.572132811352, 6594.769183078569, 5302.575793936476, 5305.124654431976, 5327.706976116273, 5373.408925018245, 5381.67709937405, 4516.412866327422, 4579.702319349299, 4595.701279416827, 4613.63090952723, 4626.236670949323, 5670.631408958405, 5738.655680659091, 5764.250647415809, 5777.364489906107, 5820.923129221108, 6642.7342906284175, 6671.199456065303, 6673.799786006428, 6675.0, 6688.097106890605, 5748.281464816898, 5750.827475175752, 5811.622244554091, 5830.096335068071, 5842.649441033552, 5810.709464526757, 5890.204822349014, 5892.734826932712, 5901.232839730807, 5905.232319798484, 6448.580842245239, 6462.935370646327, 6486.513511486657, 6546.639934803631, 6566.409023187936, 6566.376194261537, 6642.568233064835, 6651.16860392451, 6753.15585551806, 6759.493038022069, 6515.511336649865, 6525.575837570543, 6561.0, 6580.473562115115, 6583.539152259296, 6571.96714016446, 6607.47140228771, 6627.039079333566, 6656.633885136171, 6681.599104053772, 6606.240282367397, 6681.799546013627, 6698.129243198353, 6754.425873800782, 6843.110395648534, 6513.902291465537, 6540.672966351759, 6558.934410655832, 6563.474922006323, 6567.277599464151, 6470.838229044123, 6481.125048118443, 6487.059376390492, 6573.211214654272, 6589.308122647053, 6235.688215589294, 6353.078803573363, 6383.489320854228, 6387.616742995435, 6490.415862572202, 6460.192475940507, 6522.445592124533, 6528.0, 6604.636744979072, 6652.0, 6322.747090116344, 6382.170317858649, 6427.939390000597, 6452.677366131768, 6484.481241500763], "value": 6082.141077609637, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [847.2882778466092, 866.3762091294268, 890.8307421589898, 897.6319708919344, 1176.6234804862447, 31742.84128579357, 32416.0, 43193.92015199618, 43868.56131438685, 44100.55899441004, 43502.0, 44164.11671766563, 44209.77895110528, 44274.0, 44297.7785111074, 5947.583669143161, 6078.787242446515, 7684.116326622426, 7753.573553454557, 7872.606369681522, 7703.8074048148965, 7912.367010639164, 7912.367010639164, 7915.643796029164, 7916.604169791487, 7819.5308281503, 7854.293113619773, 7899.526028438283, 7911.723089691862, 7922.445428819985, 7791.766247012571, 7869.134395216522, 7877.842443151162, 7878.054633444023, 7879.172686867911, 7715.498492597963, 7723.189065148191, 7758.883616745753, 7769.766906992742, 7782.844343113106, 40020.0, 40108.0, 40164.0, 40191.598084019075, 40215.597844021475, 3515.6484351564895, 3536.5579302587175, 3571.499990001402, 3573.392523271024, 3582.158192824684, 31804.20489487758, 31812.6818731812, 31879.52180717291, 32123.35753284921, 32126.196845078826, 4822.252550854623, 5032.043911656773, 5040.0, 5040.899182016376, 5064.544191022789, 184804.0, 185386.0, 185555.0, 186515.0, 187306.06346968314, 50239.0, 50341.49658503368, 50358.49641503611, 50408.0, 50777.74611126921, 52916.470835291926, 52923.206151907754, 53095.0, 53151.20273195828, 53203.0, 16674.166291685367, 16880.662386752196, 17034.74447883283, 17053.40313089061, 17061.31754729822, 11815.172937894265, 12014.879851201551, 12827.871721282854, 13059.21644701321, 14031.438742450391, 13262.336883155996, 13422.597322080353, 13430.664233394047, 13588.38852251651, 13647.727045459234, 5209.453007434241, 5281.973590132025, 5298.178782288752, 5307.363116426053, 5358.705271210121, 1009.7223263602422, 1010.1363334349026, 1018.0786388318584, 1027.9434631095212, 1031.8761748590066, 22523.211687590854, 28761.280967975967, 29179.95955964935, 29672.2581935449, 29742.10773676793, 1091.5536913589367, 1104.3373975614568, 1111.349860331699, 1127.9097672186206, 1130.9773804524027, 12397.814032789516, 12558.87441125577, 12597.788776243271, 12600.936995315147, 12679.492820287085, 235408.0, 237537.0, 237592.0, 237593.0, 238693.0, 55211.0, 55214.0, 55282.0, 55357.72321138449, 55400.168997464265, 1498.9400423983136, 1504.608801711541, 1507.4949891786155, 1521.786949827003, 1524.4511975688965, 22012.547644607803, 22024.11903523841, 22276.554468910206, 22885.31344059681, 23067.769322307235, 51255.74372128116, 54120.188197177864, 54170.45829541654, 54376.72811635916, 54495.0, 204494.0, 205932.0, 206452.0, 206585.0, 206780.0, 31553.0, 31992.200194995312, 34762.0, 36427.0, 36576.26847463089, 45576.54423455723, 45768.0, 46005.309920350555, 46007.769961151316, 46419.30371044505, 31225.8438707805, 32427.837860811487, 33206.83396583002, 33826.66173338235, 33987.0, 31905.0, 32674.83662581672, 32729.50905736368, 32983.83508082444, 33097.17257068593, 36603.0, 36626.26747464982, 36683.44974825433, 36693.816530917175, 36844.447333289485, 29616.555751664175, 31518.212044699067, 31586.842065790443, 31884.521732173573, 31975.840120800178, 22611.773882260968, 23219.651705224773, 23804.166854160023, 23815.166469173495, 24351.51296974015], "value": 17593.48261009496, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7616953218712, 597.2206270816582, 598.6029283814354, 601.2814686449692, 620.9565330426869, 22015.779842201595, 22577.661335079985, 22904.0, 22981.540369192648, 22993.08027678893, 26077.0, 26551.86724066377, 26611.866940665317, 26643.333916652093, 26672.0, 6486.3513648635235, 6617.272100068989, 6637.1703537057865, 6637.46900247979, 6638.800835974905, 6251.749930002795, 6529.902051469232, 6571.835704107388, 6580.80257592273, 6595.142631457904, 6510.414062734353, 6517.250516190627, 6528.804135875931, 6532.216134063919, 6542.280349161612, 6463.256725476536, 6487.772927947546, 6512.479001679854, 6513.609183449008, 6552.770653027145, 6039.969800151015, 6061.272647282311, 6082.5742198046155, 6092.756289748405, 6127.172831667713, 27614.309642258904, 28923.56614650782, 29578.85210573955, 29760.36318002509, 29772.0, 1908.4847091285415, 1936.0126335568962, 1938.7188857615567, 1939.524816419972, 1944.6402415553168, 18488.2604695812, 19048.61902761951, 19069.237230510764, 19090.71363929528, 19098.0, 2364.609839376501, 2390.6653068570413, 2395.772401621843, 2404.507076049406, 2444.340028192396, 127531.0, 131830.0, 131972.0, 133269.33365333112, 134198.0, 14010.789838152436, 14978.850211497745, 15100.471483498244, 15318.846811531965, 15404.229788510755, 22245.888770556045, 23612.29163125109, 23631.409214769767, 23713.0, 23788.52422951566, 9953.651622193333, 10055.296129271028, 10063.748406289902, 10218.540165692562, 10313.174946004301, 9296.95351523238, 9371.0, 9428.669996550088, 9450.196733277611, 9451.102145296185, 9459.290553208537, 9480.668176613786, 9574.521273936276, 9598.616055357847, 9699.526620711815, 2550.821442499044, 2614.254937342886, 2620.6331113644105, 2657.0833062593374, 2823.6046953426535, 957.8467445208734, 965.2712202287228, 970.2383628851459, 992.528548939248, 993.2401712689798, 19484.90257548703, 19609.705854412194, 19798.604027919362, 20017.699734503993, 20162.596748064956, 998.9500524973722, 1038.6676263595728, 1062.3625824505234, 1065.717584840018, 1068.732816795801, 10677.83983240252, 10855.51150198243, 11307.604233851776, 13029.15310504814, 13837.377318020714, 477554.0, 485102.0, 485985.0, 493957.0, 498608.0, 111883.0, 113358.0, 114602.0, 115812.0, 116409.0, 1281.4169552853616, 1303.4981532110205, 1326.6285440076795, 1335.0, 1338.9933050334687, 20593.176272949513, 21217.893910530347, 21704.457388565414, 21741.565168696852, 21825.454363641034, 42539.635058331085, 47830.521694782605, 48957.26564101613, 54966.450335496134, 59912.40087599068, 64087.35912640814, 65794.67102664456, 66214.33785662275, 67690.66154669393, 67776.32223677897, 14596.0, 14883.330250138553, 14894.553163405115, 14996.47512337063, 15051.397944082551, 21807.23674671379, 21820.0, 21837.4540636479, 22167.77832221657, 22236.555268894856, 17401.47795566135, 18081.457556273333, 18110.456686299432, 18113.45659630213, 18147.546311341794, 15268.618284542976, 15309.311081001604, 15993.0, 16371.09958952269, 16998.57503562421, 17793.466196014142, 17943.461696149137, 18461.907690461463, 18559.422449091977, 18566.257349705862, 14741.11553306805, 14824.888133390255, 14829.703405931605, 14913.701725965202, 14924.925375373054, 15326.310316035582, 17947.73078403851, 17969.820301796815, 18019.369322073664, 18147.274109036018], "value": 11976.103303900869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.8588948160443, 1395.1907893421817, 1412.2373918084236, 1412.9010969232154, 1419.7515434798913, 13540.593782186537, 13791.931040344783, 14186.645333866658, 14328.21194834285, 14357.569272921803, 13862.653433664163, 14628.122312661248, 14637.26813659318, 14666.0, 14667.11997280164, 2753.518134326495, 2790.2884764385053, 2791.916242512728, 2795.0357126791223, 2804.649418822647, 2633.631291619175, 2803.074985254861, 2804.1867858321166, 2804.5372513535244, 2807.0035137526193, 2740.3012231880944, 2754.118682021754, 2774.4589804988036, 2791.6929137794828, 2792.371716363822, 2662.068276103358, 2686.1001564475923, 2696.36635390683, 2706.9458610827774, 2729.6997330293652, 2636.973630263692, 2675.919722408331, 2687.005807851088, 2688.690800557941, 2690.6367640368494, 13642.590722278348, 13828.723425531534, 13936.303184840819, 13972.720545589133, 14010.0, 7539.283768042027, 7791.571463569501, 7803.0, 7821.96089019557, 7827.412944029221, 4994.076095922266, 5152.896942061176, 5205.193195054772, 5230.320058392423, 5317.1492561190025, 1719.8710096742668, 1724.862011039114, 1730.4462571976972, 1773.4945540521019, 1789.5168304557826, 21450.14199432021, 21506.89246553773, 21561.137554497956, 21676.891615541823, 21744.0, 6782.796516104525, 6831.521793474509, 7111.857762844714, 7169.749058782918, 7172.892406613905, 15694.058356498646, 15710.371585136467, 15769.448069317748, 15781.210939452982, 15787.368505259661, 7258.963705181546, 7451.2921272479025, 7477.962610186914, 7487.138979017483, 7494.812629684301, 6803.081583986197, 6933.68798404073, 6942.097527321517, 6984.965075174591, 7015.89476157858, 4956.0, 5054.21659642756, 5077.898442031213, 5132.127538318495, 5166.147585648401, 1495.5588101510082, 1498.5654160293393, 1513.8940274180702, 1517.0442621148607, 1525.9847401525842, 854.2055888024197, 856.2379482260793, 858.4205661178679, 878.3851304087165, 901.9774505637412, 6933.861322773516, 6935.375816176467, 7059.5764254144915, 7118.216996130422, 7157.57054576727, 713.4684659928387, 726.1105146195973, 977.8386566216494, 996.1681995533811, 1002.4737013068052, 4808.663393562487, 5019.648624596243, 5213.296205012351, 5419.756110975016, 5427.841634738237, 18399.26402943894, 19791.505212369804, 19852.801471985385, 19857.801421985885, 19859.801401985795, 19013.33453329127, 19264.518387040436, 19378.418647440598, 19465.513362165777, 19505.0, 10653.573857045787, 10819.513121909533, 10897.509612067475, 10973.890261097447, 10979.286346387618, 7679.846403072019, 7813.726519571787, 8025.719099831478, 8147.79630509242, 8366.874496882674, 16151.838481615034, 16599.253033613757, 16758.66482670364, 17016.234269458153, 17093.145342732565, 16711.832881671027, 17350.65298693994, 17352.219150138022, 17569.0, 17610.119494025505, 11529.423528823692, 11798.587049453228, 11806.0, 11809.291442513477, 11822.940885295518, 11646.825297620711, 12233.755324893631, 12320.075994300285, 12320.938395307967, 12363.072769542141, 9634.9036509634, 10149.39103653783, 10282.177425806067, 10328.277020608786, 10426.478676066015, 9591.376560523544, 9914.504274786088, 10077.798444031225, 10083.949580252052, 10227.02843229892, 9228.261739060725, 9401.52992350366, 9561.282903782105, 9661.227101831695, 9661.565229564545, 6452.290248072803, 6771.119754431892, 6791.966040169767, 6800.6599670017295, 6933.826654333682, 6499.902501462577, 6581.506387020897, 6860.965695171492, 6947.096877405905, 6948.444124469929], "value": 6322.537289233893, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.41835470853806, 503.56441677948584, 528.3342987835327, 531.1925872673534, 535.2853939990113, 6171.413715697002, 6219.937800621992, 6237.46981506572, 6238.282597501288, 6265.968670156654, 5913.85215369616, 6109.480694141003, 6144.784932527363, 6169.4755945744555, 6176.938230617692, 4920.114379411704, 4943.456219815817, 4948.703077815343, 4966.130927087764, 4969.180085285923, 4794.808207671689, 4916.148633792392, 4928.359313289286, 4972.403311602613, 5005.799768009275, 4886.51134886512, 4888.951110488885, 4891.559759621633, 4897.926531102036, 4938.506149385051, 4872.756362181876, 4898.5591296783105, 4906.215005599087, 4909.3126962225315, 4936.555709986083, 4390.736555806629, 4431.468223813131, 4449.488308844459, 4453.866384008485, 4459.799309031101, 5972.343042265347, 6007.729652165663, 6105.908411373833, 6135.478484328793, 6152.354002829683, 5655.981923253813, 5668.631538949955, 5707.200991861143, 5720.056190728525, 5750.568707346965, 6415.326390728953, 6429.935700642981, 6441.677916104223, 6441.967790161066, 6531.967340163316, 4860.246661767396, 4884.951150488485, 4907.484714105003, 4908.7300198489065, 4919.360483137205, 6844.110265665432, 6851.07510486083, 6882.621455819878, 6920.273371296042, 6941.826454338682, 4963.875903102451, 4978.228374601942, 4993.675411098267, 5017.724025178577, 5035.244713292962, 5027.572656324253, 5092.872678183075, 5103.209002604603, 5146.536811686891, 5172.19830926207, 5661.603687741818, 5719.685417302005, 5726.0, 5751.584334579403, 5777.393373695785, 6510.609363438209, 6567.671616419256, 6591.319213600501, 6605.438537724252, 6615.941449368078, 1644.629958259406, 1717.3645751072183, 1730.368415528323, 1761.3042848074938, 1771.7253825657044, 1036.6993571864225, 1225.7609766095525, 1225.982434579297, 1238.2756087688622, 1250.337321219755, 5559.8888022239325, 5567.582431317586, 5675.602707810496, 5752.33848107473, 5764.596478246483, 6636.30318816527, 6646.933530664632, 6660.500462465335, 6687.859884836903, 6709.563878347892, 5645.181448689999, 5665.150227465913, 5705.263052700405, 5719.370869204384, 5758.596898217084, 3488.587122215507, 3542.468629705513, 3574.98212508941, 3577.3918433865783, 3589.120665436985, 6277.560570760094, 6406.903896441557, 6418.486521078303, 6445.291017988017, 6457.903131453032, 6794.932050679528, 6884.51808373419, 6886.139232595926, 6890.93109068913, 6941.132358455193, 6440.774572889926, 6489.1888513935755, 6505.772297969548, 6546.18172728409, 6550.639714815636, 6618.8345291368105, 6649.46804255668, 6675.699593518206, 6676.261293675558, 6707.798766037026, 6584.736610535717, 6591.802245932629, 6621.900671490028, 6636.170478690164, 6656.900146497709, 6415.871682566416, 6448.967755161382, 6471.385218404244, 6523.7716679915975, 6541.345865413611, 4971.552560269593, 4990.476000019946, 4997.775100120576, 5005.174146265826, 5043.823466178666, 6591.901121483085, 6729.932700672931, 6828.863422731617, 6833.248342682202, 6844.726210951506, 6331.810045698637, 6398.5201109916015, 6413.326600706859, 6414.903776443451, 6440.25937017249, 6338.080978258219, 6403.96798016007, 6530.67346632676, 6541.215054193527, 6595.67021648906, 6303.212098487689, 6322.178116844781, 6334.00478849161, 6383.553151279366, 6487.481001519773, 6491.772787952399, 6541.901871471837, 6555.623853715436, 6628.6022838627905, 6639.634820084942, 5585.245991791218, 5972.671503067373, 6213.782517611862, 6254.874902502015, 6277.591956522811], "value": 5022.896383368584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.300560071545, 919.90800919908, 938.6855403439847, 947.540442885201, 947.9146876781089, 20459.99999999998, 22465.55068898621, 22469.55060898785, 22481.55036899261, 22513.437164070907, 18991.430257092274, 19711.901440492813, 19796.60406791867, 19830.305939292128, 19871.205151793947, 1034.2966782587819, 1059.110347308261, 1059.8887116852736, 1059.9417032063234, 1060.9893901061007, 1016.9694909152737, 1047.6909311753013, 1053.0627741310202, 1055.530289021386, 1059.0838924330476, 1102.8070087734654, 1104.276698762308, 1112.866456025278, 1112.8720197177306, 1114.6711720042606, 1106.0543235533582, 1107.5403707461394, 1108.7948729485072, 1108.8447617333538, 1110.3116068037828, 811.419834818102, 815.8123631564773, 816.3632366753941, 816.8325493273865, 817.3624572833199, 18042.548936276566, 18075.638487230182, 18163.54591135232, 18515.814841851545, 20170.89914550418, 19941.40175794714, 20383.388498345073, 20630.17479300826, 20749.688754668692, 20779.0, 15758.921205393899, 15891.841081589268, 16007.599810004727, 16045.839541604551, 16089.517314480585, 3570.1788588624763, 3592.1558433768046, 3595.94606080909, 3596.982015089934, 3612.8193590320643, 119390.0, 121099.0, 121279.39360303231, 125699.37150314281, 127183.0, 15626.296816643278, 15629.765553516707, 15761.0, 15893.046417215004, 15990.840091598935, 29941.850290748407, 30108.096757097323, 30211.546826797614, 30234.697653023628, 30350.392992140034, 8348.165183481604, 8775.868361974575, 8790.164934331227, 8806.295496360275, 8861.689840855539, 3752.7560708553856, 3771.773693578394, 3794.5636251830842, 3803.695704343646, 3830.367989281793, 5199.948000519947, 5337.386200586904, 5732.856678582985, 6040.214772079602, 6103.809757097323, 1086.6794295682635, 1117.1956191542076, 1117.5027112934665, 1128.142611615162, 1135.0579019413867, 653.6372313366032, 659.4073160948186, 681.4003676764415, 708.6775517139689, 709.9787006389713, 11495.54017839277, 12144.939275303743, 12663.176893501894, 12872.806907896389, 13046.54337098197, 675.9932400676029, 691.3466773898617, 695.3533214110926, 707.1372925031557, 716.6954044531053, 5468.4531546845, 5642.971785141048, 5716.485516303469, 5832.154337621021, 5839.42333575931, 104906.0, 105148.47425762822, 105992.0, 106128.0, 108480.57597120112, 90248.00874282487, 91457.54271228734, 91667.54166229126, 93177.0, 93473.5326323364, 79555.20444795478, 83442.58278708567, 86096.56951715202, 86286.56856715676, 86313.0, 10579.5239214234, 11070.612528561462, 11140.665780026613, 11390.487428065591, 11465.254758440675, 36390.99999999894, 37247.57890737093, 37473.437898432094, 37689.43465848069, 38846.80576597099, 64397.0, 65369.34630653823, 66092.0086198717, 66174.66912665406, 70540.29459705338, 18973.0, 19138.425847224604, 19312.517187070436, 19434.125464353856, 19467.0, 20107.0, 20334.491637709176, 20475.59048819045, 21437.892810535846, 21506.0, 18964.241430343183, 19058.332958346393, 19404.61190776205, 19556.11997460146, 19585.216591336757, 18823.152958117193, 19008.619827603095, 19107.617847643247, 19505.902470487556, 19686.40940771779, 18074.096295184925, 18393.908030459763, 18517.44447666572, 19279.0, 19310.227590896207, 13990.510332138327, 13994.650133746738, 14087.366068526735, 14220.146791192561, 14233.715325693634, 14375.640608984859, 14389.7841532375, 14884.330205140577, 15177.317020733874, 15351.539453816404], "value": 9223.488180865059, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 104.0, 111.0, 111.0, 111.0, 112.0, 100.0, 110.0, 110.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 144.0, 186.0, 119.0, 149.0, 151.0, 122.0, 171.0, 116.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 163.0, 162.0, 163.0, 167.0, 172.0, 165.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 177.0, 75.0, 74.0, 78.0, 90.0, 100.0, 76.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 143.0, 81.0, 82.0, 81.0, 132.0, 82.0, 83.0, 136.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 115.0, 114.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 151.0, 152.0, 150.0, 151.0, 149.0, 152.0, 150.0, 152.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 58.0, 56.0, 56.0, 55.0, 56.0, 55.0, 58.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 85.0, 80.0, 87.0, 79.0, 79.0, 78.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 139.0, 125.0, 124.0, 137.0, 125.0, 131.0, 128.0, 194.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 175.0, 180.0, 173.0, 194.0, 173.0, 191.0, 171.0, 172.0, 172.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 68.0, 68.0, 69.0, 67.0, 67.0, 68.0, 68.0, 70.0], "value": 68.6, "unit": "score"}]}]} 09:58:01 INFO - Return code: 0 09:58:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:58:01 INFO - # TBPL SUCCESS # 09:58:01 INFO - Running post-action listener: _package_coverage_data 09:58:01 INFO - Running post-action listener: _resource_record_post_action 09:58:01 INFO - [mozharness: 2017-07-25 16:58:01.241322Z] Finished run-tests step (success) 09:58:01 INFO - Running post-run listener: _resource_record_post_run 09:58:01 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433115136; Read time: 4; Write time: 520896 09:58:01 INFO - TinderboxPrint: CPU usage
13.2% 09:58:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:58:01 INFO - TinderboxPrint: I/O write bytes / time
433,115,136 / 520,896 09:58:01 INFO - TinderboxPrint: CPU idle
8,282.3 (86.8%) 09:58:01 INFO - TinderboxPrint: CPU user
1,202.7 (12.6%) 09:58:01 INFO - TinderboxPrint: Swap in / out
0 / 0 09:58:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107630592; Read time: 0; Write time: 148308 09:58:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:58:01 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 325484544; Read time: 0; Write time: 372588 09:58:01 INFO - Running post-run listener: _upload_blobber_files 09:58:01 INFO - Blob upload gear active. 09:58:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:58:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:58:01 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'] 09:58:01 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 09:58:02 INFO - (blobuploader) - INFO - Open directory for files ... 09:58:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:58:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:03 INFO - (blobuploader) - INFO - Done attempting. 09:58:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:58:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:10 INFO - (blobuploader) - INFO - Done attempting. 09:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:10 INFO - (blobuploader) - INFO - Done attempting. 09:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:58:11 INFO - (blobuploader) - INFO - Done attempting. 09:58:11 INFO - (blobuploader) - INFO - Iteration through files over. 09:58:11 INFO - Return code: 0 09:58:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:58:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:58:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80c23aad81e822053ca032798b8c158962d864677e4b102e94db7ed63a4788ebcdf0478c1de719803f286ce2183a5c270ba5e27a27d12ff6e96ad6428965765f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530ec4f7b1f17e1e2774e96891c72de75d72ea29ab872d90fef923a17599f5d97dc722c09707ee1eb96589b19e5e189edb1b6b6816d26b3dd6c541181ffa3ff7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0818c377116f2879ec7004c003e8a675eb610d0f9d82cc77c08a6457f5ac78ebd9521ec7edb2d32d1624c0bd498cb7b3462db0ec47cebac20aab47308659f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd5d9db081a377f9767970e77a1f3c34f68d17aa96c81acf439f9e09399e13b72d155a3e52b654305e2ceaaa1c9afb708702e3c8a6b83eb2a39925a4d86e392"} 09:58:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:58:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:58:11 INFO - Contents: 09:58:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80c23aad81e822053ca032798b8c158962d864677e4b102e94db7ed63a4788ebcdf0478c1de719803f286ce2183a5c270ba5e27a27d12ff6e96ad6428965765f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530ec4f7b1f17e1e2774e96891c72de75d72ea29ab872d90fef923a17599f5d97dc722c09707ee1eb96589b19e5e189edb1b6b6816d26b3dd6c541181ffa3ff7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0818c377116f2879ec7004c003e8a675eb610d0f9d82cc77c08a6457f5ac78ebd9521ec7edb2d32d1624c0bd498cb7b3462db0ec47cebac20aab47308659f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd5d9db081a377f9767970e77a1f3c34f68d17aa96c81acf439f9e09399e13b72d155a3e52b654305e2ceaaa1c9afb708702e3c8a6b83eb2a39925a4d86e392"} 09:58:11 INFO - Running post-run listener: copy_logs_to_upload_dir 09:58:11 INFO - Copying logs to upload dir... 09:58:11 INFO - mkdir: /builds/slave/test/build/upload/logs 09:58:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.451027 ========= master_lag: 0.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-25 09:58:12.024083) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 09:58:12.025178) ========= 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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 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/80c23aad81e822053ca032798b8c158962d864677e4b102e94db7ed63a4788ebcdf0478c1de719803f286ce2183a5c270ba5e27a27d12ff6e96ad6428965765f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530ec4f7b1f17e1e2774e96891c72de75d72ea29ab872d90fef923a17599f5d97dc722c09707ee1eb96589b19e5e189edb1b6b6816d26b3dd6c541181ffa3ff7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0818c377116f2879ec7004c003e8a675eb610d0f9d82cc77c08a6457f5ac78ebd9521ec7edb2d32d1624c0bd498cb7b3462db0ec47cebac20aab47308659f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd5d9db081a377f9767970e77a1f3c34f68d17aa96c81acf439f9e09399e13b72d155a3e52b654305e2ceaaa1c9afb708702e3c8a6b83eb2a39925a4d86e392"} build_url:https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/fWUCQvL-S1mphvFnR8y4xA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/80c23aad81e822053ca032798b8c158962d864677e4b102e94db7ed63a4788ebcdf0478c1de719803f286ce2183a5c270ba5e27a27d12ff6e96ad6428965765f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/530ec4f7b1f17e1e2774e96891c72de75d72ea29ab872d90fef923a17599f5d97dc722c09707ee1eb96589b19e5e189edb1b6b6816d26b3dd6c541181ffa3ff7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0818c377116f2879ec7004c003e8a675eb610d0f9d82cc77c08a6457f5ac78ebd9521ec7edb2d32d1624c0bd498cb7b3462db0ec47cebac20aab47308659f2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ddd5d9db081a377f9767970e77a1f3c34f68d17aa96c81acf439f9e09399e13b72d155a3e52b654305e2ceaaa1c9afb708702e3c8a6b83eb2a39925a4d86e392"}' ========= master_lag: 0.22 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 09:58:12.261005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:58:12.261378) ========= 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=df17445c3590ff7897617a0e00000225-1500998109.572346-1826234505 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 09:58:12.302893) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 09:58:12.313369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 09:58:13.042768) ========= ========= Total master_lag: 1.24 =========