builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1503267469.05 results: success (0) revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.053958) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.054412) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.054681) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.071690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.072066) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 15:17:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.3M=0s 2017-08-20 15:17:49 (68.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.360853 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.448288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.448598) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016992 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.504943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:49.505341) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --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 7dddbd85047c6dc73ddbe1e423cd643a217845b3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 15:17:49,778 truncating revision to first 12 chars 2017-08-20 15:17:49,778 Setting DEBUG logging. 2017-08-20 15:17:49,778 attempt 1/10 2017-08-20 15:17:49,778 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7dddbd85047c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 15:17:50,106 unpacking tar archive at: mozilla-central-7dddbd85047c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:50.197439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:50.197906) ========= script_repo_revision: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:50.198380) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:50.198655) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 15:17:50.211125) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-20 15:17:50.211555) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:17:50 INFO - MultiFileLogger online at 20170820 15:17:50 in /builds/slave/test 15:17:50 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 15:17:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:17:50 INFO - {'append_to_log': False, 15:17:50 INFO - 'base_work_dir': '/builds/slave/test', 15:17:50 INFO - 'blob_upload_branch': 'Firefox', 15:17:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:17:50 INFO - 'branch': 'Firefox', 15:17:50 INFO - 'buildbot_json_path': 'buildprops.json', 15:17:50 INFO - 'code_coverage': False, 15:17:50 INFO - 'config_files': ('talos/linux_config.py',), 15:17:50 INFO - 'default_actions': ('clobber', 15:17:50 INFO - 'read-buildbot-config', 15:17:50 INFO - 'download-and-extract', 15:17:50 INFO - 'populate-webroot', 15:17:50 INFO - 'create-virtualenv', 15:17:50 INFO - 'install', 15:17:50 INFO - 'setup-mitmproxy', 15:17:50 INFO - 'run-tests'), 15:17:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:17:50 INFO - 'disable_ccov_upload': False, 15:17:50 INFO - 'download_minidump_stackwalk': True, 15:17:50 INFO - 'download_symbols': 'ondemand', 15:17:50 INFO - 'enable_stylo': False, 15:17:50 INFO - 'enable_webrender': False, 15:17:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:17:50 INFO - 'tooltool.py': '/tools/tooltool.py', 15:17:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:17:50 INFO - '/tools/misc-python/virtualenv.py')}, 15:17:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:17:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:17:50 INFO - 'gecko_profile': False, 15:17:50 INFO - 'gecko_profile_interval': 0, 15:17:50 INFO - 'installer_path': 'installer.exe', 15:17:50 INFO - 'log_level': 'info', 15:17:50 INFO - 'log_name': 'talos', 15:17:50 INFO - 'log_to_console': True, 15:17:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:17:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:17:50 INFO - 'opt_config_files': (), 15:17:50 INFO - 'pip_index': False, 15:17:50 INFO - 'suite': 'dromaeojs-e10s', 15:17:50 INFO - 'system_bits': '32', 15:17:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:17:50 INFO - 'title': 'talos-linux64-ix-003', 15:17:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:17:50 INFO - 'use_talos_json': True, 15:17:50 INFO - 'verify': 'False', 15:17:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:17:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:17:50 INFO - 'work_dir': 'build'} 15:17:50 INFO - [mozharness: 2017-08-20 22:17:50.626192Z] Running clobber step. 15:17:50 INFO - Running pre-action listener: _resource_record_pre_action 15:17:50 INFO - Running main action method: clobber 15:17:50 INFO - rmtree: /builds/slave/test/build 15:17:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:17:52 INFO - Running post-action listener: _resource_record_post_action 15:17:52 INFO - [mozharness: 2017-08-20 22:17:52.257569Z] Finished clobber step (success) 15:17:52 INFO - [mozharness: 2017-08-20 22:17:52.257666Z] Running read-buildbot-config step. 15:17:52 INFO - Running pre-action listener: _resource_record_pre_action 15:17:52 INFO - Running main action method: read_buildbot_config 15:17:52 INFO - Using buildbot properties: 15:17:52 INFO - { 15:17:52 INFO - "project": "", 15:17:52 INFO - "product": "firefox", 15:17:52 INFO - "who": "archaeopteryx@coole-files.de", 15:17:52 INFO - "installer_path": "public/build/target.tar.bz2", 15:17:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 15:17:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:17:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 15:17:52 INFO - "stage_platform": "linux64-stylo", 15:17:52 INFO - "basedir": "/builds/slave/test", 15:17:52 INFO - "buildnumber": 47, 15:17:52 INFO - "platform": "ubuntu64_hw_stylo", 15:17:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:17:52 INFO - "slavebuilddir": "test", 15:17:52 INFO - "taskId": "XgKUOvKoTtum_Lqp0w9Xdg", 15:17:52 INFO - "branch": "mozilla-central", 15:17:52 INFO - "script_repo_revision": "production", 15:17:52 INFO - "revision": "7dddbd85047c6dc73ddbe1e423cd643a217845b3", 15:17:52 INFO - "slavename": "talos-linux64-ix-003", 15:17:52 INFO - "repo_path": "mozilla-central" 15:17:52 INFO - } 15:17:52 INFO - Finding installer, test and symbols from parent task. 15:17:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgKUOvKoTtum_Lqp0w9Xdg'}, attempt #1 15:17:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XgKUOvKoTtum_Lqp0w9Xdg'}, attempt #1 15:17:53 INFO - Task dependencies: W2sfHt0TS8KDAxRbisPdNA 15:17:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA'}, attempt #1 15:17:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:17:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip 15:17:53 INFO - Running post-action listener: _resource_record_post_action 15:17:53 INFO - [mozharness: 2017-08-20 22:17:53.596184Z] Finished read-buildbot-config step (success) 15:17:53 INFO - [mozharness: 2017-08-20 22:17:53.596399Z] Running download-and-extract step. 15:17:53 INFO - Running pre-action listener: _resource_record_pre_action 15:17:53 INFO - Running main action method: download_and_extract 15:17:53 INFO - mkdir: /builds/slave/test/build/tests 15:17:53 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')]} 15:17:53 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json 15:17:53 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:17:54 INFO - Downloaded 989 bytes. 15:17:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:17:54 INFO - Using the following test package requirements: 15:17:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:17:54 INFO - u'common': [u'target.common.tests.zip'], 15:17:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:17:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:17:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:17:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:17:54 INFO - u'mozbase': [u'target.common.tests.zip'], 15:17:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:17:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:17:54 INFO - u'web-platform': [u'target.common.tests.zip', 15:17:54 INFO - u'target.web-platform.tests.tar.gz'], 15:17:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:17:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:17:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:17:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:17:54 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:17:55 INFO - Content-Length response header: 54005757 15:17:55 INFO - Bytes received: 54005757 15:18:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:18:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip 15:18:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:18:06 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.common.tests.zip into memory 15:18:07 INFO - Content-Length response header: 54005757 15:18:07 INFO - Bytes received: 54005757 15:18:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip 15:18:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:18:22 INFO - Fetch https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.talos.tests.zip into memory 15:18:23 INFO - Content-Length response header: 14496256 15:18:23 INFO - Bytes received: 14496256 15:18:23 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')]} 15:18:23 INFO - trying https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:23 INFO - Downloading https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:18:24 INFO - Downloaded 62126211 bytes. 15:18:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:24 INFO - mkdir: /builds/slave/test/properties 15:18:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:18:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:18:24 INFO - Contents: 15:18:24 INFO - build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 15:18:24 INFO - Running post-action listener: _resource_record_post_action 15:18:24 INFO - Running post-action listener: find_tests_for_verification 15:18:24 INFO - Running post-action listener: set_extra_try_arguments 15:18:24 INFO - [mozharness: 2017-08-20 22:18:24.429476Z] Finished download-and-extract step (success) 15:18:24 INFO - [mozharness: 2017-08-20 22:18:24.429572Z] Running populate-webroot step. 15:18:24 INFO - Running pre-action listener: _resource_record_pre_action 15:18:24 INFO - Running main action method: populate_webroot 15:18:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:18:24 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:18:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:18:24 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:18:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:24 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:18:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'tests': ['damp', 'tps']}, 15:18:24 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['damp', 'tps']}, 15:18:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:18:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:18:24 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:18:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:24 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:18:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:18:24 INFO - 'ts_paint', 15:18:24 INFO - 'tpaint', 15:18:24 INFO - 'sessionrestore', 15:18:24 INFO - 'sessionrestore_many_windows', 15:18:24 INFO - 'sessionrestore_no_auto_restore', 15:18:24 INFO - 'tabpaint']}, 15:18:24 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['a11yr', 15:18:24 INFO - 'ts_paint', 15:18:24 INFO - 'tpaint', 15:18:24 INFO - 'sessionrestore', 15:18:24 INFO - 'sessionrestore_many_windows', 15:18:24 INFO - 'sessionrestore_no_auto_restore', 15:18:24 INFO - 'tabpaint']}, 15:18:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:18:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:18:24 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['bloom_basic_singleton']}, 15:18:24 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['bloom_basic']}, 15:18:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:18:24 INFO - 'tsvgr_opacity', 15:18:24 INFO - 'tart', 15:18:24 INFO - 'tscrollx', 15:18:24 INFO - 'tsvg_static']}, 15:18:24 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['tsvgx', 15:18:24 INFO - 'tsvgr_opacity', 15:18:24 INFO - 'tart', 15:18:24 INFO - 'tscrollx', 15:18:24 INFO - 'tsvg_static']}, 15:18:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:18:24 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--stylo'], 15:18:24 INFO - 'tests': ['tp5o']}, 15:18:24 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:24 INFO - 'talos_options': ['--mitmproxy', 15:18:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:24 INFO - '--firstNonBlankPaint'], 15:18:24 INFO - 'tests': ['tp6_google', 15:18:24 INFO - 'tp6_youtube', 15:18:24 INFO - 'tp6_amazon', 15:18:24 INFO - 'tp6_facebook']}, 15:18:24 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:24 INFO - 'talos_options': ['--stylo', 15:18:24 INFO - '--mitmproxy', 15:18:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:24 INFO - '--firstNonBlankPaint'], 15:18:24 INFO - 'tests': ['tp6_google', 15:18:24 INFO - 'tp6_youtube', 15:18:24 INFO - 'tp6_amazon', 15:18:24 INFO - 'tp6_facebook']}, 15:18:24 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:18:24 INFO - 'talos_options': ['--stylo', 15:18:24 INFO - '--stylo-threads=1', 15:18:24 INFO - '--mitmproxy', 15:18:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:18:24 INFO - '--firstNonBlankPaint'], 15:18:24 INFO - 'tests': ['tp6_google', 15:18:24 INFO - 'tp6_youtube', 15:18:24 INFO - 'tp6_amazon', 15:18:24 INFO - 'tp6_facebook']}, 15:18:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--xperf_path', 15:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:24 INFO - 'tests': ['tp5n']}, 15:18:24 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 15:18:24 INFO - 'talos_options': ['--stylo', 15:18:24 INFO - '--xperf_path', 15:18:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:18:24 INFO - 'tests': ['tp5n']}}} 15:18:24 INFO - Running post-action listener: _resource_record_post_action 15:18:24 INFO - [mozharness: 2017-08-20 22:18:24.443695Z] Finished populate-webroot step (success) 15:18:24 INFO - [mozharness: 2017-08-20 22:18:24.443783Z] Running create-virtualenv step. 15:18:24 INFO - Running pre-action listener: _resource_record_pre_action 15:18:24 INFO - Running main action method: create_virtualenv 15:18:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:18:24 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 15:18:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:18:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:18:24 INFO - Using real prefix '/usr' 15:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:18:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:18:27 INFO - Installing pip.................done. 15:18:27 INFO - Return code: 0 15:18:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:18:27 INFO - Reading from file tmpfile_stdout 15:18:27 INFO - Output received: 15:18:27 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) 15:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:18:27 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')]} 15:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:27 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')]} 15:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:27 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:27 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 15:18:27 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 15:18:27 INFO - Using env: {'DISPLAY': ':0', 15:18:27 INFO - 'HOME': '/home/cltbld', 15:18:27 INFO - 'LANG': 'en_US.UTF-8', 15:18:27 INFO - 'LANGUAGE': 'en_US:en', 15:18:27 INFO - 'LOGNAME': 'cltbld', 15:18:27 INFO - 'MAIL': '/var/mail/cltbld', 15:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:27 INFO - 'MOZ_NO_REMOTE': '1', 15:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:27 INFO - 'NO_EM_RESTART': '1', 15:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:27 INFO - 'PWD': '/builds/slave/test', 15:18:27 INFO - 'SHELL': '/bin/bash', 15:18:27 INFO - 'SHLVL': '1', 15:18:27 INFO - 'TERM': 'linux', 15:18:27 INFO - 'TMOUT': '86400', 15:18:27 INFO - 'USER': 'cltbld', 15:18:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:27 INFO - '_': '/tools/buildbot/bin/python'} 15:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:27 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 15:18:27 INFO - Cleaning up... 15:18:27 INFO - Return code: 0 15:18:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:18:27 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')]} 15:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:27 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')]} 15:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:27 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:27 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 15:18:27 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 15:18:27 INFO - Using env: {'DISPLAY': ':0', 15:18:27 INFO - 'HOME': '/home/cltbld', 15:18:27 INFO - 'LANG': 'en_US.UTF-8', 15:18:27 INFO - 'LANGUAGE': 'en_US:en', 15:18:27 INFO - 'LOGNAME': 'cltbld', 15:18:27 INFO - 'MAIL': '/var/mail/cltbld', 15:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:27 INFO - 'MOZ_NO_REMOTE': '1', 15:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:27 INFO - 'NO_EM_RESTART': '1', 15:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:27 INFO - 'PWD': '/builds/slave/test', 15:18:27 INFO - 'SHELL': '/bin/bash', 15:18:27 INFO - 'SHLVL': '1', 15:18:27 INFO - 'TERM': 'linux', 15:18:27 INFO - 'TMOUT': '86400', 15:18:27 INFO - 'USER': 'cltbld', 15:18:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:27 INFO - '_': '/tools/buildbot/bin/python'} 15:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:27 INFO - Downloading/unpacking psutil>=3.1.1 15:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:18:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:28 INFO - Installing collected packages: psutil 15:18:28 INFO - Running setup.py install for psutil 15:18:28 INFO - building 'psutil._psutil_linux' extension 15:18:28 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 15:18:29 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 15:18:29 INFO - building 'psutil._psutil_posix' extension 15:18:29 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 15:18:29 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 15:18:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:18:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:18:29 INFO - Successfully installed psutil 15:18:29 INFO - Cleaning up... 15:18:29 INFO - Return code: 0 15:18:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:18:29 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')]} 15:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:29 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')]} 15:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:29 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:29 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 15:18:29 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 15:18:29 INFO - Using env: {'DISPLAY': ':0', 15:18:29 INFO - 'HOME': '/home/cltbld', 15:18:29 INFO - 'LANG': 'en_US.UTF-8', 15:18:29 INFO - 'LANGUAGE': 'en_US:en', 15:18:29 INFO - 'LOGNAME': 'cltbld', 15:18:29 INFO - 'MAIL': '/var/mail/cltbld', 15:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:29 INFO - 'MOZ_NO_REMOTE': '1', 15:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:29 INFO - 'NO_EM_RESTART': '1', 15:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:29 INFO - 'PWD': '/builds/slave/test', 15:18:29 INFO - 'SHELL': '/bin/bash', 15:18:29 INFO - 'SHLVL': '1', 15:18:29 INFO - 'TERM': 'linux', 15:18:29 INFO - 'TMOUT': '86400', 15:18:29 INFO - 'USER': 'cltbld', 15:18:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:29 INFO - '_': '/tools/buildbot/bin/python'} 15:18:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:18:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:18:30 INFO - Installing collected packages: mozsystemmonitor 15:18:30 INFO - Running setup.py install for mozsystemmonitor 15:18:30 INFO - Successfully installed mozsystemmonitor 15:18:30 INFO - Cleaning up... 15:18:30 INFO - Return code: 0 15:18:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:30 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:30 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 15:18:30 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 15:18:30 INFO - Using env: {'DISPLAY': ':0', 15:18:30 INFO - 'HOME': '/home/cltbld', 15:18:30 INFO - 'LANG': 'en_US.UTF-8', 15:18:30 INFO - 'LANGUAGE': 'en_US:en', 15:18:30 INFO - 'LOGNAME': 'cltbld', 15:18:30 INFO - 'MAIL': '/var/mail/cltbld', 15:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:30 INFO - 'MOZ_NO_REMOTE': '1', 15:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:30 INFO - 'NO_EM_RESTART': '1', 15:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:30 INFO - 'PWD': '/builds/slave/test', 15:18:30 INFO - 'SHELL': '/bin/bash', 15:18:30 INFO - 'SHLVL': '1', 15:18:30 INFO - 'TERM': 'linux', 15:18:30 INFO - 'TMOUT': '86400', 15:18:30 INFO - 'USER': 'cltbld', 15:18:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:30 INFO - '_': '/tools/buildbot/bin/python'} 15:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:31 INFO - Downloading/unpacking jsonschema==2.5.1 15:18:31 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 15:18:31 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 15:18:31 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 15:18:31 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 15:18:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:18:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 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 15:18:32 INFO - Downloading functools32-3.2.3-2.tar.gz 15:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:18:32 INFO - warning: no files found matching '*.txt' 15:18:32 INFO - no previously-included directories found matching 'build' 15:18:32 INFO - no previously-included directories found matching 'dist' 15:18:32 INFO - no previously-included directories found matching '.git*' 15:18:32 INFO - Installing collected packages: jsonschema, functools32 15:18:32 INFO - Running setup.py install for functools32 15:18:32 INFO - warning: no files found matching '*.txt' 15:18:32 INFO - no previously-included directories found matching 'build' 15:18:32 INFO - no previously-included directories found matching 'dist' 15:18:32 INFO - no previously-included directories found matching '.git*' 15:18:32 INFO - Successfully installed jsonschema functools32 15:18:32 INFO - Cleaning up... 15:18:32 INFO - Return code: 0 15:18:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:18:32 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')]} 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:32 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')]} 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:32 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:32 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 15:18:32 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 15:18:32 INFO - Using env: {'DISPLAY': ':0', 15:18:32 INFO - 'HOME': '/home/cltbld', 15:18:32 INFO - 'LANG': 'en_US.UTF-8', 15:18:32 INFO - 'LANGUAGE': 'en_US:en', 15:18:32 INFO - 'LOGNAME': 'cltbld', 15:18:32 INFO - 'MAIL': '/var/mail/cltbld', 15:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:32 INFO - 'MOZ_NO_REMOTE': '1', 15:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:32 INFO - 'NO_EM_RESTART': '1', 15:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:32 INFO - 'PWD': '/builds/slave/test', 15:18:32 INFO - 'SHELL': '/bin/bash', 15:18:32 INFO - 'SHLVL': '1', 15:18:32 INFO - 'TERM': 'linux', 15:18:32 INFO - 'TMOUT': '86400', 15:18:32 INFO - 'USER': 'cltbld', 15:18:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:32 INFO - '_': '/tools/buildbot/bin/python'} 15:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:18:32 INFO - Cleaning up... 15:18:32 INFO - Return code: 0 15:18:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:18:32 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')]} 15:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:32 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')]} 15:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:32 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:32 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 15:18:32 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 15:18:32 INFO - Using env: {'DISPLAY': ':0', 15:18:32 INFO - 'HOME': '/home/cltbld', 15:18:32 INFO - 'LANG': 'en_US.UTF-8', 15:18:32 INFO - 'LANGUAGE': 'en_US:en', 15:18:32 INFO - 'LOGNAME': 'cltbld', 15:18:32 INFO - 'MAIL': '/var/mail/cltbld', 15:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:32 INFO - 'MOZ_NO_REMOTE': '1', 15:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:32 INFO - 'NO_EM_RESTART': '1', 15:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:32 INFO - 'PWD': '/builds/slave/test', 15:18:32 INFO - 'SHELL': '/bin/bash', 15:18:32 INFO - 'SHLVL': '1', 15:18:32 INFO - 'TERM': 'linux', 15:18:32 INFO - 'TMOUT': '86400', 15:18:32 INFO - 'USER': 'cltbld', 15:18:32 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:32 INFO - '_': '/tools/buildbot/bin/python'} 15:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:33 INFO - Downloading/unpacking blobuploader==1.2.4 15:18:33 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 15:18:33 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 15:18:33 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 15:18:33 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 15:18:34 INFO - Downloading blobuploader-1.2.4.tar.gz 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:18:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:18:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 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 15:18:34 INFO - Downloading docopt-0.6.1.tar.gz 15:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:18:34 INFO - Installing collected packages: blobuploader, requests, docopt 15:18:34 INFO - Running setup.py install for blobuploader 15:18:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:18:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:18:34 INFO - Running setup.py install for requests 15:18:35 INFO - Running setup.py install for docopt 15:18:35 INFO - Successfully installed blobuploader requests docopt 15:18:35 INFO - Cleaning up... 15:18:35 INFO - Return code: 0 15:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:35 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:35 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 15:18:35 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 15:18:35 INFO - Using env: {'DISPLAY': ':0', 15:18:35 INFO - 'HOME': '/home/cltbld', 15:18:35 INFO - 'LANG': 'en_US.UTF-8', 15:18:35 INFO - 'LANGUAGE': 'en_US:en', 15:18:35 INFO - 'LOGNAME': 'cltbld', 15:18:35 INFO - 'MAIL': '/var/mail/cltbld', 15:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:35 INFO - 'MOZ_NO_REMOTE': '1', 15:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:35 INFO - 'NO_EM_RESTART': '1', 15:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:35 INFO - 'PWD': '/builds/slave/test', 15:18:35 INFO - 'SHELL': '/bin/bash', 15:18:35 INFO - 'SHLVL': '1', 15:18:35 INFO - 'TERM': 'linux', 15:18:35 INFO - 'TMOUT': '86400', 15:18:35 INFO - 'USER': 'cltbld', 15:18:35 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:35 INFO - '_': '/tools/buildbot/bin/python'} 15:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:35 INFO - Running setup.py (path:/tmp/pip-ok4gkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:35 INFO - Running setup.py (path:/tmp/pip-WMuufo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:35 INFO - Running setup.py (path:/tmp/pip-MR39ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:35 INFO - Running setup.py (path:/tmp/pip-dryPSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:35 INFO - Running setup.py (path:/tmp/pip-7Aj18g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:35 INFO - Running setup.py (path:/tmp/pip-kYC5BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:36 INFO - Running setup.py (path:/tmp/pip-IaLjRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:36 INFO - Running setup.py (path:/tmp/pip-Unti_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:36 INFO - Running setup.py (path:/tmp/pip-vbR1oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:36 INFO - Running setup.py (path:/tmp/pip-9wYpBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:36 INFO - Running setup.py (path:/tmp/pip-pKAyqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:36 INFO - Running setup.py (path:/tmp/pip-gb1Tve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:36 INFO - Running setup.py (path:/tmp/pip-AQ49g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:36 INFO - Running setup.py (path:/tmp/pip-E_HC1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:36 INFO - Running setup.py (path:/tmp/pip-DbX8X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:36 INFO - Running setup.py (path:/tmp/pip-glGs7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:36 INFO - Running setup.py (path:/tmp/pip-up24fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:18:36 INFO - Running setup.py install for manifestparser 15:18:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:18:36 INFO - Running setup.py install for mozcrash 15:18:37 INFO - Running setup.py install for mozdebug 15:18:37 INFO - Running setup.py install for mozdevice 15:18:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozfile 15:18:37 INFO - Running setup.py install for mozhttpd 15:18:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozinfo 15:18:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozInstall 15:18:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozleak 15:18:37 INFO - Running setup.py install for mozlog 15:18:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for moznetwork 15:18:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:18:37 INFO - Running setup.py install for mozprocess 15:18:38 INFO - Running setup.py install for mozprofile 15:18:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozrunner 15:18:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Running setup.py install for mozscreenshot 15:18:38 INFO - Running setup.py install for moztest 15:18:38 INFO - Running setup.py install for mozversion 15:18:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:18:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:18:38 INFO - Cleaning up... 15:18:38 INFO - Return code: 0 15:18:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:38 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')]} 15:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:38 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')]} 15:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:38 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:38 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 15:18:38 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 15:18:38 INFO - Using env: {'DISPLAY': ':0', 15:18:38 INFO - 'HOME': '/home/cltbld', 15:18:38 INFO - 'LANG': 'en_US.UTF-8', 15:18:38 INFO - 'LANGUAGE': 'en_US:en', 15:18:38 INFO - 'LOGNAME': 'cltbld', 15:18:38 INFO - 'MAIL': '/var/mail/cltbld', 15:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:38 INFO - 'MOZ_NO_REMOTE': '1', 15:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:38 INFO - 'NO_EM_RESTART': '1', 15:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:38 INFO - 'PWD': '/builds/slave/test', 15:18:38 INFO - 'SHELL': '/bin/bash', 15:18:38 INFO - 'SHLVL': '1', 15:18:38 INFO - 'TERM': 'linux', 15:18:38 INFO - 'TMOUT': '86400', 15:18:38 INFO - 'USER': 'cltbld', 15:18:38 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:38 INFO - '_': '/tools/buildbot/bin/python'} 15:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:18:38 INFO - Running setup.py (path:/tmp/pip-M668Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:18:38 INFO - Running setup.py (path:/tmp/pip-FsLCaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:18:38 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)) 15:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:18:38 INFO - Running setup.py (path:/tmp/pip-NoXcTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:18:39 INFO - Running setup.py (path:/tmp/pip-bbD5cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:18:39 INFO - Running setup.py (path:/tmp/pip-fhqBxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:18:39 INFO - Running setup.py (path:/tmp/pip-RKtRrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:18:39 INFO - Running setup.py (path:/tmp/pip-C5UGhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:18:39 INFO - Running setup.py (path:/tmp/pip-TKxSYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:18:39 INFO - Running setup.py (path:/tmp/pip-QMkNHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:18:39 INFO - Running setup.py (path:/tmp/pip-R43HAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:18:39 INFO - Running setup.py (path:/tmp/pip-j524rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:18:39 INFO - Running setup.py (path:/tmp/pip-aZGnrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:18:39 INFO - Running setup.py (path:/tmp/pip-WJGFVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:18:39 INFO - Running setup.py (path:/tmp/pip-mg2FdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:39 INFO - Running setup.py (path:/tmp/pip-AaMPCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:18:39 INFO - Running setup.py (path:/tmp/pip-0hqeBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:18:39 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)) 15:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:18:39 INFO - Running setup.py (path:/tmp/pip-wR3lQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 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)) 15:18:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:41 INFO - Downloading blessings-1.6.tar.gz 15:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:18:41 INFO - Installing collected packages: blessings 15:18:41 INFO - Running setup.py install for blessings 15:18:41 INFO - Successfully installed blessings 15:18:41 INFO - Cleaning up... 15:18:41 INFO - Return code: 0 15:18:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:18:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:41 INFO - Reading from file tmpfile_stdout 15:18:41 INFO - Current package versions: 15:18:41 INFO - argparse == 1.2.1 15:18:41 INFO - blessings == 1.6 15:18:41 INFO - blobuploader == 1.2.4 15:18:41 INFO - docopt == 0.6.1 15:18:41 INFO - functools32 == 3.2.3-2 15:18:41 INFO - jsonschema == 2.5.1 15:18:41 INFO - manifestparser == 1.1 15:18:41 INFO - mozInstall == 1.13 15:18:41 INFO - mozcrash == 1.0 15:18:41 INFO - mozdebug == 0.1 15:18:41 INFO - mozdevice == 0.51 15:18:41 INFO - mozfile == 1.2 15:18:41 INFO - mozhttpd == 0.7 15:18:41 INFO - mozinfo == 0.10 15:18:41 INFO - mozleak == 0.1 15:18:41 INFO - mozlog == 3.5 15:18:41 INFO - moznetwork == 0.27 15:18:41 INFO - mozprocess == 0.25 15:18:41 INFO - mozprofile == 0.28 15:18:41 INFO - mozrunner == 6.13 15:18:41 INFO - mozscreenshot == 0.1 15:18:41 INFO - mozsystemmonitor == 0.3 15:18:41 INFO - moztest == 0.8 15:18:41 INFO - mozversion == 1.4 15:18:41 INFO - psutil == 3.1.1 15:18:41 INFO - requests == 1.2.3 15:18:41 INFO - wsgiref == 0.1.2 15:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:18:41 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')]} 15:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:41 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')]} 15:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:41 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 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:41 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 15:18:41 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 15:18:41 INFO - Using env: {'DISPLAY': ':0', 15:18:41 INFO - 'HOME': '/home/cltbld', 15:18:41 INFO - 'LANG': 'en_US.UTF-8', 15:18:41 INFO - 'LANGUAGE': 'en_US:en', 15:18:41 INFO - 'LOGNAME': 'cltbld', 15:18:41 INFO - 'MAIL': '/var/mail/cltbld', 15:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:41 INFO - 'MOZ_NO_REMOTE': '1', 15:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:41 INFO - 'NO_EM_RESTART': '1', 15:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:41 INFO - 'PWD': '/builds/slave/test', 15:18:41 INFO - 'SHELL': '/bin/bash', 15:18:41 INFO - 'SHLVL': '1', 15:18:41 INFO - 'TERM': 'linux', 15:18:41 INFO - 'TMOUT': '86400', 15:18:41 INFO - 'USER': 'cltbld', 15:18:41 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:41 INFO - '_': '/tools/buildbot/bin/python'} 15:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 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)) 15:18:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:18:43 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)) 15:18:43 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)) 15:18:43 INFO - Installing collected packages: simplejson 15:18:43 INFO - Running setup.py install for simplejson 15:18:43 INFO - building 'simplejson._speedups' extension 15:18:43 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 15:18:43 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 15:18:44 INFO - Successfully installed simplejson 15:18:44 INFO - Cleaning up... 15:18:44 INFO - Return code: 0 15:18:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:18:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:18:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2628f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', '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 15:18:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:18:44 INFO - Using env: {'DISPLAY': ':0', 15:18:44 INFO - 'HOME': '/home/cltbld', 15:18:44 INFO - 'LANG': 'en_US.UTF-8', 15:18:44 INFO - 'LANGUAGE': 'en_US:en', 15:18:44 INFO - 'LOGNAME': 'cltbld', 15:18:44 INFO - 'MAIL': '/var/mail/cltbld', 15:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:44 INFO - 'MOZ_NO_REMOTE': '1', 15:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:18:44 INFO - 'NO_EM_RESTART': '1', 15:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:44 INFO - 'PWD': '/builds/slave/test', 15:18:44 INFO - 'SHELL': '/bin/bash', 15:18:44 INFO - 'SHLVL': '1', 15:18:44 INFO - 'TERM': 'linux', 15:18:44 INFO - 'TMOUT': '86400', 15:18:44 INFO - 'USER': 'cltbld', 15:18:44 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:44 INFO - '_': '/tools/buildbot/bin/python'} 15:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:18:44 INFO - Cleaning up... 15:18:44 INFO - Return code: 0 15:18:44 INFO - Running post-action listener: _resource_record_post_action 15:18:44 INFO - Running post-action listener: _start_resource_monitoring 15:18:44 INFO - Starting resource monitoring. 15:18:44 INFO - [mozharness: 2017-08-20 22:18:44.360898Z] Finished create-virtualenv step (success) 15:18:44 INFO - [mozharness: 2017-08-20 22:18:44.361360Z] Running install step. 15:18:44 INFO - Running pre-action listener: _resource_record_pre_action 15:18:44 INFO - Running main action method: install 15:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:18:44 INFO - Reading from file tmpfile_stdout 15:18:44 INFO - Detecting whether we're running mozinstall >=1.0... 15:18:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:18:44 INFO - Reading from file tmpfile_stdout 15:18:44 INFO - Output received: 15:18:44 INFO - Usage: mozinstall [options] installer 15:18:44 INFO - Options: 15:18:44 INFO - -h, --help show this help message and exit 15:18:44 INFO - -d DEST, --destination=DEST 15:18:44 INFO - Directory to install application into. [default: 15:18:44 INFO - "/builds/slave/test"] 15:18:44 INFO - --app=APP Application being installed. [default: firefox] 15:18:44 INFO - mkdir: /builds/slave/test/build/application 15:18:44 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'] 15:18:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:19:03 INFO - Reading from file tmpfile_stdout 15:19:03 INFO - Output received: 15:19:03 INFO - /builds/slave/test/build/application/firefox/firefox 15:19:03 INFO - Running post-action listener: _resource_record_post_action 15:19:03 INFO - [mozharness: 2017-08-20 22:19:03.096257Z] Finished install step (success) 15:19:03 INFO - [mozharness: 2017-08-20 22:19:03.096507Z] Running setup-mitmproxy step. 15:19:03 INFO - Running pre-action listener: _resource_record_pre_action 15:19:03 INFO - Running main action method: setup_mitmproxy 15:19:03 INFO - Skipping: mitmproxy is not required 15:19:03 INFO - Running post-action listener: _resource_record_post_action 15:19:03 INFO - [mozharness: 2017-08-20 22:19:03.097704Z] Finished setup-mitmproxy step (success) 15:19:03 INFO - [mozharness: 2017-08-20 22:19:03.097921Z] Running run-tests step. 15:19:03 INFO - Running pre-action listener: _resource_record_pre_action 15:19:03 INFO - Running pre-action listener: _set_gcov_prefix 15:19:03 INFO - Running main action method: run_tests 15:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:19:03 INFO - Python 2.7.3 15:19:03 INFO - Return code: 0 15:19:03 INFO - grabbing minidump binary from tooltool 15:19: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')]} 15:19:03 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 0x2626130>, '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 0x2627030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26274c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:19:03 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 15:19:03 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 15:19:03 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 15:19:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:19:03 INFO - Return code: 0 15:19:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:19:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:19:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:19:03 INFO - ENV: RUST_BACKTRACE is now full 15:19:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:19:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:19:03 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/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:19:03 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/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:19:03 INFO - Using env: {'DISPLAY': ':0', 15:19:03 INFO - 'HOME': '/home/cltbld', 15:19:03 INFO - 'LANG': 'en_US.UTF-8', 15:19:03 INFO - 'LANGUAGE': 'en_US:en', 15:19:03 INFO - 'LOGNAME': 'cltbld', 15:19:03 INFO - 'MAIL': '/var/mail/cltbld', 15:19:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:19:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:03 INFO - 'MOZ_NO_REMOTE': '1', 15:19:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:19:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:03 INFO - 'NO_EM_RESTART': '1', 15:19:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:03 INFO - 'PWD': '/builds/slave/test', 15:19:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:19:03 INFO - 'RUST_BACKTRACE': 'full', 15:19:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:19:03 INFO - 'SHELL': '/bin/bash', 15:19:03 INFO - 'SHLVL': '1', 15:19:03 INFO - 'STYLO_FORCE_ENABLED': '1', 15:19:03 INFO - 'TERM': 'linux', 15:19:03 INFO - 'TMOUT': '86400', 15:19:03 INFO - 'USER': 'cltbld', 15:19:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1503267468.209604-442352373', 15:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:03 INFO - '_': '/tools/buildbot/bin/python'} 15:19:03 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/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:19:03 INFO - mozversion application_buildid: 20170820212432 15:19:03 INFO - mozversion application_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:19:03 INFO - mozversion application_display_name: Nightly 15:19:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:19:03 INFO - mozversion application_name: Firefox 15:19:03 INFO - mozversion application_remotingname: firefox 15:19:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:19:03 INFO - mozversion application_vendor: Mozilla 15:19:03 INFO - mozversion application_version: 57.0a1 15:19:03 INFO - mozversion platform_buildid: 20170820212432 15:19:03 INFO - mozversion platform_changeset: 7dddbd85047c6dc73ddbe1e423cd643a217845b3 15:19:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:19:03 INFO - mozversion platform_version: 57.0a1 15:19:03 INFO - using testdate: 1503267543 15:19:03 INFO - actual date: 1503267543 15:19:03 INFO - starting webserver on 'localhost:56015' 15:19:03 INFO - SUITE-START | Running 2 tests 15:19:03 INFO - TEST-START | dromaeo_css 15:19:03 INFO - Initialising browser for dromaeo_css test... 15:19:03 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56015/getInfo.html -profile /tmp/tmpv6EUW0/profile 15:19:03 INFO - TEST-INFO | started process 12319 (/builds/slave/test/build/application/firefox/firefox http://localhost:56015/getInfo.html) 15:19:09 INFO - TEST-INFO | 12319: exit 0 15:19:09 INFO - Browser initialized. 15:19:09 INFO - Running cycle 1/1 for dromaeo_css test... 15:19:09 INFO - TEST-INFO | started process 12506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv6EUW0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:19:10 INFO - PID 12506 | 15:19:10 INFO - PID 12506 | (/builds/slave/test/build/application/firefox/firefox:12557): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:10 INFO - PID 12506 | 15:19:11 INFO - PID 12506 | 15:19:11 INFO - PID 12506 | (/builds/slave/test/build/application/firefox/firefox:12617): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:19:11 INFO - PID 12506 | 15:19:11 INFO - PID 12506 | __metrics Screen width/height:1600/1200 15:19:11 INFO - PID 12506 | colorDepth:24 15:19:11 INFO - PID 12506 | Browser inner width/height: 1024/768 15:19:11 INFO - PID 12506 | __metrics 15:19:20 INFO - PID 12506 | RSS: Main: 175038464 15:19:20 INFO - PID 12506 | 15:22:19 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56015/tests/dromaeo/cssquery-ext.html) 15:22:20 INFO - PID 12506 | RSS: Main: 178671616 15:22:20 INFO - PID 12506 | 15:25:22 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-ext.html (next: http://localhost:56015/tests/dromaeo/cssquery-jquery.html) 15:25:23 INFO - PID 12506 | RSS: Main: 175194112 15:25:23 INFO - PID 12506 | 15:28:24 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56015/tests/dromaeo/cssquery-mootools.html) 15:28:25 INFO - PID 12506 | RSS: Main: 177422336 15:28:25 INFO - PID 12506 | 15:31:27 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56015/tests/dromaeo/cssquery-prototype.html) 15:31:28 INFO - PID 12506 | RSS: Main: 175833088 15:31:28 INFO - PID 12506 | 15:34:31 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56015/tests/dromaeo/cssquery-yui.html) 15:34:32 INFO - PID 12506 | RSS: Main: 179519488 15:34:32 INFO - PID 12506 | 15:37:33 INFO - PID 12506 | Cycle 1(1): loaded http://localhost:56015/tests/dromaeo/cssquery-yui.html (next: http://localhost:56015/tests/dromaeo/cssquery-dojo.html) 15:37:34 INFO - PID 12506 | RSS: Main: 179855360 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | __start_tp_report 15:37:34 INFO - PID 12506 | _x_x_mozilla_page_load 15:37:34 INFO - PID 12506 | _x_x_mozilla_page_load_details 15:37:34 INFO - PID 12506 | |i|pagename|runs| 15:37:34 INFO - PID 12506 | |0;dojo.html;3150.6534281229046;3155.2742869140106;3174.6666600006997;3187.0757480330703;3191.7765756397052;5802.767889284423;6052.57631965762;6067.302260240068;6105.60313579617;6115.785947491839;6148.877022459559;6174.10475481055;6229.937700622992;6265.3734626537325;6277.686115694209;5737.3688894221605;5751.281089863777;5773.278340207474;5816.476517113459;5834.649921004732;5488.780448782044;5635.098384258519;5686.431356864322;5820.650760954335;5830.708464576775;5595.7481913313595;5624.775008999635;5681;5694.4590263925065;5746.051901436258;5592.7762889484375;5604.971975140139;5654.038813401731;5686.744096515667;5690.061139911951;5508.752106155192;5578;5587.497125258747;5598.860028499279;5610;6054.212952316171;6130.570860039799;6208.50331973441;6235.812925612239;6242;6667.833304167386;6726.865462690767;6741.662916854138;6774.491913106537;6775.796726098225;6751.156105486814;6752.729890804362;6843.692033858489;6847.417969472601;6855.971604259351;6074.544409169286;6080.300765411946;6182.536309776785;6193.876122477525;6198.442140207403;6850.554713943678;6915.101036865175;6936.4797640176175;6936.7572134975035;6957.756478523329;6563.835904102436;6640.501962352843;6652.800415987432;6656.667166641649;6660.467162626978;6667.499937504706;6675.899861502081;6737.764178253836;6777;6792.898106528406;6545.443637290884;6619.834504137339;6627.867442651216;6702.530822842452;6737.528373013842;6573.638449885207;6676.031975363545;6774.254831968479;6778.796636100925;6780.118584584071;5345.251664766935;5430.13117901134;5430.15832545956;5433.755481003364;5447.836564903059;4573.67324983467;4642.46611639659;4663.067386522641;4664.720116793003;4676.742779147112;5733.627314224562;5797.47822695951;5806.65160090396;5836;5876.294844618587;6764.120664313707;6851.314868513109;6853.17761868579;6855.4172895304455;6864.24493305736;5823.592348535646;5876.294844618587;5893.027650437715;5900.232969713996;5908.822735317947;5900.1149827526215;5908.084246941731;5929.0513517836935;5988.04191329394;6015.819525414245;6367.235931688135;6471.805845824632;6479.773207937699;6555.2789193189665;6596.967015164893;6767.154105736783;6795.286494917962;6798.660066996729;6804.693788779616;6812.4890633203695;6515.315891831289;6525.673716314071;6537.934620653733;6569.4744420445295;6581.3747693969;6638.17022872141;6646.966765166143;6696.5647232929705;6709.7316107355155;6739.157605299338;6612.768553100618;6740.831479212863;6741.325867413416;6749.696263668245;6761.966190169214;6463.64449955257;6474.935250647622;6479.935200648122;6484.610923344614;6487.54587178893;6394.4564712;6427.1002059710745;6468.676566171766;6503.934960650333;6515.73937042513;6459.870802583828;6501.1548498694865;6505.479561634963;6513.478921686348;6526.477881769352;6527.379898909596;6567.343265673395;6607.96696016536;6664.66676666155;6666.899996499959;6245.125682404558;6340.175777148941;6342.460890824332;6351.809445716636;6489.3510648934725 15:37:34 INFO - PID 12506 | |1;ext.html;828.2545708862024;862.4480332587145;886.4282537763147;892.4243862708553;1185.6502331812114;30897.845510772444;42161.156776864445;43235.56764432355;43238.783806081;43267.35098973514;43267.78366108173;43661.12677746451;43724;43728.344074838904;43754.562454375446;7530.171681115073;7913;8124.553149576771;8126.349892008625;8158.918410815875;7919.485233459835;8023.558704271263;8045.879311810328;8053.395995300347;8072.959635201816;7998.400119990994;8050.838983220332;8054.033515978091;8063.233992770707;8078.636461359223;7999.320057795095;8038.678452861878;8043.638036288381;8043.999999999971;8050.074241462248;7909.090454597737;7965.203479652047;7984.680612775482;7989.800254993614;8009.279164875189;38446.61553384458;39000.219995600215;39001.609983900365;39056.804715976235;39084.21831563353;3482.9303413931834;3511.17487390463;3534.7879127252445;3541.964580354215;3544.3088597723454;31031.37937241265;31122.221944451343;31178.220544486343;31182.37635247305;31212.8439357804;5119.667221630582;5126.871828204287;5132.973405318951;5152.407473140562;5185.403678576974;186159;186240;186413;186889;187709;46541;46579.5342046582;46762.766186168854;47177.29234061492;47217;49430.50569494259;49473.25790113079;49524.50475495271;49533.752331238116;49547.25679114816;15110.093394396372;16338.509844704678;16611.750823737413;16618.916905415397;16620.83379166217;12684.42920068599;14121.929390352983;14175.078619889675;14228.217448040457;14341.354639041268;14436.927815360856;14489.420423183166;14514.564563063124;14524.782128268085;14635;5641.351244606923;5710.2862142232225;5732.971335143297;5739.225204597409;5765.019946609086;966.2704657983178;996.9003099690118;1011.5801942194054;1013.8276492996208;1023.3552861697083;22620.095196191967;22739.204127855446;22820.201292954665;22824.65763013556;23023;1067.7170549804307;1100.5597760895546;1114.414932160606;1126.2960649594004;1130.9038731707897;12043.578474753516;12113.273203607636;12135.453904574315;12142.757144857052;12202.633920982207;222709;224562;224938;225271;225296;51752.482475174766;51841.2223816643;52040.47959520432;52087;52156;1446.6889618732023;1497.6255936015996;1510.07885190034;1511.1159971416625;1526.084349390357;22784.31647050591;22816.771832282127;22901.885490573106;22926.770732292465;23094.307170784905;38049.80975095107;38157.80921095488;38167;38216.80891595524;38229;182011;182153.089234553;182471;182600;183905;34410.48384274188;35652.46521302235;37216.627833721315;37404;37517.87446376613;46541.53458465372;46919.530804691516;46948;47000.29499557441;47039;34350.48474272938;34664.306713866084;34886.30227395488;35091.12272193113;35442.64557354496;33868.32263354769;34034;34097.48853767245;34332.82833585816;34494.65505345015;37598.43602345912;37642.623573763914;37792.43311350387;37802;37932.81033594815;32797.34405311928;32931;33368.666313337526;33387.83306083454;33470.4979425304;23964.52070958606;24290.635640465054;24337.878310608332;24613.87693061523;24643.383915402257 15:37:34 INFO - PID 12506 | |2;jquery.html;553.6705660132222;556.4984015471447;566.1309889319895;579.6811753535555;587.6855882103074;20154.39536813896;20801.27195548156;20905.895470522646;20911.059002344893;22587.322380328576;26758.732412675916;27396.315092122706;27555.17334479969;27579.586306205423;27602.5859612106;7122.430205583554;7267.963660181692;7268.781936541912;7272.018277532518;7279.89080163798;6658.10115634388;6958.826029349256;6975.093237879094;6995.265497122779;7179.210286868466;6942.444604431634;6976.930230697679;6977.476689248301;6982.720691172347;6987.790366288994;6945.895811562806;6950.270221626733;6962.164540255151;6968.686409111577;6973.302669733037;6815.7614483493335;6841.076454678604;6853.109095817562;6858.931410685929;6864.862702745917;30594.69405305963;32094.679053209402;32641.83679081613;32658.510122348183;32779.18052048718;2044.0393015282793;2080.573482436097;2080.989595052015;2081.7814129516332;2084.791520847918;20357.49106272355;20991.055402506925;21041.263555775626;21053.789462105335;21060.473488162766;2515.2328539795353;2518.874056297178;2532.2403279016407;2602.700689420722;2608.699999500063;136622.31688841493;139560;139723;139790;139839.30080349534;20846;21700.34898953034;21743.130274789146;21947;22057.669134962987;44182.77908610436;44185.558144418144;44199.33700994487;44229.894252643295;44270;11013.449327533592;11122.888771112348;11244.49399777012;11360.23916292976;11423.143264255214;8893.911060889308;9262.351635385457;9300.441973481613;9389.812203755886;9463.90536094644;9991.850122248172;11405.433777400018;11410.771784564262;11647.6505704829;11830.645080647595;4261.232978063978;4382.289039282784;4414.872094591503;4420.933685994648;4481.865544033684;953.9284553658504;969.9515024248759;983.7098056073476;989.7483225661678;991.3457118301886;19381.4185574433;19802.50493737668;20243.898780506297;20250;20497.897510512354;1056.1181413519796;1059.9311044782064;1060.6977011551826;1060.7083052160563;1068.8824229334766;10970.506327215295;11373.488193031333;13255.469781208836;14075.929620351833;14139.080959737585;497985;510185;524190;531530;533101;118226.4088679551;122360;122378.38810806067;122518;123320;1267.2016629523525;1273.3824095313767;1311.9212847229387;1315.9078864479586;1317.4137508808487;20970.895145524784;21134.365969020953;21241;21548.35354939354;21917.67123493117;59196.999999998276;59922.70038649779;60409.39590604213;62026;62544.68727656332;69338.65330673516;78376;80845.59577202312;81506;81676.59161704153;12598.370081495705;13049.76027277407;14580.85419145795;14858.628534286729;15423.691526169638;23661;23817.642735358637;23984;23996.88001559981;24143.758562414852;18757.81242187615;19062.809371906103;19255.51861203481;19275.22899084021;19292;16536.75194872102;16824.495265142064;17011.744823827405;17124.828751712324;17564;18932.526686832938;19394.321198757974;19573.70639440381;19716;19734.40796776099;14718.116912985255;14938.551843444715;14942.925285373503;14970;14990.625234369229;18668.719969200745;18872.433826985212;18910.338138165098;18977.051147442296;18988 15:37:34 INFO - PID 12506 | |3;mootools.html;1339.3102552185624;1384.9446022159113;1392.2133994293224;1410.4710733474947;1410.8448070712227;12351.567695130672;14200.218987955659;14776.6305842354;14778.556643300704;14785.408583656668;12357.19678220915;14402.783958240609;14645.487407940724;14687.632809179775;14792.408303667868;2683.7182095879944;2728.0997270900652;2733.7129601391866;2734.6581677290337;2735.4939336222765;2596.0654164500766;2698.231004163814;2699.311675522749;2703.6350092737425;2703.8783254753484;2610.4518051209175;2625.186192280399;2632.578787394017;2643.762061414472;2649.377396311865;2580.4968031233916;2593.299809051555;2610.9216723498325;2613.3335999320243;2613.9607905881426;2497.5504409206337;2514.120057979711;2524.482481091372;2550.7959363250893;2552.1450314144786;13836.30818459073;14244.643883902881;14245.857541424557;14251.85748142526;14270.571882843531;7614.923850761477;7867.6459559319965;7922.920770792276;7942.880856787153;7953.483023603505;4987.526185012418;5178.249153872705;5236.266922630834;5248.396434410053;5348.786048558053;1816.7547381103514;1827.2690923630655;1828.9725654115198;1849.6670599292122;1858.5353661584604;23434.882825585933;23547.7645223549;23568;23605.409864753346;23622.29133125992;6942.652867356612;7005.754798582026;7103.92896071043;7222.566646001152;7278.235785242579;18611.348602798837;18619.534511637048;18648.34730784416;18661.346852860086;18681.43955681332;7816.726414575576;7929.286364227247;7931.841363172704;8114.350851931831;8116.878246826184;5908.379620139909;7121.537100088478;7153.213146553875;7184.892226616605;7249.202587715347;5378.569714422837;5486.094794358966;5506.394296627368;5539.086050801653;5570.3315602127195;1772.2113659421434;1779.4394765648779;1783.5273652482103;1787.1868299923503;1790.7582476365524;879.6085741844818;901.369041670833;903.5978989349676;917.4082716647724;919.2508105893676;8002.239787220205;8202.753917382488;8216.630251638571;8253.752387428387;8352.373571982125;710.0662628643421;718.608358444649;721.8347546010676;723.2984005514643;729.806601250669;4668.393108895822;4737.170995075848;4757.762111894392;4776.307435421844;4779.569838714532;19293.035348232534;19590.70613940792;20044.799552004584;20347;20358.389248322575;19331;19982.30061947825;20014.599708006048;20015.499612509513;20016.49958751043;10903.29128606638;10940.288881222696;11102.111831053497;11121.443927803577;11132.554697812158;8310.916890831015;8328.62521186536;8332.291755200877;8409.705660301861;8457.619407126816;17251.137443128046;17259.913700431418;17425.73861392055;17668.381606643707;18115.63768724592;17595.56011099733;18036.36872709449;18044.09779510993;18056.45830625083;18189.636207276046;10850.837237441287;11133.443327833415;11142.052925501099;11254.549818007516;11565.595204167814;13688.178709277476;13940.721185576029;14012.789808152682;14014.579562613138;14023.859761402664;11070.667879963614;11083.556657733601;11227.943860280646;11263.155263355116;11457.541698331974;10817.18871084656;10900.509477073709;11024.834627480755;11170.27393219438;11390;9647;9817.26370522228;9831.705048848546;9843.557039933363;9862.309638325536;7456.7762967111075;7470.103587569526;7472.551646901204;7478;7488.588127653032;7180.281971802778;7439.739609113655;7456.627168641655;7467.701291948261;7469.402447804054 15:37:34 INFO - PID 12506 | |4;prototype.html;488.5188089731616;500.44200716201425;516.4525602860967;520.8020952038225;523.5811350919264;6239.563230573862;6253.59351642143;6287.591306565081;6296.748130074791;6298.338674439186;6085.78699745509;6114.798672477916;6164.660943648098;6228;6262.499000079994;5077.238414237857;5117.33474648297;5117.641765076446;5174.120399532088;5221.425643179266;4859.829905953292;5068.1890897456415;5096.719680417576;5109.3613298337705;5190.273361729361;4871.512848715136;4898.755062246892;4936.605071594264;4953.801847926096;4958.132326842806;4885.022995400934;4930.260460930853;4957.231629097514;4970.627202959774;5007.84976450707;4447.911041779146;4448.154850578379;4463.085067561175;4487.506374298857;4497.775111244425;5990.592210830451;6079.574429789916;6110.022396416552;6115.419035191694;6136.8158955230965;5697.373288938214;5741.224934633813;5742.6841523716175;5780.8843823123725;5784.248047753765;6473.223213214397;6546.967265163644;6575.3095924927675;6586.868262634768;6602.73589056442;4863.562279394871;4865.299758633957;4875.68308059975;4930.876728081791;4932.804901818692;6583.794428866336;6791.932080679228;6903.1716194056535;6904.3095690431055;6939.7224111036;5024.422191447957;5033.471485494044;5046.116929537389;5062.82280120194;5062.924056139161;5046.419661738947;5083.204237669341;5083.491650834887;5123.513266239701;5129.9230511542355;5669.177969194526;5704.80033198836;5718.342390625048;5748.137779333133;5787.681677507778;6608.471322294205;6639.170103737033;6661.566998145105;6670.833229169212;6723.747544572623;1770.7963584187726;1799.560351718646;1800.6488734696609;1807.3041878876463;1807.9638407231782;1178.4166837415535;1219.8838063172097;1231.5566396097397;1236.5223557848285;1251.249250449741;5811.15738217956;5844.649321040752;5844.6785426801935;5853.824385268449;5872.76671898906;6729.629870357079;6734.764283250062;6767.763128290486;6773.491988100814;6854.931450685429;5757.510611597977;5805.129230615442;5837.460704593515;5865.970670146708;5876.559258055663;3590.622984586633;3593.365018916387;3616.710663146942;3640.8179591020344;3641.344557979536;6528.902066469007;6573.605583664996;6588.769393071316;6622;6658.4673226141795;6894.689738961759;6907.930920690829;6937.895931561031;7034.030471467997;7082.681279342442;6473.967630161725;6553.901691474632;6569.540132190701;6606.240282367589;6657.633830139292;6308.526860485574;6659.467242620482;6693.196816382066;6728.226253980855;6749.561278517077;6654.767083152066;6661.933380666325;6674.399304062657;6690.230623478362;6753.223379311442;6401.647909364843;6535.57518761279;6540.8880490315805;6552.63960482178;6561.866024404594;4941.456439791692;4997.500249975119;5007.949920500894;5015.119330251156;5103.668261562986;6437.935620643733;6515.837104072247;6616.371444712745;6756.358145976124;6833;6477.481801455967;6485.902711459237;6507.674616269073;6580.5064620154635;6592.406683398517;6526.836829079311;6549.7380104795275;6563.1796025496815;6598.736050557924;6598.967005164944;6479;6528.804135875931;6534.934650653433;6540.476761859135;6593.703283352164;6643.2360278568585;6656.1394391253925;6656.83357916056;6658.334166583303;6660;6352.6506042166275;6381.521385895983;6390.648514331757;6393.1688880445245;6486.2216534016225 15:37:34 INFO - PID 12506 | |5;yui.html;907.1654078248012;925.2967744514169;935.8736570562972;937.3625934364638;951.900050494698;18938.715919261205;19630.60738785225;19635;19649.803501964976;22106.778932210673;21512.139514419403;22228;22238.777612223872;22336.10655573775;22411.43971400716;997.0826839307854;999.4902599674182;999.8200323941687;1000.7648202672366;1024.0783295034473;1028.0952761569808;1061.787642471505;1066.919981001424;1070.5022164693416;1074.6131392698621;1125.2123513540514;1130.581684776634;1130.7851508213414;1131.1798945764338;1132.1339175530725;1115.046635126967;1123.522502936253;1124.0726400719398;1129.9604513842057;1131.6548452721916;816.249050873198;822.7531740477892;824.7154731617583;825.0759149752256;825.4799476329933;17939.461816145536;18021;18041.639167216712;18573;19956.70064949027;22015.779842201693;22131.225407110673;22179.66730499044;22529.098836046538;22651.660225096635;16577.254023568967;16642.66714665712;16711.582210444714;16830.15849207535;16943.322267109303;3654.3604869148057;3673.981630091859;3676.5036720042717;3677.7057835373375;3679.4480827875764;126752;127264.36367818102;128118;132670.3366483171;132941;16718.331266749436;16909.154542272838;16935.407260745815;17000.319987200623;17294.962302261905;30490.237744056132;30690.38619227603;30728.846355768077;32140.357192856012;32585.674143258737;7671.6164191790185;7959.602019899097;8518.659253629785;8597.5701214939;8641.30869530436;4137.731047481964;4217.430646862635;4235.915281694411;4252.829886804493;4260.55264197261;5312.5484333832055;5400.702961337164;5403.459654034565;5435.320584926884;5441.564674826004;1089.4334945828125;1105.3920343811033;1110.123002827757;1115.5537784885948;1119.9496022679;676.5534747067011;690.6581242285;701.1060897355912;701.8175274428685;711.718871045934;11944.701382465335;12153.817692734616;12308.076894232789;12316.261024338568;13293.933530332286;647.6502688548131;654.0320325917573;658.404144249455;664.9268580456146;687.4294335701356;5730.398308177665;5797.955778472671;5837.562182836219;5844.503217226584;5963.463288303987;115230;115474.42262788632;116217;116794;119225.40387298008;96572.51713741386;96713.51643241738;98701;100498;105017;90147.54926225326;93628.53185734028;93756.53121734348;93979.53010234905;95838.52080739551;12593.748125037631;12748.61754147377;13127.868721312665;13357.465701372224;13464.394102265618;41314.79342603268;42758.358624620036;42908;43485.34771978486;44654.10691786211;52928;75321.62339188269;78423.60788196251;80243.59878200805;85422.57288713516;19984.400467985983;20354.389368318974;20391.694124587848;20627.58744825125;20799.8960005199;18382.448526544224;21305.46736331542;21900.12399504002;23244.76755232426;23574.646380304654;19781.70327445118;20251.898740506793;20531.589368212255;20594;20673.58652826965;19797.40607781769;20207.19171233193;20286;20378.18487260493;20404.591908162052;19196.520086997938;19438.4168474946;19505.414837554898;19581.51046223856;19636.607267854277;13749.656258593215;13979.44082236699;14056.367463463965;14523.636909077357;14716.632084197981;13629.795553066513;14041.36813843359;14745.557633271019;15228.314725837585;15407.306671200047 15:37:34 INFO - PID 12506 | __end_tp_report 15:37:34 INFO - PID 12506 | __start_cc_report 15:37:34 INFO - PID 12506 | _x_x_mozilla_cycle_collect,398 15:37:34 INFO - PID 12506 | __end_cc_report 15:37:34 INFO - PID 12506 | __startTimestamp1503268654238__endTimestamp 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | ------- Summary: start ------- 15:37:34 INFO - PID 12506 | Number of tests: 6 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#0] dojo.html Cycles:165 Average:6166.18 Median:6459.87 stddev:741.69 (11.5%) stddev-sans-first:705.23 15:37:34 INFO - PID 12506 | Values: 3150.7 3155.3 3174.7 3187.1 3191.8 5802.8 6052.6 6067.3 6105.6 6115.8 6148.9 6174.1 6229.9 6265.4 6277.7 5737.4 5751.3 5773.3 5816.5 5834.6 5488.8 5635.1 5686.4 5820.7 5830.7 5595.7 5624.8 5681.0 5694.5 5746.1 5592.8 5605.0 5654.0 5686.7 5690.1 5508.8 5578.0 5587.5 5598.9 5610.0 6054.2 6130.6 6208.5 6235.8 6242.0 6667.8 6726.9 6741.7 6774.5 6775.8 6751.2 6752.7 6843.7 6847.4 6856.0 6074.5 6080.3 6182.5 6193.9 6198.4 6850.6 6915.1 6936.5 6936.8 6957.8 6563.8 6640.5 6652.8 6656.7 6660.5 6667.5 6675.9 6737.8 6777.0 6792.9 6545.4 6619.8 6627.9 6702.5 6737.5 6573.6 6676.0 6774.3 6778.8 6780.1 5345.3 5430.1 5430.2 5433.8 5447.8 4573.7 4642.5 4663.1 4664.7 4676.7 5733.6 5797.5 5806.7 5836.0 5876.3 6764.1 6851.3 6853.2 6855.4 6864.2 5823.6 5876.3 5893.0 5900.2 5908.8 5900.1 5908.1 5929.1 5988.0 6015.8 6367.2 6471.8 6479.8 6555.3 6597.0 6767.2 6795.3 6798.7 6804.7 6812.5 6515.3 6525.7 6537.9 6569.5 6581.4 6638.2 6647.0 6696.6 6709.7 6739.2 6612.8 6740.8 6741.3 6749.7 6762.0 6463.6 6474.9 6479.9 6484.6 6487.5 6394.5 6427.1 6468.7 6503.9 6515.7 6459.9 6501.2 6505.5 6513.5 6526.5 6527.4 6567.3 6608.0 6664.7 6666.9 6245.1 6340.2 6342.5 6351.8 6489.4 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#1] ext.html Cycles:180 Average:37328.10 Median:35547.56 stddev:51410.64 (144.6%) stddev-sans-first:51481.80 15:37:34 INFO - PID 12506 | Values: 828.3 862.4 886.4 892.4 1185.7 30897.8 42161.2 43235.6 43238.8 43267.4 43267.8 43661.1 43724.0 43728.3 43754.6 7530.2 7913.0 8124.6 8126.3 8158.9 7919.5 8023.6 8045.9 8053.4 8073.0 7998.4 8050.8 8054.0 8063.2 8078.6 7999.3 8038.7 8043.6 8044.0 8050.1 7909.1 7965.2 7984.7 7989.8 8009.3 38446.6 39000.2 39001.6 39056.8 39084.2 3482.9 3511.2 3534.8 3542.0 3544.3 31031.4 31122.2 31178.2 31182.4 31212.8 5119.7 5126.9 5133.0 5152.4 5185.4 186159.0 186240.0 186413.0 186889.0 187709.0 46541.0 46579.5 46762.8 47177.3 47217.0 49430.5 49473.3 49524.5 49533.8 49547.3 15110.1 16338.5 16611.8 16618.9 16620.8 12684.4 14121.9 14175.1 14228.2 14341.4 14436.9 14489.4 14514.6 14524.8 14635.0 5641.4 5710.3 5733.0 5739.2 5765.0 966.3 996.9 1011.6 1013.8 1023.4 22620.1 22739.2 22820.2 22824.7 23023.0 1067.7 1100.6 1114.4 1126.3 1130.9 12043.6 12113.3 12135.5 12142.8 12202.6 222709.0 224562.0 224938.0 225271.0 225296.0 51752.5 51841.2 52040.5 52087.0 52156.0 1446.7 1497.6 1510.1 1511.1 1526.1 22784.3 22816.8 22901.9 22926.8 23094.3 38049.8 38157.8 38167.0 38216.8 38229.0 182011.0 182153.1 182471.0 182600.0 183905.0 34410.5 35652.5 37216.6 37404.0 37517.9 46541.5 46919.5 46948.0 47000.3 47039.0 34350.5 34664.3 34886.3 35091.1 35442.6 33868.3 34034.0 34097.5 34332.8 34494.7 37598.4 37642.6 37792.4 37802.0 37932.8 32797.3 32931.0 33368.7 33387.8 33470.5 23964.5 24290.6 24337.9 24613.9 24643.4 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#2] jquery.html Cycles:180 Average:37446.02 Median:21932.34 stddev:87266.72 (397.9%) stddev-sans-first:87467.56 15:37:34 INFO - PID 12506 | Values: 553.7 556.5 566.1 579.7 587.7 20154.4 20801.3 20905.9 20911.1 22587.3 26758.7 27396.3 27555.2 27579.6 27602.6 7122.4 7268.0 7268.8 7272.0 7279.9 6658.1 6958.8 6975.1 6995.3 7179.2 6942.4 6976.9 6977.5 6982.7 6987.8 6945.9 6950.3 6962.2 6968.7 6973.3 6815.8 6841.1 6853.1 6858.9 6864.9 30594.7 32094.7 32641.8 32658.5 32779.2 2044.0 2080.6 2081.0 2081.8 2084.8 20357.5 20991.1 21041.3 21053.8 21060.5 2515.2 2518.9 2532.2 2602.7 2608.7 136622.3 139560.0 139723.0 139790.0 139839.3 20846.0 21700.3 21743.1 21947.0 22057.7 44182.8 44185.6 44199.3 44229.9 44270.0 11013.4 11122.9 11244.5 11360.2 11423.1 8893.9 9262.4 9300.4 9389.8 9463.9 9991.9 11405.4 11410.8 11647.7 11830.6 4261.2 4382.3 4414.9 4420.9 4481.9 953.9 970.0 983.7 989.7 991.3 19381.4 19802.5 20243.9 20250.0 20497.9 1056.1 1059.9 1060.7 1060.7 1068.9 10970.5 11373.5 13255.5 14075.9 14139.1 497985.0 510185.0 524190.0 531530.0 533101.0 118226.4 122360.0 122378.4 122518.0 123320.0 1267.2 1273.4 1311.9 1315.9 1317.4 20970.9 21134.4 21241.0 21548.4 21917.7 59197.0 59922.7 60409.4 62026.0 62544.7 69338.7 78376.0 80845.6 81506.0 81676.6 12598.4 13049.8 14580.9 14858.6 15423.7 23661.0 23817.6 23984.0 23996.9 24143.8 18757.8 19062.8 19255.5 19275.2 19292.0 16536.8 16824.5 17011.7 17124.8 17564.0 18932.5 19394.3 19573.7 19716.0 19734.4 14718.1 14938.6 14942.9 14970.0 14990.6 18668.7 18872.4 18910.3 18977.1 18988.0 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#3] mootools.html Cycles:180 Average:9023.95 Median:2586.90 stddev:6211.90 (240.1%) stddev-sans-first:6202.49 15:37:34 INFO - PID 12506 | Values: 1339.3 1384.9 1392.2 1410.5 1410.8 12351.6 14200.2 14776.6 14778.6 14785.4 12357.2 14402.8 14645.5 14687.6 14792.4 2683.7 2728.1 2733.7 2734.7 2735.5 2596.1 2698.2 2699.3 2703.6 2703.9 2610.5 2625.2 2632.6 2643.8 2649.4 2580.5 2593.3 2610.9 2613.3 2614.0 2497.6 2514.1 2524.5 2550.8 2552.1 13836.3 14244.6 14245.9 14251.9 14270.6 7614.9 7867.6 7922.9 7942.9 7953.5 4987.5 5178.2 5236.3 5248.4 5348.8 1816.8 1827.3 1829.0 1849.7 1858.5 23434.9 23547.8 23568.0 23605.4 23622.3 6942.7 7005.8 7103.9 7222.6 7278.2 18611.3 18619.5 18648.3 18661.3 18681.4 7816.7 7929.3 7931.8 8114.4 8116.9 5908.4 7121.5 7153.2 7184.9 7249.2 5378.6 5486.1 5506.4 5539.1 5570.3 1772.2 1779.4 1783.5 1787.2 1790.8 879.6 901.4 903.6 917.4 919.3 8002.2 8202.8 8216.6 8253.8 8352.4 710.1 718.6 721.8 723.3 729.8 4668.4 4737.2 4757.8 4776.3 4779.6 19293.0 19590.7 20044.8 20347.0 20358.4 19331.0 19982.3 20014.6 20015.5 20016.5 10903.3 10940.3 11102.1 11121.4 11132.6 8310.9 8328.6 8332.3 8409.7 8457.6 17251.1 17259.9 17425.7 17668.4 18115.6 17595.6 18036.4 18044.1 18056.5 18189.6 10850.8 11133.4 11142.1 11254.5 11565.6 13688.2 13940.7 14012.8 14014.6 14023.9 11070.7 11083.6 11227.9 11263.2 11457.5 10817.2 10900.5 11024.8 11170.3 11390.0 9647.0 9817.3 9831.7 9843.6 9862.3 7456.8 7470.1 7472.6 7478.0 7488.6 7180.3 7439.7 7456.6 7467.7 7469.4 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#4] prototype.html Cycles:180 Average:5542.48 Median:6126.12 stddev:1549.94 (25.3%) stddev-sans-first:1507.15 15:37:34 INFO - PID 12506 | Values: 488.5 500.4 516.5 520.8 523.6 6239.6 6253.6 6287.6 6296.7 6298.3 6085.8 6114.8 6164.7 6228.0 6262.5 5077.2 5117.3 5117.6 5174.1 5221.4 4859.8 5068.2 5096.7 5109.4 5190.3 4871.5 4898.8 4936.6 4953.8 4958.1 4885.0 4930.3 4957.2 4970.6 5007.8 4447.9 4448.2 4463.1 4487.5 4497.8 5990.6 6079.6 6110.0 6115.4 6136.8 5697.4 5741.2 5742.7 5780.9 5784.2 6473.2 6547.0 6575.3 6586.9 6602.7 4863.6 4865.3 4875.7 4930.9 4932.8 6583.8 6791.9 6903.2 6904.3 6939.7 5024.4 5033.5 5046.1 5062.8 5062.9 5046.4 5083.2 5083.5 5123.5 5129.9 5669.2 5704.8 5718.3 5748.1 5787.7 6608.5 6639.2 6661.6 6670.8 6723.7 1770.8 1799.6 1800.6 1807.3 1808.0 1178.4 1219.9 1231.6 1236.5 1251.2 5811.2 5844.6 5844.7 5853.8 5872.8 6729.6 6734.8 6767.8 6773.5 6854.9 5757.5 5805.1 5837.5 5866.0 5876.6 3590.6 3593.4 3616.7 3640.8 3641.3 6528.9 6573.6 6588.8 6622.0 6658.5 6894.7 6907.9 6937.9 7034.0 7082.7 6474.0 6553.9 6569.5 6606.2 6657.6 6308.5 6659.5 6693.2 6728.2 6749.6 6654.8 6661.9 6674.4 6690.2 6753.2 6401.6 6535.6 6540.9 6552.6 6561.9 4941.5 4997.5 5007.9 5015.1 5103.7 6437.9 6515.8 6616.4 6756.4 6833.0 6477.5 6485.9 6507.7 6580.5 6592.4 6526.8 6549.7 6563.2 6598.7 6599.0 6479.0 6528.8 6534.9 6540.5 6593.7 6643.2 6656.1 6656.8 6658.3 6660.0 6352.7 6381.5 6390.6 6393.2 6486.2 15:37:34 INFO - PID 12506 | 15:37:34 INFO - PID 12506 | [#5] yui.html Cycles:180 Average:24915.93 Median:20610.79 stddev:33634.13 (163.2%) stddev-sans-first:33680.17 15:37:34 INFO - PID 12506 | Values: 907.2 925.3 935.9 937.4 951.9 18938.7 19630.6 19635.0 19649.8 22106.8 21512.1 22228.0 22238.8 22336.1 22411.4 997.1 999.5 999.8 1000.8 1024.1 1028.1 1061.8 1066.9 1070.5 1074.6 1125.2 1130.6 1130.8 1131.2 1132.1 1115.0 1123.5 1124.1 1130.0 1131.7 816.2 822.8 824.7 825.1 825.5 17939.5 18021.0 18041.6 18573.0 19956.7 22015.8 22131.2 22179.7 22529.1 22651.7 16577.3 16642.7 16711.6 16830.2 16943.3 3654.4 3674.0 3676.5 3677.7 3679.4 126752.0 127264.4 128118.0 132670.3 132941.0 16718.3 16909.2 16935.4 17000.3 17295.0 30490.2 30690.4 30728.8 32140.4 32585.7 7671.6 7959.6 8518.7 8597.6 8641.3 4137.7 4217.4 4235.9 4252.8 4260.6 5312.5 5400.7 5403.5 5435.3 5441.6 1089.4 1105.4 1110.1 1115.6 1119.9 676.6 690.7 701.1 701.8 711.7 11944.7 12153.8 12308.1 12316.3 13293.9 647.7 654.0 658.4 664.9 687.4 5730.4 5798.0 5837.6 5844.5 5963.5 115230.0 115474.4 116217.0 116794.0 119225.4 96572.5 96713.5 98701.0 100498.0 105017.0 90147.5 93628.5 93756.5 93979.5 95838.5 12593.7 12748.6 13127.9 13357.5 13464.4 41314.8 42758.4 42908.0 43485.3 44654.1 52928.0 75321.6 78423.6 80243.6 85422.6 19984.4 20354.4 20391.7 20627.6 20799.9 18382.4 21305.5 21900.1 23244.8 23574.6 19781.7 20251.9 20531.6 20594.0 20673.6 19797.4 20207.2 20286.0 20378.2 20404.6 19196.5 19438.4 19505.4 19581.5 19636.6 13749.7 13979.4 14056.4 14523.6 14716.6 13629.8 14041.4 14745.6 15228.3 15407.3 15:37:34 INFO - PID 12506 | -------- Summary: end -------- 15:37:34 INFO - PID 12506 | 15:37:34 INFO - TEST-INFO | 12506: exit 0 15:37:35 INFO - TEST-OK | dromaeo_css | took 1111547ms 15:37:35 INFO - TEST-START | kraken 15:37:35 INFO - Initialising browser for kraken test... 15:37:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56015/getInfo.html -profile /tmp/tmpa6Xetm/profile 15:37:35 INFO - TEST-INFO | started process 12928 (/builds/slave/test/build/application/firefox/firefox http://localhost:56015/getInfo.html) 15:37:40 INFO - TEST-INFO | 12928: exit 0 15:37:40 INFO - Browser initialized. 15:37:40 INFO - Running cycle 1/1 for kraken test... 15:37:40 INFO - TEST-INFO | started process 13112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa6Xetm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:41 INFO - PID 13112 | 15:37:41 INFO - PID 13112 | (/builds/slave/test/build/application/firefox/firefox:13161): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:41 INFO - PID 13112 | 15:37:42 INFO - PID 13112 | 15:37:42 INFO - PID 13112 | (/builds/slave/test/build/application/firefox/firefox:13220): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:37:42 INFO - PID 13112 | 15:37:42 INFO - PID 13112 | __metrics Screen width/height:1600/1200 15:37:42 INFO - PID 13112 | colorDepth:24 15:37:42 INFO - PID 13112 | Browser inner width/height: 1024/768 15:37:42 INFO - PID 13112 | __metrics 15:37:52 INFO - PID 13112 | RSS: Main: 174149632 15:37:52 INFO - PID 13112 | 15:37:54 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56015/tests/kraken/driver.html?testName=audio-beat-detection) 15:37:55 INFO - PID 13112 | RSS: Main: 177917952 15:37:55 INFO - PID 13112 | 15:37:58 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56015/tests/kraken/driver.html?testName=audio-dft) 15:37:59 INFO - PID 13112 | RSS: Main: 180346880 15:37:59 INFO - PID 13112 | 15:38:02 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56015/tests/kraken/driver.html?testName=audio-fft) 15:38:02 INFO - PID 13112 | RSS: Main: 173895680 15:38:02 INFO - PID 13112 | 15:38:05 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56015/tests/kraken/driver.html?testName=audio-oscillator) 15:38:05 INFO - PID 13112 | RSS: Main: 174665728 15:38:05 INFO - PID 13112 | 15:38:07 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:38:08 INFO - PID 13112 | RSS: Main: 174718976 15:38:08 INFO - PID 13112 | 15:38:11 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56015/tests/kraken/driver.html?testName=imaging-darkroom) 15:38:12 INFO - PID 13112 | RSS: Main: 175685632 15:38:12 INFO - PID 13112 | 15:38:15 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56015/tests/kraken/driver.html?testName=imaging-desaturate) 15:38:16 INFO - PID 13112 | RSS: Main: 176443392 15:38:16 INFO - PID 13112 | 15:38:19 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56015/tests/kraken/driver.html?testName=json-parse-financial) 15:38:19 INFO - PID 13112 | RSS: Main: 176418816 15:38:19 INFO - PID 13112 | 15:38:21 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:38:22 INFO - PID 13112 | RSS: Main: 176279552 15:38:22 INFO - PID 13112 | 15:38:24 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:38:24 INFO - PID 13112 | RSS: Main: 176590848 15:38:24 INFO - PID 13112 | 15:38:26 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:38:27 INFO - PID 13112 | RSS: Main: 176402432 15:38:27 INFO - PID 13112 | 15:38:30 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:38:31 INFO - PID 13112 | RSS: Main: 176472064 15:38:31 INFO - PID 13112 | 15:38:34 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:38:34 INFO - PID 13112 | RSS: Main: 176590848 15:38:34 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | Cycle 1(1): loaded http://localhost:56015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56015/tests/kraken/driver.html?testName=ai-astar) 15:38:36 INFO - PID 13112 | RSS: Main: 178311168 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | __start_tp_report 15:38:36 INFO - PID 13112 | _x_x_mozilla_page_load 15:38:36 INFO - PID 13112 | _x_x_mozilla_page_load_details 15:38:36 INFO - PID 13112 | |i|pagename|runs| 15:38:36 INFO - PID 13112 | |0;ai-astar;97;107;110;115;107;109;110;99;109;108 15:38:36 INFO - PID 13112 | |1;audio-beat-detection;148;118;147;178;120;143;145;118;194;128 15:38:36 INFO - PID 13112 | |2;audio-dft;170;168;165;161;164;171;170;175;168;167 15:38:36 INFO - PID 13112 | |3;audio-fft;77;78;74;174;76;77;76;78;162;86 15:38:36 INFO - PID 13112 | |4;audio-oscillator;78;78;130;79;82;83;125;78;79;125 15:38:36 INFO - PID 13112 | |5;imaging-gaussian-blur;119;118;114;115;114;113;113;114;122;115 15:38:36 INFO - PID 13112 | |6;imaging-darkroom;153;150;150;149;149;150;150;151;149;151 15:38:36 INFO - PID 13112 | |7;imaging-desaturate;100;94;94;94;95;94;100;97;94;94 15:38:36 INFO - PID 13112 | |8;json-parse-financial;55;54;55;54;63;58;54;68;57;54 15:38:36 INFO - PID 13112 | |9;json-stringify-tinderbox;55;55;60;59;55;55;56;60;57;54 15:38:36 INFO - PID 13112 | |10;stanford-crypto-aes;77;79;76;76;78;77;75;77;77;75 15:38:36 INFO - PID 13112 | |11;stanford-crypto-ccm;132;137;122;129;124;128;135;126;127;164 15:38:36 INFO - PID 13112 | |12;stanford-crypto-pbkdf2;178;179;186;175;175;175;173;176;183;173 15:38:36 INFO - PID 13112 | |13;stanford-crypto-sha256-iterative;74;70;69;68;66;68;72;67;68;67 15:38:36 INFO - PID 13112 | __end_tp_report 15:38:36 INFO - PID 13112 | __start_cc_report 15:38:36 INFO - PID 13112 | _x_x_mozilla_cycle_collect,967 15:38:36 INFO - PID 13112 | __end_cc_report 15:38:36 INFO - PID 13112 | __startTimestamp1503268716854__endTimestamp 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | ------- Summary: start ------- 15:38:36 INFO - PID 13112 | Number of tests: 14 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#0] ai-astar Cycles:10 Average:107.10 Median:110.00 stddev:5.32 (4.8%) stddev-sans-first:4.21 15:38:36 INFO - PID 13112 | Values: 97.0 107.0 110.0 115.0 107.0 109.0 110.0 99.0 109.0 108.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:146.00 stddev:25.53 (17.5%) stddev-sans-first:27.04 15:38:36 INFO - PID 13112 | Values: 148.0 118.0 147.0 178.0 120.0 143.0 145.0 118.0 194.0 128.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#2] audio-dft Cycles:10 Average:167.90 Median:169.00 stddev:3.96 (2.3%) stddev-sans-first:4.12 15:38:36 INFO - PID 13112 | Values: 170.0 168.0 165.0 161.0 164.0 171.0 170.0 175.0 168.0 167.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#3] audio-fft Cycles:10 Average:95.80 Median:77.00 stddev:38.29 (49.7%) stddev-sans-first:40.00 15:38:36 INFO - PID 13112 | Values: 77.0 78.0 74.0 174.0 76.0 77.0 76.0 78.0 162.0 86.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:78.50 stddev:22.85 (29.1%) stddev-sans-first:23.52 15:38:36 INFO - PID 13112 | Values: 78.0 78.0 130.0 79.0 82.0 83.0 125.0 78.0 79.0 125.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.00 stddev:2.98 (2.6%) stddev-sans-first:2.92 15:38:36 INFO - PID 13112 | Values: 119.0 118.0 114.0 115.0 114.0 113.0 113.0 114.0 122.0 115.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:1.23 (0.8%) stddev-sans-first:0.78 15:38:36 INFO - PID 13112 | Values: 153.0 150.0 150.0 149.0 149.0 150.0 150.0 151.0 149.0 151.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:2.50 (2.7%) stddev-sans-first:2.09 15:38:36 INFO - PID 13112 | Values: 100.0 94.0 94.0 94.0 95.0 94.0 100.0 97.0 94.0 94.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:4.73 (8.5%) stddev-sans-first:4.95 15:38:36 INFO - PID 13112 | Values: 55.0 54.0 55.0 54.0 63.0 58.0 54.0 68.0 57.0 54.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.50 stddev:2.27 (4.0%) stddev-sans-first:2.33 15:38:36 INFO - PID 13112 | Values: 55.0 55.0 60.0 59.0 55.0 55.0 56.0 60.0 57.0 54.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:77.00 stddev:1.25 (1.6%) stddev-sans-first:1.32 15:38:36 INFO - PID 13112 | Values: 77.0 79.0 76.0 76.0 78.0 77.0 75.0 77.0 77.0 75.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:130.50 stddev:12.05 (9.2%) stddev-sans-first:12.78 15:38:36 INFO - PID 13112 | Values: 132.0 137.0 122.0 129.0 124.0 128.0 135.0 126.0 127.0 164.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:177.00 stddev:4.30 (2.4%) stddev-sans-first:4.55 15:38:36 INFO - PID 13112 | Values: 178.0 179.0 186.0 175.0 175.0 175.0 173.0 176.0 183.0 173.0 15:38:36 INFO - PID 13112 | 15:38:36 INFO - PID 13112 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:68.50 stddev:2.47 (3.6%) stddev-sans-first:1.80 15:38:36 INFO - PID 13112 | Values: 74.0 70.0 69.0 68.0 66.0 68.0 72.0 67.0 68.0 67.0 15:38:36 INFO - PID 13112 | -------- Summary: end -------- 15:38:36 INFO - PID 13112 | 15:38:37 INFO - PID 13112 | 15:38:37 INFO - PID 13112 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 15:38:37 INFO - PID 13112 | 15:38:37 INFO - PID 13112 | 15:38:37 INFO - PID 13112 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 15:38:37 INFO - PID 13112 | 15:38:37 INFO - PID 13112 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:38:37 INFO - TEST-INFO | 13112: exit 0 15:38:37 INFO - TEST-OK | kraken | took 62551ms 15:38:37 INFO - SUITE-END | took 1174s 15:38:38 INFO - Completed test suite (00:19:34) 15:38:38 INFO - javascript benchmark 15:38:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8730.401133012621, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.6534281229046, 3155.2742869140106, 3174.6666600006997, 3187.0757480330703, 3191.7765756397052, 5802.767889284423, 6052.57631965762, 6067.302260240068, 6105.60313579617, 6115.785947491839, 6148.877022459559, 6174.10475481055, 6229.937700622992, 6265.3734626537325, 6277.686115694209, 5737.3688894221605, 5751.281089863777, 5773.278340207474, 5816.476517113459, 5834.649921004732, 5488.780448782044, 5635.098384258519, 5686.431356864322, 5820.650760954335, 5830.708464576775, 5595.7481913313595, 5624.775008999635, 5681.0, 5694.4590263925065, 5746.051901436258, 5592.7762889484375, 5604.971975140139, 5654.038813401731, 5686.744096515667, 5690.061139911951, 5508.752106155192, 5578.0, 5587.497125258747, 5598.860028499279, 5610.0, 6054.212952316171, 6130.570860039799, 6208.50331973441, 6235.812925612239, 6242.0, 6667.833304167386, 6726.865462690767, 6741.662916854138, 6774.491913106537, 6775.796726098225, 6751.156105486814, 6752.729890804362, 6843.692033858489, 6847.417969472601, 6855.971604259351, 6074.544409169286, 6080.300765411946, 6182.536309776785, 6193.876122477525, 6198.442140207403, 6850.554713943678, 6915.101036865175, 6936.4797640176175, 6936.7572134975035, 6957.756478523329, 6563.835904102436, 6640.501962352843, 6652.800415987432, 6656.667166641649, 6660.467162626978, 6667.499937504706, 6675.899861502081, 6737.764178253836, 6777.0, 6792.898106528406, 6545.443637290884, 6619.834504137339, 6627.867442651216, 6702.530822842452, 6737.528373013842, 6573.638449885207, 6676.031975363545, 6774.254831968479, 6778.796636100925, 6780.118584584071, 5345.251664766935, 5430.13117901134, 5430.15832545956, 5433.755481003364, 5447.836564903059, 4573.67324983467, 4642.46611639659, 4663.067386522641, 4664.720116793003, 4676.742779147112, 5733.627314224562, 5797.47822695951, 5806.65160090396, 5836.0, 5876.294844618587, 6764.120664313707, 6851.314868513109, 6853.17761868579, 6855.4172895304455, 6864.24493305736, 5823.592348535646, 5876.294844618587, 5893.027650437715, 5900.232969713996, 5908.822735317947, 5900.1149827526215, 5908.084246941731, 5929.0513517836935, 5988.04191329394, 6015.819525414245, 6367.235931688135, 6471.805845824632, 6479.773207937699, 6555.2789193189665, 6596.967015164893, 6767.154105736783, 6795.286494917962, 6798.660066996729, 6804.693788779616, 6812.4890633203695, 6515.315891831289, 6525.673716314071, 6537.934620653733, 6569.4744420445295, 6581.3747693969, 6638.17022872141, 6646.966765166143, 6696.5647232929705, 6709.7316107355155, 6739.157605299338, 6612.768553100618, 6740.831479212863, 6741.325867413416, 6749.696263668245, 6761.966190169214, 6463.64449955257, 6474.935250647622, 6479.935200648122, 6484.610923344614, 6487.54587178893, 6394.4564712, 6427.1002059710745, 6468.676566171766, 6503.934960650333, 6515.73937042513, 6459.870802583828, 6501.1548498694865, 6505.479561634963, 6513.478921686348, 6526.477881769352, 6527.379898909596, 6567.343265673395, 6607.96696016536, 6664.66676666155, 6666.899996499959, 6245.125682404558, 6340.175777148941, 6342.460890824332, 6351.809445716636, 6489.3510648934725], "value": 6110.079688584305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.2545708862024, 862.4480332587145, 886.4282537763147, 892.4243862708553, 1185.6502331812114, 30897.845510772444, 42161.156776864445, 43235.56764432355, 43238.783806081, 43267.35098973514, 43267.78366108173, 43661.12677746451, 43724.0, 43728.344074838904, 43754.562454375446, 7530.171681115073, 7913.0, 8124.553149576771, 8126.349892008625, 8158.918410815875, 7919.485233459835, 8023.558704271263, 8045.879311810328, 8053.395995300347, 8072.959635201816, 7998.400119990994, 8050.838983220332, 8054.033515978091, 8063.233992770707, 8078.636461359223, 7999.320057795095, 8038.678452861878, 8043.638036288381, 8043.999999999971, 8050.074241462248, 7909.090454597737, 7965.203479652047, 7984.680612775482, 7989.800254993614, 8009.279164875189, 38446.61553384458, 39000.219995600215, 39001.609983900365, 39056.804715976235, 39084.21831563353, 3482.9303413931834, 3511.17487390463, 3534.7879127252445, 3541.964580354215, 3544.3088597723454, 31031.37937241265, 31122.221944451343, 31178.220544486343, 31182.37635247305, 31212.8439357804, 5119.667221630582, 5126.871828204287, 5132.973405318951, 5152.407473140562, 5185.403678576974, 186159.0, 186240.0, 186413.0, 186889.0, 187709.0, 46541.0, 46579.5342046582, 46762.766186168854, 47177.29234061492, 47217.0, 49430.50569494259, 49473.25790113079, 49524.50475495271, 49533.752331238116, 49547.25679114816, 15110.093394396372, 16338.509844704678, 16611.750823737413, 16618.916905415397, 16620.83379166217, 12684.42920068599, 14121.929390352983, 14175.078619889675, 14228.217448040457, 14341.354639041268, 14436.927815360856, 14489.420423183166, 14514.564563063124, 14524.782128268085, 14635.0, 5641.351244606923, 5710.2862142232225, 5732.971335143297, 5739.225204597409, 5765.019946609086, 966.2704657983178, 996.9003099690118, 1011.5801942194054, 1013.8276492996208, 1023.3552861697083, 22620.095196191967, 22739.204127855446, 22820.201292954665, 22824.65763013556, 23023.0, 1067.7170549804307, 1100.5597760895546, 1114.414932160606, 1126.2960649594004, 1130.9038731707897, 12043.578474753516, 12113.273203607636, 12135.453904574315, 12142.757144857052, 12202.633920982207, 222709.0, 224562.0, 224938.0, 225271.0, 225296.0, 51752.482475174766, 51841.2223816643, 52040.47959520432, 52087.0, 52156.0, 1446.6889618732023, 1497.6255936015996, 1510.07885190034, 1511.1159971416625, 1526.084349390357, 22784.31647050591, 22816.771832282127, 22901.885490573106, 22926.770732292465, 23094.307170784905, 38049.80975095107, 38157.80921095488, 38167.0, 38216.80891595524, 38229.0, 182011.0, 182153.089234553, 182471.0, 182600.0, 183905.0, 34410.48384274188, 35652.46521302235, 37216.627833721315, 37404.0, 37517.87446376613, 46541.53458465372, 46919.530804691516, 46948.0, 47000.29499557441, 47039.0, 34350.48474272938, 34664.306713866084, 34886.30227395488, 35091.12272193113, 35442.64557354496, 33868.32263354769, 34034.0, 34097.48853767245, 34332.82833585816, 34494.65505345015, 37598.43602345912, 37642.623573763914, 37792.43311350387, 37802.0, 37932.81033594815, 32797.34405311928, 32931.0, 33368.666313337526, 33387.83306083454, 33470.4979425304, 23964.52070958606, 24290.635640465054, 24337.878310608332, 24613.87693061523, 24643.383915402257], "value": 17461.986137228858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6705660132222, 556.4984015471447, 566.1309889319895, 579.6811753535555, 587.6855882103074, 20154.39536813896, 20801.27195548156, 20905.895470522646, 20911.059002344893, 22587.322380328576, 26758.732412675916, 27396.315092122706, 27555.17334479969, 27579.586306205423, 27602.5859612106, 7122.430205583554, 7267.963660181692, 7268.781936541912, 7272.018277532518, 7279.89080163798, 6658.10115634388, 6958.826029349256, 6975.093237879094, 6995.265497122779, 7179.210286868466, 6942.444604431634, 6976.930230697679, 6977.476689248301, 6982.720691172347, 6987.790366288994, 6945.895811562806, 6950.270221626733, 6962.164540255151, 6968.686409111577, 6973.302669733037, 6815.7614483493335, 6841.076454678604, 6853.109095817562, 6858.931410685929, 6864.862702745917, 30594.69405305963, 32094.679053209402, 32641.83679081613, 32658.510122348183, 32779.18052048718, 2044.0393015282793, 2080.573482436097, 2080.989595052015, 2081.7814129516332, 2084.791520847918, 20357.49106272355, 20991.055402506925, 21041.263555775626, 21053.789462105335, 21060.473488162766, 2515.2328539795353, 2518.874056297178, 2532.2403279016407, 2602.700689420722, 2608.699999500063, 136622.31688841493, 139560.0, 139723.0, 139790.0, 139839.30080349534, 20846.0, 21700.34898953034, 21743.130274789146, 21947.0, 22057.669134962987, 44182.77908610436, 44185.558144418144, 44199.33700994487, 44229.894252643295, 44270.0, 11013.449327533592, 11122.888771112348, 11244.49399777012, 11360.23916292976, 11423.143264255214, 8893.911060889308, 9262.351635385457, 9300.441973481613, 9389.812203755886, 9463.90536094644, 9991.850122248172, 11405.433777400018, 11410.771784564262, 11647.6505704829, 11830.645080647595, 4261.232978063978, 4382.289039282784, 4414.872094591503, 4420.933685994648, 4481.865544033684, 953.9284553658504, 969.9515024248759, 983.7098056073476, 989.7483225661678, 991.3457118301886, 19381.4185574433, 19802.50493737668, 20243.898780506297, 20250.0, 20497.897510512354, 1056.1181413519796, 1059.9311044782064, 1060.6977011551826, 1060.7083052160563, 1068.8824229334766, 10970.506327215295, 11373.488193031333, 13255.469781208836, 14075.929620351833, 14139.080959737585, 497985.0, 510185.0, 524190.0, 531530.0, 533101.0, 118226.4088679551, 122360.0, 122378.38810806067, 122518.0, 123320.0, 1267.2016629523525, 1273.3824095313767, 1311.9212847229387, 1315.9078864479586, 1317.4137508808487, 20970.895145524784, 21134.365969020953, 21241.0, 21548.35354939354, 21917.67123493117, 59196.999999998276, 59922.70038649779, 60409.39590604213, 62026.0, 62544.68727656332, 69338.65330673516, 78376.0, 80845.59577202312, 81506.0, 81676.59161704153, 12598.370081495705, 13049.76027277407, 14580.85419145795, 14858.628534286729, 15423.691526169638, 23661.0, 23817.642735358637, 23984.0, 23996.88001559981, 24143.758562414852, 18757.81242187615, 19062.809371906103, 19255.51861203481, 19275.22899084021, 19292.0, 16536.75194872102, 16824.495265142064, 17011.744823827405, 17124.828751712324, 17564.0, 18932.526686832938, 19394.321198757974, 19573.70639440381, 19716.0, 19734.40796776099, 14718.116912985255, 14938.551843444715, 14942.925285373503, 14970.0, 14990.625234369229, 18668.719969200745, 18872.433826985212, 18910.338138165098, 18977.051147442296, 18988.0], "value": 13127.30883317831, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.3102552185624, 1384.9446022159113, 1392.2133994293224, 1410.4710733474947, 1410.8448070712227, 12351.567695130672, 14200.218987955659, 14776.6305842354, 14778.556643300704, 14785.408583656668, 12357.19678220915, 14402.783958240609, 14645.487407940724, 14687.632809179775, 14792.408303667868, 2683.7182095879944, 2728.0997270900652, 2733.7129601391866, 2734.6581677290337, 2735.4939336222765, 2596.0654164500766, 2698.231004163814, 2699.311675522749, 2703.6350092737425, 2703.8783254753484, 2610.4518051209175, 2625.186192280399, 2632.578787394017, 2643.762061414472, 2649.377396311865, 2580.4968031233916, 2593.299809051555, 2610.9216723498325, 2613.3335999320243, 2613.9607905881426, 2497.5504409206337, 2514.120057979711, 2524.482481091372, 2550.7959363250893, 2552.1450314144786, 13836.30818459073, 14244.643883902881, 14245.857541424557, 14251.85748142526, 14270.571882843531, 7614.923850761477, 7867.6459559319965, 7922.920770792276, 7942.880856787153, 7953.483023603505, 4987.526185012418, 5178.249153872705, 5236.266922630834, 5248.396434410053, 5348.786048558053, 1816.7547381103514, 1827.2690923630655, 1828.9725654115198, 1849.6670599292122, 1858.5353661584604, 23434.882825585933, 23547.7645223549, 23568.0, 23605.409864753346, 23622.29133125992, 6942.652867356612, 7005.754798582026, 7103.92896071043, 7222.566646001152, 7278.235785242579, 18611.348602798837, 18619.534511637048, 18648.34730784416, 18661.346852860086, 18681.43955681332, 7816.726414575576, 7929.286364227247, 7931.841363172704, 8114.350851931831, 8116.878246826184, 5908.379620139909, 7121.537100088478, 7153.213146553875, 7184.892226616605, 7249.202587715347, 5378.569714422837, 5486.094794358966, 5506.394296627368, 5539.086050801653, 5570.3315602127195, 1772.2113659421434, 1779.4394765648779, 1783.5273652482103, 1787.1868299923503, 1790.7582476365524, 879.6085741844818, 901.369041670833, 903.5978989349676, 917.4082716647724, 919.2508105893676, 8002.239787220205, 8202.753917382488, 8216.630251638571, 8253.752387428387, 8352.373571982125, 710.0662628643421, 718.608358444649, 721.8347546010676, 723.2984005514643, 729.806601250669, 4668.393108895822, 4737.170995075848, 4757.762111894392, 4776.307435421844, 4779.569838714532, 19293.035348232534, 19590.70613940792, 20044.799552004584, 20347.0, 20358.389248322575, 19331.0, 19982.30061947825, 20014.599708006048, 20015.499612509513, 20016.49958751043, 10903.29128606638, 10940.288881222696, 11102.111831053497, 11121.443927803577, 11132.554697812158, 8310.916890831015, 8328.62521186536, 8332.291755200877, 8409.705660301861, 8457.619407126816, 17251.137443128046, 17259.913700431418, 17425.73861392055, 17668.381606643707, 18115.63768724592, 17595.56011099733, 18036.36872709449, 18044.09779510993, 18056.45830625083, 18189.636207276046, 10850.837237441287, 11133.443327833415, 11142.052925501099, 11254.549818007516, 11565.595204167814, 13688.178709277476, 13940.721185576029, 14012.789808152682, 14014.579562613138, 14023.859761402664, 11070.667879963614, 11083.556657733601, 11227.943860280646, 11263.155263355116, 11457.541698331974, 10817.18871084656, 10900.509477073709, 11024.834627480755, 11170.27393219438, 11390.0, 9647.0, 9817.26370522228, 9831.705048848546, 9843.557039933363, 9862.309638325536, 7456.7762967111075, 7470.103587569526, 7472.551646901204, 7478.0, 7488.588127653032, 7180.281971802778, 7439.739609113655, 7456.627168641655, 7467.701291948261, 7469.402447804054], "value": 6510.826244472066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.5188089731616, 500.44200716201425, 516.4525602860967, 520.8020952038225, 523.5811350919264, 6239.563230573862, 6253.59351642143, 6287.591306565081, 6296.748130074791, 6298.338674439186, 6085.78699745509, 6114.798672477916, 6164.660943648098, 6228.0, 6262.499000079994, 5077.238414237857, 5117.33474648297, 5117.641765076446, 5174.120399532088, 5221.425643179266, 4859.829905953292, 5068.1890897456415, 5096.719680417576, 5109.3613298337705, 5190.273361729361, 4871.512848715136, 4898.755062246892, 4936.605071594264, 4953.801847926096, 4958.132326842806, 4885.022995400934, 4930.260460930853, 4957.231629097514, 4970.627202959774, 5007.84976450707, 4447.911041779146, 4448.154850578379, 4463.085067561175, 4487.506374298857, 4497.775111244425, 5990.592210830451, 6079.574429789916, 6110.022396416552, 6115.419035191694, 6136.8158955230965, 5697.373288938214, 5741.224934633813, 5742.6841523716175, 5780.8843823123725, 5784.248047753765, 6473.223213214397, 6546.967265163644, 6575.3095924927675, 6586.868262634768, 6602.73589056442, 4863.562279394871, 4865.299758633957, 4875.68308059975, 4930.876728081791, 4932.804901818692, 6583.794428866336, 6791.932080679228, 6903.1716194056535, 6904.3095690431055, 6939.7224111036, 5024.422191447957, 5033.471485494044, 5046.116929537389, 5062.82280120194, 5062.924056139161, 5046.419661738947, 5083.204237669341, 5083.491650834887, 5123.513266239701, 5129.9230511542355, 5669.177969194526, 5704.80033198836, 5718.342390625048, 5748.137779333133, 5787.681677507778, 6608.471322294205, 6639.170103737033, 6661.566998145105, 6670.833229169212, 6723.747544572623, 1770.7963584187726, 1799.560351718646, 1800.6488734696609, 1807.3041878876463, 1807.9638407231782, 1178.4166837415535, 1219.8838063172097, 1231.5566396097397, 1236.5223557848285, 1251.249250449741, 5811.15738217956, 5844.649321040752, 5844.6785426801935, 5853.824385268449, 5872.76671898906, 6729.629870357079, 6734.764283250062, 6767.763128290486, 6773.491988100814, 6854.931450685429, 5757.510611597977, 5805.129230615442, 5837.460704593515, 5865.970670146708, 5876.559258055663, 3590.622984586633, 3593.365018916387, 3616.710663146942, 3640.8179591020344, 3641.344557979536, 6528.902066469007, 6573.605583664996, 6588.769393071316, 6622.0, 6658.4673226141795, 6894.689738961759, 6907.930920690829, 6937.895931561031, 7034.030471467997, 7082.681279342442, 6473.967630161725, 6553.901691474632, 6569.540132190701, 6606.240282367589, 6657.633830139292, 6308.526860485574, 6659.467242620482, 6693.196816382066, 6728.226253980855, 6749.561278517077, 6654.767083152066, 6661.933380666325, 6674.399304062657, 6690.230623478362, 6753.223379311442, 6401.647909364843, 6535.57518761279, 6540.8880490315805, 6552.63960482178, 6561.866024404594, 4941.456439791692, 4997.500249975119, 5007.949920500894, 5015.119330251156, 5103.668261562986, 6437.935620643733, 6515.837104072247, 6616.371444712745, 6756.358145976124, 6833.0, 6477.481801455967, 6485.902711459237, 6507.674616269073, 6580.5064620154635, 6592.406683398517, 6526.836829079311, 6549.7380104795275, 6563.1796025496815, 6598.736050557924, 6598.967005164944, 6479.0, 6528.804135875931, 6534.934650653433, 6540.476761859135, 6593.703283352164, 6643.2360278568585, 6656.1394391253925, 6656.83357916056, 6658.334166583303, 6660.0, 6352.6506042166275, 6381.521385895983, 6390.648514331757, 6393.1688880445245, 6486.2216534016225], "value": 5085.50882911075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.1654078248012, 925.2967744514169, 935.8736570562972, 937.3625934364638, 951.900050494698, 18938.715919261205, 19630.60738785225, 19635.0, 19649.803501964976, 22106.778932210673, 21512.139514419403, 22228.0, 22238.777612223872, 22336.10655573775, 22411.43971400716, 997.0826839307854, 999.4902599674182, 999.8200323941687, 1000.7648202672366, 1024.0783295034473, 1028.0952761569808, 1061.787642471505, 1066.919981001424, 1070.5022164693416, 1074.6131392698621, 1125.2123513540514, 1130.581684776634, 1130.7851508213414, 1131.1798945764338, 1132.1339175530725, 1115.046635126967, 1123.522502936253, 1124.0726400719398, 1129.9604513842057, 1131.6548452721916, 816.249050873198, 822.7531740477892, 824.7154731617583, 825.0759149752256, 825.4799476329933, 17939.461816145536, 18021.0, 18041.639167216712, 18573.0, 19956.70064949027, 22015.779842201693, 22131.225407110673, 22179.66730499044, 22529.098836046538, 22651.660225096635, 16577.254023568967, 16642.66714665712, 16711.582210444714, 16830.15849207535, 16943.322267109303, 3654.3604869148057, 3673.981630091859, 3676.5036720042717, 3677.7057835373375, 3679.4480827875764, 126752.0, 127264.36367818102, 128118.0, 132670.3366483171, 132941.0, 16718.331266749436, 16909.154542272838, 16935.407260745815, 17000.319987200623, 17294.962302261905, 30490.237744056132, 30690.38619227603, 30728.846355768077, 32140.357192856012, 32585.674143258737, 7671.6164191790185, 7959.602019899097, 8518.659253629785, 8597.5701214939, 8641.30869530436, 4137.731047481964, 4217.430646862635, 4235.915281694411, 4252.829886804493, 4260.55264197261, 5312.5484333832055, 5400.702961337164, 5403.459654034565, 5435.320584926884, 5441.564674826004, 1089.4334945828125, 1105.3920343811033, 1110.123002827757, 1115.5537784885948, 1119.9496022679, 676.5534747067011, 690.6581242285, 701.1060897355912, 701.8175274428685, 711.718871045934, 11944.701382465335, 12153.817692734616, 12308.076894232789, 12316.261024338568, 13293.933530332286, 647.6502688548131, 654.0320325917573, 658.404144249455, 664.9268580456146, 687.4294335701356, 5730.398308177665, 5797.955778472671, 5837.562182836219, 5844.503217226584, 5963.463288303987, 115230.0, 115474.42262788632, 116217.0, 116794.0, 119225.40387298008, 96572.51713741386, 96713.51643241738, 98701.0, 100498.0, 105017.0, 90147.54926225326, 93628.53185734028, 93756.53121734348, 93979.53010234905, 95838.52080739551, 12593.748125037631, 12748.61754147377, 13127.868721312665, 13357.465701372224, 13464.394102265618, 41314.79342603268, 42758.358624620036, 42908.0, 43485.34771978486, 44654.10691786211, 52928.0, 75321.62339188269, 78423.60788196251, 80243.59878200805, 85422.57288713516, 19984.400467985983, 20354.389368318974, 20391.694124587848, 20627.58744825125, 20799.8960005199, 18382.448526544224, 21305.46736331542, 21900.12399504002, 23244.76755232426, 23574.646380304654, 19781.70327445118, 20251.898740506793, 20531.589368212255, 20594.0, 20673.58652826965, 19797.40607781769, 20207.19171233193, 20286.0, 20378.18487260493, 20404.591908162052, 19196.520086997938, 19438.4168474946, 19505.414837554898, 19581.51046223856, 19636.607267854277, 13749.656258593215, 13979.44082236699, 14056.367463463965, 14523.636909077357, 14716.632084197981, 13629.795553066513, 14041.36813843359, 14745.557633271019, 15228.314725837585, 15407.306671200047], "value": 9547.514182572791, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 110.0, 115.0, 107.0, 109.0, 110.0, 99.0, 109.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 147.0, 178.0, 120.0, 143.0, 145.0, 118.0, 194.0, 128.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 165.0, 161.0, 164.0, 171.0, 170.0, 175.0, 168.0, 167.0], "value": 167.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 74.0, 174.0, 76.0, 77.0, 76.0, 78.0, 162.0, 86.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 130.0, 79.0, 82.0, 83.0, 125.0, 78.0, 79.0, 125.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 122.0, 115.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0, 151.0, 149.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 94.0, 94.0, 94.0, 95.0, 94.0, 100.0, 97.0, 94.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 63.0, 58.0, 54.0, 68.0, 57.0, 54.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 60.0, 59.0, 55.0, 55.0, 56.0, 60.0, 57.0, 54.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 76.0, 76.0, 78.0, 77.0, 75.0, 77.0, 77.0, 75.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 122.0, 129.0, 124.0, 128.0, 135.0, 126.0, 127.0, 164.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 186.0, 175.0, 175.0, 175.0, 173.0, 176.0, 183.0, 173.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 69.0, 68.0, 66.0, 68.0, 72.0, 67.0, 68.0, 67.0], "value": 68.9, "unit": "score"}]}]} 15:38:38 INFO - Return code: 0 15:38:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:38:38 INFO - # TBPL SUCCESS # 15:38:38 INFO - Running post-action listener: _package_coverage_data 15:38:38 INFO - Running post-action listener: _resource_record_post_action 15:38:38 INFO - [mozharness: 2017-08-20 22:38:38.168293Z] Finished run-tests step (success) 15:38:38 INFO - Running post-run listener: _resource_record_post_run 15:38:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 445276160; Read time: 68; Write time: 354140 15:38:38 INFO - TinderboxPrint: CPU usage
13.2% 15:38:38 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 68 15:38:38 INFO - TinderboxPrint: I/O write bytes / time
445,276,160 / 354,140 15:38:38 INFO - TinderboxPrint: CPU idle
8,258.5 (86.8%) 15:38:38 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 15:38:38 INFO - TinderboxPrint: Swap in / out
0 / 0 15:38:38 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117092352; Read time: 16; Write time: 119876 15:38:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:38:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 328183808; Read time: 52; Write time: 234264 15:38:38 INFO - Running post-run listener: _upload_blobber_files 15:38:38 INFO - Blob upload gear active. 15:38:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:38:38 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 15:38:38 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'] 15:38:38 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 15:38:39 INFO - (blobuploader) - INFO - Open directory for files ... 15:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:40 INFO - (blobuploader) - INFO - Done attempting. 15:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:40 INFO - (blobuploader) - INFO - Done attempting. 15:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:38:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:41 INFO - (blobuploader) - INFO - Done attempting. 15:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:38:44 INFO - (blobuploader) - INFO - Done attempting. 15:38:44 INFO - (blobuploader) - INFO - Iteration through files over. 15:38:44 INFO - Return code: 0 15:38:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:38:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:38:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2355ef696b0b823c04d76da3e2e8d0abb0c5b498e25c77b8a56ac20ef2d3efca4f898038ab9ec5e185a299cb160870a556407fcb6431a99aef5728291e9dff5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ee81584bedef2ef8c039c3eb8de9edb2da515dc1beb9c3b8075b27e2697b180019368dd8ff5f234c09dbcdc76a1d00141420c0b861d9c1b37e072b5b015db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91905c9ef84dcdc44551e18a855f778b5332056aabdf78c90c07e323c7aab293b07336497776ee19ed111bf6d01f02fd7159d09c10eb6db3cae71a388050b679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21fe9059546a665c7066dc5815287820e65559b3905cefd56104a277d043fde526fbb11b9601ca16ac6ed2a23204cdbf7beae8c37ef2f75f4b18abdc75096ae5"} 15:38:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:38:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:38:44 INFO - Contents: 15:38:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2355ef696b0b823c04d76da3e2e8d0abb0c5b498e25c77b8a56ac20ef2d3efca4f898038ab9ec5e185a299cb160870a556407fcb6431a99aef5728291e9dff5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ee81584bedef2ef8c039c3eb8de9edb2da515dc1beb9c3b8075b27e2697b180019368dd8ff5f234c09dbcdc76a1d00141420c0b861d9c1b37e072b5b015db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91905c9ef84dcdc44551e18a855f778b5332056aabdf78c90c07e323c7aab293b07336497776ee19ed111bf6d01f02fd7159d09c10eb6db3cae71a388050b679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21fe9059546a665c7066dc5815287820e65559b3905cefd56104a277d043fde526fbb11b9601ca16ac6ed2a23204cdbf7beae8c37ef2f75f4b18abdc75096ae5"} 15:38:44 INFO - Running post-run listener: copy_logs_to_upload_dir 15:38:44 INFO - Copying logs to upload dir... 15:38:44 INFO - mkdir: /builds/slave/test/build/upload/logs 15:38:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.475137 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-20 15:38:44.313738) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:44.321155) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 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/2355ef696b0b823c04d76da3e2e8d0abb0c5b498e25c77b8a56ac20ef2d3efca4f898038ab9ec5e185a299cb160870a556407fcb6431a99aef5728291e9dff5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ee81584bedef2ef8c039c3eb8de9edb2da515dc1beb9c3b8075b27e2697b180019368dd8ff5f234c09dbcdc76a1d00141420c0b861d9c1b37e072b5b015db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91905c9ef84dcdc44551e18a855f778b5332056aabdf78c90c07e323c7aab293b07336497776ee19ed111bf6d01f02fd7159d09c10eb6db3cae71a388050b679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21fe9059546a665c7066dc5815287820e65559b3905cefd56104a277d043fde526fbb11b9601ca16ac6ed2a23204cdbf7beae8c37ef2f75f4b18abdc75096ae5"} build_url:https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/W2sfHt0TS8KDAxRbisPdNA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2355ef696b0b823c04d76da3e2e8d0abb0c5b498e25c77b8a56ac20ef2d3efca4f898038ab9ec5e185a299cb160870a556407fcb6431a99aef5728291e9dff5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd4ee81584bedef2ef8c039c3eb8de9edb2da515dc1beb9c3b8075b27e2697b180019368dd8ff5f234c09dbcdc76a1d00141420c0b861d9c1b37e072b5b015db", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91905c9ef84dcdc44551e18a855f778b5332056aabdf78c90c07e323c7aab293b07336497776ee19ed111bf6d01f02fd7159d09c10eb6db3cae71a388050b679", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21fe9059546a665c7066dc5815287820e65559b3905cefd56104a277d043fde526fbb11b9601ca16ac6ed2a23204cdbf7beae8c37ef2f75f4b18abdc75096ae5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:44.350403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:44.350729) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1503267468.209604-442352373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 15:38:44.432486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:44.435804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 15:38:44.436065) ========= ========= Total master_lag: -0.20 =========