builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1501410750.12 results: success (0) revision: 8b577b152383f5560ab57fdc307fa872cd268ea7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.122155) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.122601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.122882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.140649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.140941) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 03:32:30-- 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% 101M=0s 2017-07-30 03:32:30 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.205855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.363428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.363749) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015426 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.420689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:30.421025) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b577b152383f5560ab57fdc307fa872cd268ea7 --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 8b577b152383f5560ab57fdc307fa872cd268ea7 --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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 03:32:30,488 truncating revision to first 12 chars 2017-07-30 03:32:30,488 Setting DEBUG logging. 2017-07-30 03:32:30,488 attempt 1/10 2017-07-30 03:32:30,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b577b152383?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:32:30,801 unpacking tar archive at: mozilla-central-8b577b152383/testing/mozharness/ program finished with exit code 0 elapsedTime=0.608047 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:31.044812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:31.045133) ========= script_repo_revision: 8b577b152383f5560ab57fdc307fa872cd268ea7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:31.045514) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:31.045794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:32:31.082792) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-30 03:32:31.083097) ========= /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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:32:31 INFO - MultiFileLogger online at 20170730 03:32:31 in /builds/slave/test 03:32:31 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 03:32:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:31 INFO - {'append_to_log': False, 03:32:31 INFO - 'base_work_dir': '/builds/slave/test', 03:32:31 INFO - 'blob_upload_branch': 'Firefox', 03:32:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:31 INFO - 'branch': 'Firefox', 03:32:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:31 INFO - 'code_coverage': False, 03:32:31 INFO - 'config_files': ('talos/linux_config.py',), 03:32:31 INFO - 'default_actions': ('clobber', 03:32:31 INFO - 'read-buildbot-config', 03:32:31 INFO - 'download-and-extract', 03:32:31 INFO - 'populate-webroot', 03:32:31 INFO - 'create-virtualenv', 03:32:31 INFO - 'install', 03:32:31 INFO - 'setup-mitmproxy', 03:32:31 INFO - 'run-tests'), 03:32:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:31 INFO - 'disable_ccov_upload': False, 03:32:31 INFO - 'download_minidump_stackwalk': True, 03:32:31 INFO - 'download_symbols': 'ondemand', 03:32:31 INFO - 'enable_stylo': False, 03:32:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:31 INFO - 'gecko_profile': False, 03:32:31 INFO - 'gecko_profile_interval': 0, 03:32:31 INFO - 'installer_path': 'installer.exe', 03:32:31 INFO - 'log_level': 'info', 03:32:31 INFO - 'log_name': 'talos', 03:32:31 INFO - 'log_to_console': True, 03:32:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:32:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:32:31 INFO - 'opt_config_files': (), 03:32:31 INFO - 'pip_index': False, 03:32:31 INFO - 'suite': 'dromaeojs-e10s', 03:32:31 INFO - 'system_bits': '32', 03:32:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:31 INFO - 'title': 'talos-linux64-ix-001', 03:32:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:31 INFO - 'use_talos_json': True, 03:32:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:31 INFO - 'work_dir': 'build'} 03:32:31 INFO - [mozharness: 2017-07-30 10:32:31.262586Z] Running clobber step. 03:32:31 INFO - Running pre-action listener: _resource_record_pre_action 03:32:31 INFO - Running main action method: clobber 03:32:31 INFO - rmtree: /builds/slave/test/build 03:32:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:32 INFO - Running post-action listener: _resource_record_post_action 03:32:32 INFO - [mozharness: 2017-07-30 10:32:32.289223Z] Finished clobber step (success) 03:32:32 INFO - [mozharness: 2017-07-30 10:32:32.289326Z] Running read-buildbot-config step. 03:32:32 INFO - Running pre-action listener: _resource_record_pre_action 03:32:32 INFO - Running main action method: read_buildbot_config 03:32:32 INFO - Using buildbot properties: 03:32:32 INFO - { 03:32:32 INFO - "project": "", 03:32:32 INFO - "product": "firefox", 03:32:32 INFO - "who": "archaeopteryx@coole-files.de", 03:32:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:32:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:32:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:32:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:32:32 INFO - "stage_platform": "linux64-pgo", 03:32:32 INFO - "basedir": "/builds/slave/test", 03:32:32 INFO - "buildnumber": 92, 03:32:32 INFO - "platform": "ubuntu64_hw", 03:32:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:32:32 INFO - "slavebuilddir": "test", 03:32:32 INFO - "taskId": "d1tAM286SZ2fN8EFdzHgtA", 03:32:32 INFO - "branch": "mozilla-central", 03:32:32 INFO - "script_repo_revision": "production", 03:32:32 INFO - "revision": "8b577b152383f5560ab57fdc307fa872cd268ea7", 03:32:32 INFO - "slavename": "talos-linux64-ix-001", 03:32:32 INFO - "repo_path": "mozilla-central" 03:32:32 INFO - } 03:32:32 INFO - Finding installer, test and symbols from parent task. 03:32:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d1tAM286SZ2fN8EFdzHgtA'}, attempt #1 03:32:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d1tAM286SZ2fN8EFdzHgtA'}, attempt #1 03:32:33 INFO - Task dependencies: O1hVlqEqSA64Rm7ExMLfAg 03:32:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg'}, attempt #1 03:32:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 03:32:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.test_packages.json 03:32:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.crashreporter-symbols.zip 03:32:33 INFO - Running post-action listener: _resource_record_post_action 03:32:33 INFO - [mozharness: 2017-07-30 10:32:33.641880Z] Finished read-buildbot-config step (success) 03:32:33 INFO - [mozharness: 2017-07-30 10:32:33.642102Z] Running download-and-extract step. 03:32:33 INFO - Running pre-action listener: _resource_record_pre_action 03:32:33 INFO - Running main action method: download_and_extract 03:32:33 INFO - mkdir: /builds/slave/test/build/tests 03:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:33 INFO - trying https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.test_packages.json 03:32:33 INFO - Downloading https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:32:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:32:34 INFO - Downloaded 989 bytes. 03:32:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:32:34 INFO - Using the following test package requirements: 03:32:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:32:34 INFO - u'common': [u'target.common.tests.zip'], 03:32:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:32:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:32:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:32:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:32:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:32:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:32:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:32:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:32:34 INFO - u'target.web-platform.tests.tar.gz'], 03:32:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:32:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:32:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip 03:32:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:32:34 INFO - Fetch https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip into memory 03:32:36 INFO - Content-Length response header: 73183138 03:32:36 INFO - Bytes received: 73183138 03:32:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:32:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip 03:32:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:32:48 INFO - Fetch https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.common.tests.zip into memory 03:32:50 INFO - Content-Length response header: 73183138 03:32:50 INFO - Bytes received: 73183138 03:33:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.talos.tests.zip 03:33:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:33:04 INFO - Fetch https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.talos.tests.zip into memory 03:33:05 INFO - Content-Length response header: 14496686 03:33:05 INFO - Bytes received: 14496686 03:33:05 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')]} 03:33:05 INFO - trying https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 03:33:05 INFO - Downloading https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:33:06 INFO - Downloaded 63012004 bytes. 03:33:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 03:33:06 INFO - mkdir: /builds/slave/test/properties 03:33:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:06 INFO - Contents: 03:33:06 INFO - build_url:https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 03:33:06 INFO - Running post-action listener: _resource_record_post_action 03:33:06 INFO - Running post-action listener: set_extra_try_arguments 03:33:06 INFO - [mozharness: 2017-07-30 10:33:06.560019Z] Finished download-and-extract step (success) 03:33:06 INFO - [mozharness: 2017-07-30 10:33:06.560117Z] Running populate-webroot step. 03:33:06 INFO - Running pre-action listener: _resource_record_pre_action 03:33:06 INFO - Running main action method: populate_webroot 03:33:06 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:06 INFO - 'tests': ['damp', 'tps']}, 03:33:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:33:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:33:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:06 INFO - 'ts_paint', 03:33:06 INFO - 'tpaint', 03:33:06 INFO - 'sessionrestore', 03:33:06 INFO - 'sessionrestore_many_windows', 03:33:06 INFO - 'sessionrestore_no_auto_restore', 03:33:06 INFO - 'tabpaint']}, 03:33:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:33:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:33:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:06 INFO - 'talos_options': ['--mitmproxy', 03:33:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:06 INFO - '--firstNonBlankPaint'], 03:33:06 INFO - 'tests': ['quantum_pageload_google', 03:33:06 INFO - 'quantum_pageload_youtube', 03:33:06 INFO - 'quantum_pageload_amazon', 03:33:06 INFO - 'quantum_pageload_facebook']}, 03:33:06 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:06 INFO - 'talos_options': ['--stylo', 03:33:06 INFO - '--mitmproxy', 03:33:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:06 INFO - '--firstNonBlankPaint'], 03:33:06 INFO - 'tests': ['quantum_pageload_google', 03:33:06 INFO - 'quantum_pageload_youtube', 03:33:06 INFO - 'quantum_pageload_amazon', 03:33:06 INFO - 'quantum_pageload_facebook']}, 03:33:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:06 INFO - 'tsvgr_opacity', 03:33:06 INFO - 'tart', 03:33:06 INFO - 'tscrollx', 03:33:06 INFO - 'cart', 03:33:06 INFO - 'tsvg_static']}, 03:33:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:06 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:06 INFO - 'talos_options': ['--stylo', 03:33:06 INFO - '--stylo-threads=1', 03:33:06 INFO - '--mitmproxy', 03:33:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:06 INFO - '--firstNonBlankPaint'], 03:33:06 INFO - 'tests': ['tp6_google', 03:33:06 INFO - 'tp6_youtube', 03:33:06 INFO - 'tp6_amazon', 03:33:06 INFO - 'tp6_facebook']}, 03:33:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:06 INFO - 'talos_options': ['--xperf_path', 03:33:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:06 INFO - 'tests': ['tp5n']}}} 03:33:06 INFO - Running post-action listener: _resource_record_post_action 03:33:06 INFO - [mozharness: 2017-07-30 10:33:06.568782Z] Finished populate-webroot step (success) 03:33:06 INFO - [mozharness: 2017-07-30 10:33:06.568874Z] Running create-virtualenv step. 03:33:06 INFO - Running pre-action listener: _resource_record_pre_action 03:33:06 INFO - Running main action method: create_virtualenv 03:33:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:06 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 03:33:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:33:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:33:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:06 INFO - Using real prefix '/usr' 03:33:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:07 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:09 INFO - Installing pip.................done. 03:33:09 INFO - Return code: 0 03:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:09 INFO - Reading from file tmpfile_stdout 03:33:09 INFO - Output received: 03:33:09 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) 03:33:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:09 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:09 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 03:33:09 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 03:33:09 INFO - Using env: {'DISPLAY': ':0', 03:33:09 INFO - 'HOME': '/home/cltbld', 03:33:09 INFO - 'LANG': 'en_US.UTF-8', 03:33:09 INFO - 'LANGUAGE': 'en_US:en', 03:33:09 INFO - 'LOGNAME': 'cltbld', 03:33:09 INFO - 'MAIL': '/var/mail/cltbld', 03:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:09 INFO - 'MOZ_NO_REMOTE': '1', 03:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:09 INFO - 'NO_EM_RESTART': '1', 03:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:09 INFO - 'PWD': '/builds/slave/test', 03:33:09 INFO - 'SHELL': '/bin/bash', 03:33:09 INFO - 'SHLVL': '1', 03:33:09 INFO - 'TERM': 'linux', 03:33:09 INFO - 'TMOUT': '86400', 03:33:09 INFO - 'USER': 'cltbld', 03:33:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:09 INFO - '_': '/tools/buildbot/bin/python'} 03:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:09 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 03:33:09 INFO - Cleaning up... 03:33:09 INFO - Return code: 0 03:33:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:09 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:09 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 03:33:09 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 03:33:09 INFO - Using env: {'DISPLAY': ':0', 03:33:09 INFO - 'HOME': '/home/cltbld', 03:33:09 INFO - 'LANG': 'en_US.UTF-8', 03:33:09 INFO - 'LANGUAGE': 'en_US:en', 03:33:09 INFO - 'LOGNAME': 'cltbld', 03:33:09 INFO - 'MAIL': '/var/mail/cltbld', 03:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:09 INFO - 'MOZ_NO_REMOTE': '1', 03:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:09 INFO - 'NO_EM_RESTART': '1', 03:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:09 INFO - 'PWD': '/builds/slave/test', 03:33:09 INFO - 'SHELL': '/bin/bash', 03:33:09 INFO - 'SHLVL': '1', 03:33:09 INFO - 'TERM': 'linux', 03:33:09 INFO - 'TMOUT': '86400', 03:33:09 INFO - 'USER': 'cltbld', 03:33:09 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:09 INFO - '_': '/tools/buildbot/bin/python'} 03:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:09 INFO - Downloading/unpacking psutil>=3.1.1 03:33:09 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 03:33:09 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 03:33:09 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 03:33:09 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 03:33:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:11 INFO - Installing collected packages: psutil 03:33:11 INFO - Running setup.py install for psutil 03:33:11 INFO - building 'psutil._psutil_linux' extension 03:33:11 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 03:33:11 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 03:33:11 INFO - building 'psutil._psutil_posix' extension 03:33:11 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 03:33:11 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 03:33:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:11 INFO - Successfully installed psutil 03:33:11 INFO - Cleaning up... 03:33:11 INFO - Return code: 0 03:33:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:11 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')]} 03:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:11 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')]} 03:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:11 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:11 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 03:33:11 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 03:33:11 INFO - Using env: {'DISPLAY': ':0', 03:33:11 INFO - 'HOME': '/home/cltbld', 03:33:11 INFO - 'LANG': 'en_US.UTF-8', 03:33:11 INFO - 'LANGUAGE': 'en_US:en', 03:33:11 INFO - 'LOGNAME': 'cltbld', 03:33:11 INFO - 'MAIL': '/var/mail/cltbld', 03:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:11 INFO - 'MOZ_NO_REMOTE': '1', 03:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:11 INFO - 'NO_EM_RESTART': '1', 03:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:11 INFO - 'PWD': '/builds/slave/test', 03:33:11 INFO - 'SHELL': '/bin/bash', 03:33:11 INFO - 'SHLVL': '1', 03:33:11 INFO - 'TERM': 'linux', 03:33:11 INFO - 'TMOUT': '86400', 03:33:11 INFO - 'USER': 'cltbld', 03:33:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:11 INFO - '_': '/tools/buildbot/bin/python'} 03:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33:11 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 03:33:11 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 03:33:11 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 03:33:11 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 03:33:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:12 INFO - Installing collected packages: mozsystemmonitor 03:33:12 INFO - Running setup.py install for mozsystemmonitor 03:33:13 INFO - Successfully installed mozsystemmonitor 03:33:13 INFO - Cleaning up... 03:33:13 INFO - Return code: 0 03:33:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:13 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')]} 03:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:13 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')]} 03:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:13 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:13 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 03:33:13 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 03:33:13 INFO - Using env: {'DISPLAY': ':0', 03:33:13 INFO - 'HOME': '/home/cltbld', 03:33:13 INFO - 'LANG': 'en_US.UTF-8', 03:33:13 INFO - 'LANGUAGE': 'en_US:en', 03:33:13 INFO - 'LOGNAME': 'cltbld', 03:33:13 INFO - 'MAIL': '/var/mail/cltbld', 03:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:13 INFO - 'MOZ_NO_REMOTE': '1', 03:33:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:13 INFO - 'NO_EM_RESTART': '1', 03:33:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:13 INFO - 'PWD': '/builds/slave/test', 03:33:13 INFO - 'SHELL': '/bin/bash', 03:33:13 INFO - 'SHLVL': '1', 03:33:13 INFO - 'TERM': 'linux', 03:33:13 INFO - 'TMOUT': '86400', 03:33:13 INFO - 'USER': 'cltbld', 03:33:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:13 INFO - '_': '/tools/buildbot/bin/python'} 03:33:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:33:13 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 03:33:13 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 03:33:13 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 03:33:13 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 03:33:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:14 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 03:33:14 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 03:33:14 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 03:33:14 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 03:33:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:14 INFO - warning: no files found matching '*.txt' 03:33:14 INFO - no previously-included directories found matching 'build' 03:33:14 INFO - no previously-included directories found matching 'dist' 03:33:14 INFO - no previously-included directories found matching '.git*' 03:33:14 INFO - Installing collected packages: jsonschema, functools32 03:33:14 INFO - Running setup.py install for functools32 03:33:14 INFO - warning: no files found matching '*.txt' 03:33:14 INFO - no previously-included directories found matching 'build' 03:33:14 INFO - no previously-included directories found matching 'dist' 03:33:14 INFO - no previously-included directories found matching '.git*' 03:33:14 INFO - Successfully installed jsonschema functools32 03:33:14 INFO - Cleaning up... 03:33:14 INFO - Return code: 0 03:33:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:14 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:14 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 03:33:14 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 03:33:14 INFO - Using env: {'DISPLAY': ':0', 03:33:14 INFO - 'HOME': '/home/cltbld', 03:33:14 INFO - 'LANG': 'en_US.UTF-8', 03:33:14 INFO - 'LANGUAGE': 'en_US:en', 03:33:14 INFO - 'LOGNAME': 'cltbld', 03:33:14 INFO - 'MAIL': '/var/mail/cltbld', 03:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:14 INFO - 'MOZ_NO_REMOTE': '1', 03:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:14 INFO - 'NO_EM_RESTART': '1', 03:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:14 INFO - 'PWD': '/builds/slave/test', 03:33:14 INFO - 'SHELL': '/bin/bash', 03:33:14 INFO - 'SHLVL': '1', 03:33:14 INFO - 'TERM': 'linux', 03:33:14 INFO - 'TMOUT': '86400', 03:33:14 INFO - 'USER': 'cltbld', 03:33:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:14 INFO - '_': '/tools/buildbot/bin/python'} 03:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:14 INFO - Cleaning up... 03:33:14 INFO - Return code: 0 03:33:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:14 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:14 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 03:33:14 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 03:33:14 INFO - Using env: {'DISPLAY': ':0', 03:33:14 INFO - 'HOME': '/home/cltbld', 03:33:14 INFO - 'LANG': 'en_US.UTF-8', 03:33:14 INFO - 'LANGUAGE': 'en_US:en', 03:33:14 INFO - 'LOGNAME': 'cltbld', 03:33:14 INFO - 'MAIL': '/var/mail/cltbld', 03:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:14 INFO - 'MOZ_NO_REMOTE': '1', 03:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:14 INFO - 'NO_EM_RESTART': '1', 03:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:14 INFO - 'PWD': '/builds/slave/test', 03:33:14 INFO - 'SHELL': '/bin/bash', 03:33:14 INFO - 'SHLVL': '1', 03:33:14 INFO - 'TERM': 'linux', 03:33:14 INFO - 'TMOUT': '86400', 03:33:14 INFO - 'USER': 'cltbld', 03:33:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:14 INFO - '_': '/tools/buildbot/bin/python'} 03:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:15 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 03:33:15 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 03:33:15 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 03:33:15 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 03:33:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 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 03:33:16 INFO - Downloading docopt-0.6.1.tar.gz 03:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:16 INFO - Running setup.py install for blobuploader 03:33:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:16 INFO - Running setup.py install for requests 03:33:17 INFO - Running setup.py install for docopt 03:33:17 INFO - Successfully installed blobuploader requests docopt 03:33:17 INFO - Cleaning up... 03:33:17 INFO - Return code: 0 03:33:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:17 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')]} 03:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:17 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')]} 03:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:17 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:17 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 03:33:17 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 03:33:17 INFO - Using env: {'DISPLAY': ':0', 03:33:17 INFO - 'HOME': '/home/cltbld', 03:33:17 INFO - 'LANG': 'en_US.UTF-8', 03:33:17 INFO - 'LANGUAGE': 'en_US:en', 03:33:17 INFO - 'LOGNAME': 'cltbld', 03:33:17 INFO - 'MAIL': '/var/mail/cltbld', 03:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:17 INFO - 'MOZ_NO_REMOTE': '1', 03:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:17 INFO - 'NO_EM_RESTART': '1', 03:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:17 INFO - 'PWD': '/builds/slave/test', 03:33:17 INFO - 'SHELL': '/bin/bash', 03:33:17 INFO - 'SHLVL': '1', 03:33:17 INFO - 'TERM': 'linux', 03:33:17 INFO - 'TMOUT': '86400', 03:33:17 INFO - 'USER': 'cltbld', 03:33:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:17 INFO - '_': '/tools/buildbot/bin/python'} 03:33:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:17 INFO - Running setup.py (path:/tmp/pip-ErYHmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:17 INFO - Running setup.py (path:/tmp/pip-MIkIA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:17 INFO - Running setup.py (path:/tmp/pip-9f4lOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:17 INFO - Running setup.py (path:/tmp/pip-TNpVWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:17 INFO - Running setup.py (path:/tmp/pip-9gOtCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:18 INFO - Running setup.py (path:/tmp/pip-mK21TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:18 INFO - Running setup.py (path:/tmp/pip-3nWo9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:18 INFO - Running setup.py (path:/tmp/pip-2qRhXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:18 INFO - Running setup.py (path:/tmp/pip-lwqi7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:18 INFO - Running setup.py (path:/tmp/pip-1hGyx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:18 INFO - Running setup.py (path:/tmp/pip-lzh0Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:18 INFO - Running setup.py (path:/tmp/pip-VYfxAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:18 INFO - Running setup.py (path:/tmp/pip-NSd3Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:18 INFO - Running setup.py (path:/tmp/pip-9IQZjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:18 INFO - Running setup.py (path:/tmp/pip-MYRSUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:18 INFO - Running setup.py (path:/tmp/pip-vtxT6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:18 INFO - Running setup.py (path:/tmp/pip-lsrTuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:18 INFO - Running setup.py install for manifestparser 03:33:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:18 INFO - Running setup.py install for mozcrash 03:33:19 INFO - Running setup.py install for mozdebug 03:33:19 INFO - Running setup.py install for mozdevice 03:33:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Running setup.py install for mozfile 03:33:19 INFO - Running setup.py install for mozhttpd 03:33:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Running setup.py install for mozinfo 03:33:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Running setup.py install for mozInstall 03:33:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Running setup.py install for mozleak 03:33:19 INFO - Running setup.py install for mozlog 03:33:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:19 INFO - Running setup.py install for moznetwork 03:33:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Running setup.py install for mozprocess 03:33:20 INFO - Running setup.py install for mozprofile 03:33:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Running setup.py install for mozrunner 03:33:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Running setup.py install for mozscreenshot 03:33:20 INFO - Running setup.py install for moztest 03:33:20 INFO - Running setup.py install for mozversion 03:33:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:20 INFO - Cleaning up... 03:33:20 INFO - Return code: 0 03:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:20 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')]} 03:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:20 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')]} 03:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:20 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:20 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 03:33:20 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 03:33:20 INFO - Using env: {'DISPLAY': ':0', 03:33:20 INFO - 'HOME': '/home/cltbld', 03:33:20 INFO - 'LANG': 'en_US.UTF-8', 03:33:20 INFO - 'LANGUAGE': 'en_US:en', 03:33:20 INFO - 'LOGNAME': 'cltbld', 03:33:20 INFO - 'MAIL': '/var/mail/cltbld', 03:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:20 INFO - 'MOZ_NO_REMOTE': '1', 03:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:20 INFO - 'NO_EM_RESTART': '1', 03:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:20 INFO - 'PWD': '/builds/slave/test', 03:33:20 INFO - 'SHELL': '/bin/bash', 03:33:20 INFO - 'SHLVL': '1', 03:33:20 INFO - 'TERM': 'linux', 03:33:20 INFO - 'TMOUT': '86400', 03:33:20 INFO - 'USER': 'cltbld', 03:33:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:20 INFO - '_': '/tools/buildbot/bin/python'} 03:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:20 INFO - Running setup.py (path:/tmp/pip-dIOGVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:20 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)) 03:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:20 INFO - Running setup.py (path:/tmp/pip-Ka9L8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:21 INFO - Running setup.py (path:/tmp/pip-AZsuDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:21 INFO - Running setup.py (path:/tmp/pip-0Aodba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:21 INFO - Running setup.py (path:/tmp/pip-wYnUaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:21 INFO - Running setup.py (path:/tmp/pip-4omNnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:21 INFO - Running setup.py (path:/tmp/pip-E49au2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:21 INFO - Running setup.py (path:/tmp/pip-ySNUwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:21 INFO - Running setup.py (path:/tmp/pip-TBNhRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:21 INFO - Running setup.py (path:/tmp/pip-9pJFnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:21 INFO - Running setup.py (path:/tmp/pip-invACy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:21 INFO - Running setup.py (path:/tmp/pip-sNMKYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:21 INFO - Running setup.py (path:/tmp/pip-W9HK_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:21 INFO - Running setup.py (path:/tmp/pip-YTmALG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:21 INFO - Running setup.py (path:/tmp/pip-v_gJ0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:21 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)) 03:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:21 INFO - Running setup.py (path:/tmp/pip-yw4APp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:22 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)) 03:33:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:22 INFO - Running setup.py (path:/tmp/pip-cnv18b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:22 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)) 03:33:22 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)) 03:33:22 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)) 03:33:22 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)) 03:33:22 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)) 03:33:22 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)) 03:33:22 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)) 03:33:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:23 INFO - Downloading blessings-1.6.tar.gz 03:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:23 INFO - Installing collected packages: blessings 03:33:23 INFO - Running setup.py install for blessings 03:33:23 INFO - Successfully installed blessings 03:33:23 INFO - Cleaning up... 03:33:23 INFO - Return code: 0 03:33:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:23 INFO - Reading from file tmpfile_stdout 03:33:23 INFO - Current package versions: 03:33:23 INFO - argparse == 1.2.1 03:33:23 INFO - blessings == 1.6 03:33:23 INFO - blobuploader == 1.2.4 03:33:23 INFO - docopt == 0.6.1 03:33:23 INFO - functools32 == 3.2.3-2 03:33:23 INFO - jsonschema == 2.5.1 03:33:23 INFO - manifestparser == 1.1 03:33:23 INFO - mozInstall == 1.13 03:33:23 INFO - mozcrash == 1.0 03:33:23 INFO - mozdebug == 0.1 03:33:23 INFO - mozdevice == 0.51 03:33:23 INFO - mozfile == 1.2 03:33:23 INFO - mozhttpd == 0.7 03:33:23 INFO - mozinfo == 0.10 03:33:23 INFO - mozleak == 0.1 03:33:23 INFO - mozlog == 3.5 03:33:23 INFO - moznetwork == 0.27 03:33:23 INFO - mozprocess == 0.25 03:33:23 INFO - mozprofile == 0.28 03:33:23 INFO - mozrunner == 6.13 03:33:23 INFO - mozscreenshot == 0.1 03:33:23 INFO - mozsystemmonitor == 0.3 03:33:23 INFO - moztest == 0.8 03:33:23 INFO - mozversion == 1.4 03:33:23 INFO - psutil == 3.1.1 03:33:23 INFO - requests == 1.2.3 03:33:23 INFO - wsgiref == 0.1.2 03:33:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33: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')]} 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33: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')]} 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:23 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 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:23 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 03:33:23 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 03:33:23 INFO - Using env: {'DISPLAY': ':0', 03:33:23 INFO - 'HOME': '/home/cltbld', 03:33:23 INFO - 'LANG': 'en_US.UTF-8', 03:33:23 INFO - 'LANGUAGE': 'en_US:en', 03:33:23 INFO - 'LOGNAME': 'cltbld', 03:33:23 INFO - 'MAIL': '/var/mail/cltbld', 03:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:23 INFO - 'MOZ_NO_REMOTE': '1', 03:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:23 INFO - 'NO_EM_RESTART': '1', 03:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:23 INFO - 'PWD': '/builds/slave/test', 03:33:23 INFO - 'SHELL': '/bin/bash', 03:33:23 INFO - 'SHLVL': '1', 03:33:23 INFO - 'TERM': 'linux', 03:33:23 INFO - 'TMOUT': '86400', 03:33:23 INFO - 'USER': 'cltbld', 03:33:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:23 INFO - '_': '/tools/buildbot/bin/python'} 03:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 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)) 03:33:23 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:33:23 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 03:33:23 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 03:33:23 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 03:33:23 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 03:33:24 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:33:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:33:25 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)) 03:33:25 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)) 03:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:33:25 INFO - Installing collected packages: marionette-driver, simplejson 03:33:25 INFO - Running setup.py install for marionette-driver 03:33:25 INFO - Running setup.py install for simplejson 03:33:25 INFO - building 'simplejson._speedups' extension 03:33:25 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 03:33:26 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 03:33:26 INFO - Successfully installed marionette-driver simplejson 03:33:26 INFO - Cleaning up... 03:33:26 INFO - Return code: 0 03:33:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d4a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b9d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, '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': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', '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 03:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:26 INFO - Using env: {'DISPLAY': ':0', 03:33:26 INFO - 'HOME': '/home/cltbld', 03:33:26 INFO - 'LANG': 'en_US.UTF-8', 03:33:26 INFO - 'LANGUAGE': 'en_US:en', 03:33:26 INFO - 'LOGNAME': 'cltbld', 03:33:26 INFO - 'MAIL': '/var/mail/cltbld', 03:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:26 INFO - 'MOZ_NO_REMOTE': '1', 03:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:26 INFO - 'NO_EM_RESTART': '1', 03:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:26 INFO - 'PWD': '/builds/slave/test', 03:33:26 INFO - 'SHELL': '/bin/bash', 03:33:26 INFO - 'SHLVL': '1', 03:33:26 INFO - 'TERM': 'linux', 03:33:26 INFO - 'TMOUT': '86400', 03:33:26 INFO - 'USER': 'cltbld', 03:33:26 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:26 INFO - '_': '/tools/buildbot/bin/python'} 03:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:26 INFO - Cleaning up... 03:33:26 INFO - Return code: 0 03:33:26 INFO - Running post-action listener: _resource_record_post_action 03:33:26 INFO - Running post-action listener: _start_resource_monitoring 03:33:26 INFO - Starting resource monitoring. 03:33:26 INFO - [mozharness: 2017-07-30 10:33:26.759736Z] Finished create-virtualenv step (success) 03:33:26 INFO - [mozharness: 2017-07-30 10:33:26.760239Z] Running install step. 03:33:26 INFO - Running pre-action listener: _resource_record_pre_action 03:33:26 INFO - Running main action method: install 03:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:26 INFO - Reading from file tmpfile_stdout 03:33:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:27 INFO - Reading from file tmpfile_stdout 03:33:27 INFO - Output received: 03:33:27 INFO - Usage: mozinstall [options] installer 03:33:27 INFO - Options: 03:33:27 INFO - -h, --help show this help message and exit 03:33:27 INFO - -d DEST, --destination=DEST 03:33:27 INFO - Directory to install application into. [default: 03:33:27 INFO - "/builds/slave/test"] 03:33:27 INFO - --app=APP Application being installed. [default: firefox] 03:33:27 INFO - mkdir: /builds/slave/test/build/application 03:33:27 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'] 03:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:33:45 INFO - Reading from file tmpfile_stdout 03:33:45 INFO - Output received: 03:33:45 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:45 INFO - Running post-action listener: _resource_record_post_action 03:33:45 INFO - [mozharness: 2017-07-30 10:33:45.021517Z] Finished install step (success) 03:33:45 INFO - [mozharness: 2017-07-30 10:33:45.021775Z] Running setup-mitmproxy step. 03:33:45 INFO - Running pre-action listener: _resource_record_pre_action 03:33:45 INFO - Running main action method: setup_mitmproxy 03:33:45 INFO - Skipping: mitmproxy is not required 03:33:45 INFO - Running post-action listener: _resource_record_post_action 03:33:45 INFO - [mozharness: 2017-07-30 10:33:45.022909Z] Finished setup-mitmproxy step (success) 03:33:45 INFO - [mozharness: 2017-07-30 10:33:45.023136Z] Running run-tests step. 03:33:45 INFO - Running pre-action listener: _resource_record_pre_action 03:33:45 INFO - Running pre-action listener: _set_gcov_prefix 03:33:45 INFO - Running main action method: run_tests 03:33:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:45 INFO - Python 2.7.3 03:33:45 INFO - Return code: 0 03:33:45 INFO - grabbing minidump binary from tooltool 03:33:45 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')]} 03:33:45 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 0x20b6eb0>, '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 0x20b7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b8240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:45 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 03:33:45 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 03:33:45 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 03:33:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:45 INFO - Return code: 0 03:33:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:45 INFO - ENV: RUST_BACKTRACE is now 1 03:33:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:45 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/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:33:45 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/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 03:33:45 INFO - Using env: {'DISPLAY': ':0', 03:33:45 INFO - 'HOME': '/home/cltbld', 03:33:45 INFO - 'LANG': 'en_US.UTF-8', 03:33:45 INFO - 'LANGUAGE': 'en_US:en', 03:33:45 INFO - 'LOGNAME': 'cltbld', 03:33:45 INFO - 'MAIL': '/var/mail/cltbld', 03:33:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:45 INFO - 'MOZ_NO_REMOTE': '1', 03:33:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:45 INFO - 'NO_EM_RESTART': '1', 03:33:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:45 INFO - 'PWD': '/builds/slave/test', 03:33:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:45 INFO - 'RUST_BACKTRACE': '1', 03:33:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:33:45 INFO - 'SHELL': '/bin/bash', 03:33:45 INFO - 'SHLVL': '1', 03:33:45 INFO - 'TERM': 'linux', 03:33:45 INFO - 'TMOUT': '86400', 03:33:45 INFO - 'USER': 'cltbld', 03:33:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767', 03:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:45 INFO - '_': '/tools/buildbot/bin/python'} 03:33:45 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/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:33:45 INFO - mozversion application_buildid: 20170730091942 03:33:45 INFO - mozversion application_changeset: 8b577b152383f5560ab57fdc307fa872cd268ea7 03:33:45 INFO - mozversion application_display_name: Nightly 03:33:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:45 INFO - mozversion application_name: Firefox 03:33:45 INFO - mozversion application_remotingname: firefox 03:33:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:45 INFO - mozversion application_vendor: Mozilla 03:33:45 INFO - mozversion application_version: 56.0a1 03:33:45 INFO - mozversion platform_buildid: 20170730091942 03:33:45 INFO - mozversion platform_changeset: 8b577b152383f5560ab57fdc307fa872cd268ea7 03:33:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:45 INFO - mozversion platform_version: 56.0a1 03:33:45 INFO - using testdate: 1501410825 03:33:45 INFO - actual date: 1501410825 03:33:45 INFO - starting webserver on 'localhost:40143' 03:33:45 INFO - SUITE-START | Running 2 tests 03:33:45 INFO - TEST-START | dromaeo_css 03:33:45 INFO - Initialising browser for dromaeo_css test... 03:33:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html -profile /tmp/tmpcysoFu/profile 03:33:45 INFO - TEST-INFO | started process 17925 (/builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html) 03:33:50 INFO - TEST-INFO | 17925: exit 0 03:33:51 INFO - Browser initialized. 03:33:51 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:51 INFO - TEST-INFO | started process 18137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcysoFu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:51 INFO - PID 18137 | 03:33:51 INFO - PID 18137 | (/builds/slave/test/build/application/firefox/firefox:18185): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:33:51 INFO - PID 18137 | 03:34:02 INFO - PID 18137 | RSS: Main: 164229120 03:34:02 INFO - PID 18137 | 03:36:59 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40143/tests/dromaeo/cssquery-ext.html) 03:37:02 INFO - PID 18137 | RSS: Main: 166703104 03:37:02 INFO - PID 18137 | 03:40:04 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-ext.html (next: http://localhost:40143/tests/dromaeo/cssquery-jquery.html) 03:40:05 INFO - PID 18137 | RSS: Main: 164155392 03:40:05 INFO - PID 18137 | 03:43:06 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40143/tests/dromaeo/cssquery-mootools.html) 03:43:07 INFO - PID 18137 | RSS: Main: 166068224 03:43:07 INFO - PID 18137 | 03:46:08 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40143/tests/dromaeo/cssquery-prototype.html) 03:46:09 INFO - PID 18137 | RSS: Main: 164438016 03:46:09 INFO - PID 18137 | 03:49:13 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40143/tests/dromaeo/cssquery-yui.html) 03:49:13 INFO - PID 18137 | RSS: Main: 167878656 03:49:13 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | Cycle 1(1): loaded http://localhost:40143/tests/dromaeo/cssquery-yui.html (next: http://localhost:40143/tests/dromaeo/cssquery-dojo.html) 03:52:15 INFO - PID 18137 | RSS: Main: 168550400 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | __start_tp_report 03:52:15 INFO - PID 18137 | _x_x_mozilla_page_load 03:52:15 INFO - PID 18137 | _x_x_mozilla_page_load_details 03:52:15 INFO - PID 18137 | |i|pagename|runs| 03:52:15 INFO - PID 18137 | |0;dojo.html;3363.495475678649;3380.9492857607133;3390.4405773047442;3414.1635299351665;3419.145213696576;6131.846703832406;6223.875522489553;6266.310705822356;6271.968640156804;6278.560500764948;6052.939470605293;6117.235345581802;6120.265568131819;6122.571420000601;6149.938500614992;5280.128778751501;5324.467553244684;5328.440513746059;5336.67979921204;5422.701751403672;5480.506754392104;5488.121900495921;5498.340199176105;5521.337439507265;5527.474889885474;5368.141097424394;5447.645903016291;5451.672899626035;5504.4495550445035;5537.280153580049;5258.0535503609335;5323.387810401776;5326.653767505139;5422.674639521641;5425.728713564306;5356.705381204032;5362.2224777407055;5417;5431.103867861798;5445.700486473282;5821.214136091616;6061.272647282311;6109.847253818646;6127.11156882254;6139.693015349215;6523.347665233486;6564.048213009087;6583.341665833426;6618.7021584028835;6629.668516574152;6676.13210282665;6758.628275444848;6775.457963362919;6780.254172041072;6782.694778734969;6160.907586386208;6163.599366041193;6252.406021427957;6271.184745982993;6277.246730392382;6572.671366431755;6678.532502724763;6681;6684.064231007663;6843.281455447206;6440.80677579664;6441.806745797634;6442.710078046499;6448.548601597937;6457.418832305115;6489.513286503531;6540.640264785482;6562.934370656328;6566.638834864033;6566.67166641666;6489.448396886223;6505.186851643544;6617.503687223381;6678.065070890079;6708.899366509506;6658.667066646648;6727.428168605626;6754.864902701918;6757.054012438262;6764.0530325754435;4803.687760295639;4845.297431872359;4882.584980276716;4897;4905.9264111038365;4226.619604235633;4270.530241673413;4283.336082907154;4347.152305300436;4374.671899607542;6390.488760899117;6408.743650254031;6461.483081353481;6463.967680161663;6466.094746735461;6697.430718388894;6703.162104736908;6780.288069752703;6781.728730850711;6801;6245.156903817927;6285.874282514415;6293.402126798039;6296.181496405438;6300.464460520815;5434.619576629598;5459.69971651555;5469.179623056573;5472.2065300531995;5474.863128421821;6935.306469353024;6936.132983377078;6937;6950.756723514653;6956.408705260008;6522.119513865568;6569;6598.274189839018;6605.966970165311;6606.10817539626;6927.965360173369;6932.930670693228;6955.269696681978;6962.930370696431;7154.427645788429;6520.706568204348;6568.6058836469965;6595.901061484177;6670.466362691071;6673.432758215606;6595.505337099833;6733.898991515229;6742.089817874524;6778.93221067783;6835.14560679915;6428.132202152649;6443.96778016107;6444.033394990602;6444.194475690539;6450.548461607643;6506.479481641552;6534;6539.411452969065;6561.573497722633;6572.277049524453;6351.809445716636;6464.612123272619;6542.051402546699;6554.213494380705;6561.704723287368;6383.808485745435;6451.70967306463;6456.6771661415805;6473.1261279728515;6486.189226346707;6145.354737752472;6274.215723034621;6300.243970723543;6300.653464059521;6304.968475157595 03:52:15 INFO - PID 18137 | |1;ext.html;811.8884308156364;929.2287401456791;953.7901661634443;1178.8408564843749;1206.2641788509013;41472.58527414725;44769.10461790762;44895.326570101475;45018;45067;46126.30810537836;46314.30528542075;46342.76828615852;46389.536104638944;46522.30216546755;7465;7702.614869256543;7706.576138312391;7707.190744971781;7708.30625243728;7562.924370756305;7658.578778167199;7667.118281397627;7670;7671.846563068735;7635;7642.961785191066;7654.3111119999185;7685.077790665128;7687.000689910304;7594.354479869217;7632.961835190788;7633.313001829806;7640.159582445926;7663.233676632376;7468.178500364956;7532;7534.924650753477;7537.246275372474;7548.962255188744;41409.585904141175;41668.583314166775;41732.79133604343;41774.79112604448;41866.79066604647;3443.913902152441;3470.9305813883834;3473;3475.7566970312087;3483.651634836521;32784.50823237653;32798;32812.67187328144;32927.50608740871;33015;4794.5205479452125;4850.175470170079;4865.318855360252;4868.853934381974;4903.803847846082;207906;211026;211253;211427;211963;53098.469015309354;53138.734306328224;53273.2009019865;53453.79277243378;53637;56130.43869561334;56551;56677.43322566721;56736.716316418155;56898.7155064222;15236.31436585334;15497.225138743017;16299.674006519803;16426.75359869603;16764.329426823035;13543.661408464866;13570.796438053438;13572.864271357357;13576.389062492211;13589.524366647318;15366.692666146839;15485.535433937;15550.144742039296;15564.143972081643;15597.532074037797;6056.3338032816355;6075.33171351151;6078.787242446493;6145.354737752472;6190.3190649028575;1085.9945700271448;1100.350793032115;1100.5927806711409;1108.5177947592822;1109.4397329348628;24851.87574062118;24857.5028499429;25048.4990300193;25226.87386563092;25342.493150136896;1174.0959461214989;1199.7060720123452;1203.1337437045313;1224.1920332580455;1229.766344394562;12990.285534295705;13404.32978351098;13470.865291346961;13501.459941602423;13531.45874165042;263446;265014;266236;266298;267720;56825;57255.71372143113;57319.42680573224;57369;57731;1516.6966606678488;1539.1073177556991;1570.6780110077407;1578.0925967568694;1583.3270859884503;24627.261182164562;30349;30519.23701907381;30946.845265774427;31732.36535269328;54019.72990135024;54202.72898635639;54277.72861135669;54279.72860135674;54308.45691543192;225586;226410;227150;227783;227904;35536.64463355333;35902.461463077554;38063.80968095142;38070.61929380671;38176;48104.27843582419;50161;50303.245451318995;50404;50561.49438505568;34053;34575.82712086423;35726.46410303796;36164.27671446609;36347.27305453929;34710.479342809376;35356.46965295574;35706.28587428289;35748.4637730429;35757.28485430329;41359.1728165429;42705.78647106869;42851;43144.35283470688;43330;33104.66895331112;35670.64329356673;35967.82016089903;36340.636593633724;36709.44935825912;26581.202563923114;27066;27134.45731085328;27198.320041999108;27225.86387068052 03:52:15 INFO - PID 18137 | |2;jquery.html;569.3054473542279;578.8986927287724;581.9534437245015;589.1104432307217;592.3720855892755;23090.307290781282;23332.41668958277;23902.163424280152;23959;24015.879920600393;27103.45793084142;27587.310317242078;27762.16713498593;27776.58335124975;27802.860985695093;6204.317525072239;6299.464545513637;6397.392247736481;6402.967985160068;6404.103425520431;5718.628289161212;6277.1839660844025;6299.811005669814;6306.180196574439;6312.779052733155;6264.21697287839;6267.0286105653695;6279.748810047616;6279.780207692732;6283;6203.503719702436;6244.0633904914175;6245.125682404467;6263.373662633723;6265.498760099181;5855.209546711182;5855.297364316267;5856.531477481792;5861.032929566616;5866.14940833581;28928.27679308013;30218;30705;30925;30928.8453557733;2185.497335612818;2223.0663121489015;2223.633100538409;2225.376894469551;2225.4770129019666;20219.797802022087;20718;20798.064087116116;20802.751834889954;20829.89585052065;2360.9527809443716;2435.768601982809;2437.2079074300923;2462.704475462956;2504.023430861965;160010;162067;162690;163145;163209.18395408065;15258;15725.911263071685;16043.759343609856;16333.183340832911;16365;24429.26712198637;25126.497470050497;25524.744752552608;25636.871815641174;25690;10591.735206619896;10602.469876506299;10660.413677247825;10716.410597417062;10924.67225983206;9742.31803773729;9791.902080979098;9828.557714902847;9865.408075515348;9921.702348929399;9811.656592019244;10005.249606279413;10270.948645256874;10323.122534584494;10470.476476176313;2875.346675661503;2878.5682147678017;2895.4932886744737;2918.658854296632;3038.3315670552442;1032.8605638238892;1035.891231420705;1058.5871510111062;1061.4692653673164;1094.190299178618;21323.25368612122;21437.571248574943;21593.460163496038;21867.562648746934;22268.66597001046;1119.8432219489277;1120.5461787975883;1120.6918097523246;1132.620572108353;1134.500819639356;11313.943430282961;14282.85717142836;15163.848361516464;15487.30307136159;15700.607484812743;611706;614831;628288;634813;638451;142142.28928855289;142545;144760;147652;148603;1339.9062065655505;1358.8844948179317;1385.300423286234;1391.7773156294945;1394.5537428023138;22296.665550017085;23200.883995579916;23358.64962025605;23458.64812027855;23503.17738879131;62666;62963.6851815738;64134;66101.66949165224;66945.3305466939;81344.59327703323;81512.18487815045;81643.5917820407;82752.17247827686;82848.58575707083;15411.922940385226;15694;15911.124888131264;15938.60153496172;15941.920290398473;23553.764462355157;24699;25004.749952500242;25135.622965655897;25332.493350133263;20065.39803805888;20140;20158.59682806365;20301.08645111003;20442.48893777608;16383.918080409998;17359.479215623553;17658.5585360367;17823.28706851763;18279.360222392683;20675.379738607866;20856.270030549465;20881.791182087985;20921.790782091983;21111.8944405277;14780.556583302518;15564.84435155634;15565;15651.843481565038;15773;20153.496162596053;20337.59324813525;20350.898245508677;20438.591228175057;20456.89771551192 03:52:15 INFO - PID 18137 | |3;mootools.html;1407.901446898717;1462.2104063805546;1464.472789795674;1477.7266205751937;1482.2144263540326;14439.711205775891;14978.850211497882;15001.699966000673;15011.32449039793;15032.473863414783;15465.613359665986;15687.215639218051;15712.214389280518;15727.921360393211;15800;2621.7640412362834;2657.9601305980427;2661.0287245155478;2662.1747258349974;2662.9201123966313;2494.3514686181634;2532;2608.0350270399977;2708.756211940925;2712.620233167358;2623.6326914232022;2652.085030664418;2652.1778248742853;2655.3759866431374;2655.668041494813;2522.4576716006054;2539.390546268901;2556.6037264224074;2556.7059788124416;2587.133310341038;2550.9489810203877;2557.1177943609423;2565.217608629367;2565.6279839423364;2567.5763499022823;14494.492692755808;14729.116253024853;14747.483838065617;14748.557543273719;14752.55742327732;7858.410619203582;8106.229908158715;8107.95946020272;8134.959325203336;8156.510609363457;5065.544101030925;5226.8693282667855;5245.973770131163;5318.627696061278;5411.269478620415;1881.6142690748363;1898.9715154272697;1903.6573416784972;1928.9710654340197;1949.522367020075;24331.391715207083;24461.755382446303;24622.753772462223;25394.238172854843;25459.618105728245;6743.35938085881;6876.828079298058;6889.311068893171;6926.2034865990045;7038.085048943707;17145.657086858442;17275.913620431817;17372.47882563525;17389.65220695579;17419.041952692725;7999.640016199169;8111.351091912633;8114.553699546582;8117;8129.796755081052;7173.820654483576;7308.415326773846;7385.593792341473;7394.149672787591;7409.444291678145;5076.289319495274;5211.374635043819;5266.34170728659;5269.156934890476;5302.125149350391;1555.9922200388926;1565.4599163288647;1575.708493928627;1587.1905328282428;1605.7511085781723;856.674463703801;871.6382701179067;871.9694810681596;897.8114595934927;915.6337465014047;7081.92918070823;7243.818904527324;7259.782206533812;7349.30181632744;7422.777316680508;707.342171780239;715.3919168706558;735.1619154164257;736.14607055815;753.7248904150056;4076.286649836267;4803.327534145223;5023.773930173151;5127.487251274917;5227.26818245446;20638.896805515877;21571.245006425015;21689.132434702435;21700.891495542422;21716.457088572595;20258.189672413235;20674.17303307881;20799.896000520203;21043.263485777923;21049.263275785273;10473.371597704163;10852.403117828595;11391.544338226378;11487.0810335173;11806.586769463027;7670.463067585216;7864.84270314579;7923.326517246099;7928.84142317162;8102;17055;18009.549761256072;18422.35521756732;18668.813311867252;18919.148638311584;18512.16695248744;18541.536461588566;18548.165332560337;18946.715799262747;18965.62068758645;12084.093692973238;12344.074194435632;12426;12503.062270329943;12523.56167534132;13907.443702252202;13936.790948135584;14088.36602352876;14088.929555352157;14097.436102555783;10826.56693732242;11262.436878156223;11492.310461372344;11502;11761.764764704829;10525.157987360839;10936.289141205796;11056.613018544313;11140.387278699749;11168.441577921234;9257.814843702954;9430.3398762086;9431.386959847589;9434.339596228197;9434.85847712271;6547.639879806657;6790.42281406086;6866.244713081657;6909.30906909305;6936.098307220029;6416.390442907917;6514.218293804774;6832.59004459734;6959.304069593;7046.718131274896 03:52:15 INFO - PID 18137 | |4;prototype.html;497.70664584756526;508.83717210492637;525.1623660261882;534.3000669123446;540.3677697094399;6105.267367915851;6109.572329936901;6116.357782432848;6183.783567575136;6190.75236990521;6066.6663333516635;6078;6095.51235901128;6128.693565321727;6129.509639228862;4875.829345972892;4899.167141585939;4904.288878112671;4911.852644420665;4943.604511639078;4566.223741963858;4682.899518613123;4715.764211789414;4837.685550439228;4840.184930651006;4635.791389387468;4638.628909687234;4670.696404733699;4717.834875779348;4739.976300118495;4673.182193116225;4673.784815947844;4703.506131856174;4715.434147902257;4727.739974301412;4235.703500754948;4248.660107191417;4257.148570285955;4268.807903644312;4297.806598703066;5830.82507524775;5912.201852749867;5932.970335148297;5949.345571987078;5958.255218097738;5582.916256256119;5664.291963504562;5674.829755107354;5681.318241810968;5756.165356023395;6404.935950640527;6425.389587989133;6452.4515416189215;6454.354564543555;6463.644499552523;4838.346823178897;4842.394700662418;4843.782029808667;4892.143874821892;4928.950710492921;6606.174228221473;6700.443698285116;6729.596224226562;6752.291009443987;6853.17761868574;4998.6750861193905;5012.1980483122525;5024.648274620815;5030.924536131961;5036.11867923112;4973.303737476756;5009.398872135294;5044;5057.317262169634;5087.923681144785;5618.578606604521;5631.099024156116;5648.796969182023;5680.11958146488;5732.226149469851;6466.870662586722;6516.804495865132;6563.343665633399;6568.835779105465;6577.3422657733845;1744.127936031984;1745.7343426016037;1767.354915455875;1783.7335491800707;1791.1939627167567;1175.7060734816296;1238.6222202228407;1254.0782524844233;1257.4970011995092;1259.4710221706905;6127.234095738033;6132.117904584838;6177.567570270038;6228.377162283736;6281.434670879551;6569.408753212138;6574.013897915255;6592.769253076215;6593.274739778716;6637.137172167587;6167.136600875881;6240.719167637467;6244.219472565929;6258.77813376254;6267.122602835607;3483.9722281926893;3497.5453191085;3506.9298614027575;3521.3133438979153;3541.6812486876306;6838.931610683929;6859.211190713132;6883.208431030395;6939.340762627542;6956.860862782716;6783.607032409246;6808.863822723518;6832.282610325944;6838.48711346651;6861.416779573692;6344;6842.605088219084;6892;6903.240643529208;6979.40675042627;6482;6527.314631963765;6543.5419520633095;6558.114654521579;6582.124094633006;6440.066190402459;6472.773452929125;6495.577787443801;6501.934980650322;6591.110200122922;6981.8254543634785;7031.859362812817;7039;7041;7058.6470676467;5050.77271522775;5053.494650534917;5072.416672082758;5076.796928122833;5085.974570127126;6403.3276505966205;6481.773137940149;6527.5757075789925;6686.531942764154;6714.328567143247;6369.87260254783;6391.424771770563;6425.9036114457385;6475.417212450902;6537.346265373425;6361.741581738416;6421.293657697743;6426.839329016812;6465.224173099258;6503.187101612299;6453.709583068679;6457.806265812033;6458.160439142881;6459.354064593691;6489.8702025960165;6372.96813515948;6493.610383377012;6519.630877515585;6556.409923106943;6561.901571476336;6289.811305660837;6322.49420046386;6329.335419781041;6341.968290158704;6354.555181137276 03:52:15 INFO - PID 18137 | |5;yui.html;948.7248697877616;952.9714108576741;969.9127078562927;973.6202880876455;975.9072888075635;17991.19039643216;19228.903855480738;19278.132484038233;19328;20351.491212719688;20375.694364584542;21705.67441488375;21826.672599911013;21967.23114690986;22095.558088838214;1036.6319956415477;1066.7173199102244;1071.346478648024;1075.2526993739355;1075.9085477734402;1083.2579682917226;1087.6900083476212;1090.9727256818603;1091;1091.3615534912085;1146.7133216695827;1148.0643275730295;1148.161841855446;1151.2689442204219;1153.2734377342304;1123.0341905960868;1130.2766229613055;1131.0668698323834;1132.0773569540797;1136.2898188632105;836.0552575589605;836.2933321343455;836.9497830130211;837.1252041616525;837.2004735477665;19545.80454195454;19859;19886;20081.09635066411;20252;17584.472465826046;17611.647767044717;17811.376601818873;17971.371002015;18103.456896293133;16174.27215775293;16591.170441477876;16722.24749886258;16724.916375418168;17034.23345949423;3709.3694072007825;3749.9625003749884;3755.605661405568;3761.9090463765474;3767.4348847672795;130217;135211.32394338064;136982;138808;139733;16580.336786528405;16581.419650312422;16836;17075.40236091731;17203.913980430018;31231.21921951924;32066.679333206837;32414.675853241166;32481.837590812367;32706.67293327084;8003.439759216799;8580.656773729106;8697.913020869837;8762.430442021248;9549.809003819884;4418.823247070145;4563.680542362003;4575.450945886515;4582.9770851146195;4585.679002469862;5445.074337362578;5461.699606521679;5542.7782888684005;5579.246801681802;5585.553155747531;1108.2020944919645;1125.352922069813;1135.5457816873318;1139.7720455908852;1142.4858813533776;727.421699748701;740.8110931712379;741.9666115024729;746.1941103608091;763.6334559411514;11231.900356369866;12840.486380544673;13084.214947103204;13239.205647660978;13317.267550284634;702.1889717376438;712.9465290103263;720.135836995597;727.3671905442193;734.8713975054344;5892.145638882424;5984.8803023940145;6138.600990935664;6184.257889053342;6350.079238510482;127594;130384;130680;134003.32998334945;134339;113240;113849;114801;115785.4210728941;118098.40950795192;101909;102240.48879755553;103536.48231758793;104066;104732.47633761934;11734.765304693688;12083.516659333529;12133.150679452354;12475.812862807246;13134.343282836011;42013;43824;44569.331460027475;45780.542194577625;46036.53963460323;78682;81302.59348703218;82714;83494.58252708698;86131;20800.791992080492;20883;21032.684509732062;21034.47413814667;21144.259950901644;21263.68104478465;21312.14751409988;21508;22703.318900433012;22767;20628.484287892923;21160.576788464452;21269.89365053165;21311.57376852423;21779.891100544395;20400.897995509928;20413.183472660927;20493.180272788923;20549.79450205479;21130.577388452453;20088;20309.79690203079;20402.79597204009;20973.370798876058;21154.259600913894;13265.270410127536;13926.442942282196;13988.58034258974;14415;14624.707505850036;15224.771628425804;15281.847181528043;15327.693446130792;15617.609559761097;15723.842761572696 03:52:15 INFO - PID 18137 | __end_tp_report 03:52:15 INFO - PID 18137 | __start_cc_report 03:52:15 INFO - PID 18137 | _x_x_mozilla_cycle_collect,329 03:52:15 INFO - PID 18137 | __end_cc_report 03:52:15 INFO - PID 18137 | __startTimestamp1501411935519__endTimestamp 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | ------- Summary: start ------- 03:52:15 INFO - PID 18137 | Number of tests: 6 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#0] dojo.html Cycles:165 Average:6108.54 Median:6442.71 stddev:791.90 (12.3%) stddev-sans-first:764.49 03:52:15 INFO - PID 18137 | Values: 3363.5 3380.9 3390.4 3414.2 3419.1 6131.8 6223.9 6266.3 6272.0 6278.6 6052.9 6117.2 6120.3 6122.6 6149.9 5280.1 5324.5 5328.4 5336.7 5422.7 5480.5 5488.1 5498.3 5521.3 5527.5 5368.1 5447.6 5451.7 5504.4 5537.3 5258.1 5323.4 5326.7 5422.7 5425.7 5356.7 5362.2 5417.0 5431.1 5445.7 5821.2 6061.3 6109.8 6127.1 6139.7 6523.3 6564.0 6583.3 6618.7 6629.7 6676.1 6758.6 6775.5 6780.3 6782.7 6160.9 6163.6 6252.4 6271.2 6277.2 6572.7 6678.5 6681.0 6684.1 6843.3 6440.8 6441.8 6442.7 6448.5 6457.4 6489.5 6540.6 6562.9 6566.6 6566.7 6489.4 6505.2 6617.5 6678.1 6708.9 6658.7 6727.4 6754.9 6757.1 6764.1 4803.7 4845.3 4882.6 4897.0 4905.9 4226.6 4270.5 4283.3 4347.2 4374.7 6390.5 6408.7 6461.5 6464.0 6466.1 6697.4 6703.2 6780.3 6781.7 6801.0 6245.2 6285.9 6293.4 6296.2 6300.5 5434.6 5459.7 5469.2 5472.2 5474.9 6935.3 6936.1 6937.0 6950.8 6956.4 6522.1 6569.0 6598.3 6606.0 6606.1 6928.0 6932.9 6955.3 6962.9 7154.4 6520.7 6568.6 6595.9 6670.5 6673.4 6595.5 6733.9 6742.1 6778.9 6835.1 6428.1 6444.0 6444.0 6444.2 6450.5 6506.5 6534.0 6539.4 6561.6 6572.3 6351.8 6464.6 6542.1 6554.2 6561.7 6383.8 6451.7 6456.7 6473.1 6486.2 6145.4 6274.2 6300.2 6300.7 6305.0 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#1] ext.html Cycles:180 Average:42328.13 Median:36252.46 stddev:61221.15 (168.9%) stddev-sans-first:61313.53 03:52:15 INFO - PID 18137 | Values: 811.9 929.2 953.8 1178.8 1206.3 41472.6 44769.1 44895.3 45018.0 45067.0 46126.3 46314.3 46342.8 46389.5 46522.3 7465.0 7702.6 7706.6 7707.2 7708.3 7562.9 7658.6 7667.1 7670.0 7671.8 7635.0 7643.0 7654.3 7685.1 7687.0 7594.4 7633.0 7633.3 7640.2 7663.2 7468.2 7532.0 7534.9 7537.2 7549.0 41409.6 41668.6 41732.8 41774.8 41866.8 3443.9 3470.9 3473.0 3475.8 3483.7 32784.5 32798.0 32812.7 32927.5 33015.0 4794.5 4850.2 4865.3 4868.9 4903.8 207906.0 211026.0 211253.0 211427.0 211963.0 53098.5 53138.7 53273.2 53453.8 53637.0 56130.4 56551.0 56677.4 56736.7 56898.7 15236.3 15497.2 16299.7 16426.8 16764.3 13543.7 13570.8 13572.9 13576.4 13589.5 15366.7 15485.5 15550.1 15564.1 15597.5 6056.3 6075.3 6078.8 6145.4 6190.3 1086.0 1100.4 1100.6 1108.5 1109.4 24851.9 24857.5 25048.5 25226.9 25342.5 1174.1 1199.7 1203.1 1224.2 1229.8 12990.3 13404.3 13470.9 13501.5 13531.5 263446.0 265014.0 266236.0 266298.0 267720.0 56825.0 57255.7 57319.4 57369.0 57731.0 1516.7 1539.1 1570.7 1578.1 1583.3 24627.3 30349.0 30519.2 30946.8 31732.4 54019.7 54202.7 54277.7 54279.7 54308.5 225586.0 226410.0 227150.0 227783.0 227904.0 35536.6 35902.5 38063.8 38070.6 38176.0 48104.3 50161.0 50303.2 50404.0 50561.5 34053.0 34575.8 35726.5 36164.3 36347.3 34710.5 35356.5 35706.3 35748.5 35757.3 41359.2 42705.8 42851.0 43144.4 43330.0 33104.7 35670.6 35967.8 36340.6 36709.4 26581.2 27066.0 27134.5 27198.3 27225.9 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#2] jquery.html Cycles:180 Average:41405.55 Median:23145.60 stddev:105181.45 (454.4%) stddev-sans-first:105431.82 03:52:15 INFO - PID 18137 | Values: 569.3 578.9 582.0 589.1 592.4 23090.3 23332.4 23902.2 23959.0 24015.9 27103.5 27587.3 27762.2 27776.6 27802.9 6204.3 6299.5 6397.4 6403.0 6404.1 5718.6 6277.2 6299.8 6306.2 6312.8 6264.2 6267.0 6279.7 6279.8 6283.0 6203.5 6244.1 6245.1 6263.4 6265.5 5855.2 5855.3 5856.5 5861.0 5866.1 28928.3 30218.0 30705.0 30925.0 30928.8 2185.5 2223.1 2223.6 2225.4 2225.5 20219.8 20718.0 20798.1 20802.8 20829.9 2361.0 2435.8 2437.2 2462.7 2504.0 160010.0 162067.0 162690.0 163145.0 163209.2 15258.0 15725.9 16043.8 16333.2 16365.0 24429.3 25126.5 25524.7 25636.9 25690.0 10591.7 10602.5 10660.4 10716.4 10924.7 9742.3 9791.9 9828.6 9865.4 9921.7 9811.7 10005.2 10270.9 10323.1 10470.5 2875.3 2878.6 2895.5 2918.7 3038.3 1032.9 1035.9 1058.6 1061.5 1094.2 21323.3 21437.6 21593.5 21867.6 22268.7 1119.8 1120.5 1120.7 1132.6 1134.5 11313.9 14282.9 15163.8 15487.3 15700.6 611706.0 614831.0 628288.0 634813.0 638451.0 142142.3 142545.0 144760.0 147652.0 148603.0 1339.9 1358.9 1385.3 1391.8 1394.6 22296.7 23200.9 23358.6 23458.6 23503.2 62666.0 62963.7 64134.0 66101.7 66945.3 81344.6 81512.2 81643.6 82752.2 82848.6 15411.9 15694.0 15911.1 15938.6 15941.9 23553.8 24699.0 25004.7 25135.6 25332.5 20065.4 20140.0 20158.6 20301.1 20442.5 16383.9 17359.5 17658.6 17823.3 18279.4 20675.4 20856.3 20881.8 20921.8 21111.9 14780.6 15564.8 15565.0 15651.8 15773.0 20153.5 20337.6 20350.9 20438.6 20456.9 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#3] mootools.html Cycles:180 Average:9165.78 Median:2556.65 stddev:6529.81 (255.4%) stddev-sans-first:6522.11 03:52:15 INFO - PID 18137 | Values: 1407.9 1462.2 1464.5 1477.7 1482.2 14439.7 14978.9 15001.7 15011.3 15032.5 15465.6 15687.2 15712.2 15727.9 15800.0 2621.8 2658.0 2661.0 2662.2 2662.9 2494.4 2532.0 2608.0 2708.8 2712.6 2623.6 2652.1 2652.2 2655.4 2655.7 2522.5 2539.4 2556.6 2556.7 2587.1 2550.9 2557.1 2565.2 2565.6 2567.6 14494.5 14729.1 14747.5 14748.6 14752.6 7858.4 8106.2 8108.0 8135.0 8156.5 5065.5 5226.9 5246.0 5318.6 5411.3 1881.6 1899.0 1903.7 1929.0 1949.5 24331.4 24461.8 24622.8 25394.2 25459.6 6743.4 6876.8 6889.3 6926.2 7038.1 17145.7 17275.9 17372.5 17389.7 17419.0 7999.6 8111.4 8114.6 8117.0 8129.8 7173.8 7308.4 7385.6 7394.1 7409.4 5076.3 5211.4 5266.3 5269.2 5302.1 1556.0 1565.5 1575.7 1587.2 1605.8 856.7 871.6 872.0 897.8 915.6 7081.9 7243.8 7259.8 7349.3 7422.8 707.3 715.4 735.2 736.1 753.7 4076.3 4803.3 5023.8 5127.5 5227.3 20638.9 21571.2 21689.1 21700.9 21716.5 20258.2 20674.2 20799.9 21043.3 21049.3 10473.4 10852.4 11391.5 11487.1 11806.6 7670.5 7864.8 7923.3 7928.8 8102.0 17055.0 18009.5 18422.4 18668.8 18919.1 18512.2 18541.5 18548.2 18946.7 18965.6 12084.1 12344.1 12426.0 12503.1 12523.6 13907.4 13936.8 14088.4 14088.9 14097.4 10826.6 11262.4 11492.3 11502.0 11761.8 10525.2 10936.3 11056.6 11140.4 11168.4 9257.8 9430.3 9431.4 9434.3 9434.9 6547.6 6790.4 6866.2 6909.3 6936.1 6416.4 6514.2 6832.6 6959.3 7046.7 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#4] prototype.html Cycles:180 Average:5495.37 Median:6172.35 stddev:1565.98 (25.4%) stddev-sans-first:1524.78 03:52:15 INFO - PID 18137 | Values: 497.7 508.8 525.2 534.3 540.4 6105.3 6109.6 6116.4 6183.8 6190.8 6066.7 6078.0 6095.5 6128.7 6129.5 4875.8 4899.2 4904.3 4911.9 4943.6 4566.2 4682.9 4715.8 4837.7 4840.2 4635.8 4638.6 4670.7 4717.8 4740.0 4673.2 4673.8 4703.5 4715.4 4727.7 4235.7 4248.7 4257.1 4268.8 4297.8 5830.8 5912.2 5933.0 5949.3 5958.3 5582.9 5664.3 5674.8 5681.3 5756.2 6404.9 6425.4 6452.5 6454.4 6463.6 4838.3 4842.4 4843.8 4892.1 4929.0 6606.2 6700.4 6729.6 6752.3 6853.2 4998.7 5012.2 5024.6 5030.9 5036.1 4973.3 5009.4 5044.0 5057.3 5087.9 5618.6 5631.1 5648.8 5680.1 5732.2 6466.9 6516.8 6563.3 6568.8 6577.3 1744.1 1745.7 1767.4 1783.7 1791.2 1175.7 1238.6 1254.1 1257.5 1259.5 6127.2 6132.1 6177.6 6228.4 6281.4 6569.4 6574.0 6592.8 6593.3 6637.1 6167.1 6240.7 6244.2 6258.8 6267.1 3484.0 3497.5 3506.9 3521.3 3541.7 6838.9 6859.2 6883.2 6939.3 6956.9 6783.6 6808.9 6832.3 6838.5 6861.4 6344.0 6842.6 6892.0 6903.2 6979.4 6482.0 6527.3 6543.5 6558.1 6582.1 6440.1 6472.8 6495.6 6501.9 6591.1 6981.8 7031.9 7039.0 7041.0 7058.6 5050.8 5053.5 5072.4 5076.8 5086.0 6403.3 6481.8 6527.6 6686.5 6714.3 6369.9 6391.4 6425.9 6475.4 6537.3 6361.7 6421.3 6426.8 6465.2 6503.2 6453.7 6457.8 6458.2 6459.4 6489.9 6373.0 6493.6 6519.6 6556.4 6561.9 6289.8 6322.5 6329.3 6342.0 6354.6 03:52:15 INFO - PID 18137 | 03:52:15 INFO - PID 18137 | [#5] yui.html Cycles:180 Average:26514.43 Median:20330.64 stddev:37202.78 (183.0%) stddev-sans-first:37257.61 03:52:15 INFO - PID 18137 | Values: 948.7 953.0 969.9 973.6 975.9 17991.2 19228.9 19278.1 19328.0 20351.5 20375.7 21705.7 21826.7 21967.2 22095.6 1036.6 1066.7 1071.3 1075.3 1075.9 1083.3 1087.7 1091.0 1091.0 1091.4 1146.7 1148.1 1148.2 1151.3 1153.3 1123.0 1130.3 1131.1 1132.1 1136.3 836.1 836.3 836.9 837.1 837.2 19545.8 19859.0 19886.0 20081.1 20252.0 17584.5 17611.6 17811.4 17971.4 18103.5 16174.3 16591.2 16722.2 16724.9 17034.2 3709.4 3750.0 3755.6 3761.9 3767.4 130217.0 135211.3 136982.0 138808.0 139733.0 16580.3 16581.4 16836.0 17075.4 17203.9 31231.2 32066.7 32414.7 32481.8 32706.7 8003.4 8580.7 8697.9 8762.4 9549.8 4418.8 4563.7 4575.5 4583.0 4585.7 5445.1 5461.7 5542.8 5579.2 5585.6 1108.2 1125.4 1135.5 1139.8 1142.5 727.4 740.8 742.0 746.2 763.6 11231.9 12840.5 13084.2 13239.2 13317.3 702.2 712.9 720.1 727.4 734.9 5892.1 5984.9 6138.6 6184.3 6350.1 127594.0 130384.0 130680.0 134003.3 134339.0 113240.0 113849.0 114801.0 115785.4 118098.4 101909.0 102240.5 103536.5 104066.0 104732.5 11734.8 12083.5 12133.2 12475.8 13134.3 42013.0 43824.0 44569.3 45780.5 46036.5 78682.0 81302.6 82714.0 83494.6 86131.0 20800.8 20883.0 21032.7 21034.5 21144.3 21263.7 21312.1 21508.0 22703.3 22767.0 20628.5 21160.6 21269.9 21311.6 21779.9 20400.9 20413.2 20493.2 20549.8 21130.6 20088.0 20309.8 20402.8 20973.4 21154.3 13265.3 13926.4 13988.6 14415.0 14624.7 15224.8 15281.8 15327.7 15617.6 15723.8 03:52:15 INFO - PID 18137 | -------- Summary: end -------- 03:52:15 INFO - PID 18137 | 03:52:16 INFO - TEST-INFO | 18137: exit 0 03:52:16 INFO - TEST-OK | dromaeo_css | took 1110808ms 03:52:16 INFO - TEST-START | kraken 03:52:16 INFO - Initialising browser for kraken test... 03:52:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html -profile /tmp/tmpuDsanN/profile 03:52:16 INFO - TEST-INFO | started process 18501 (/builds/slave/test/build/application/firefox/firefox http://localhost:40143/getInfo.html) 03:52:21 INFO - TEST-INFO | 18501: exit 0 03:52:21 INFO - Browser initialized. 03:52:21 INFO - Running cycle 1/1 for kraken test... 03:52:21 INFO - TEST-INFO | started process 18707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuDsanN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:22 INFO - PID 18707 | 03:52:22 INFO - PID 18707 | (/builds/slave/test/build/application/firefox/firefox:18755): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:52:22 INFO - PID 18707 | 03:52:33 INFO - PID 18707 | RSS: Main: 164548608 03:52:33 INFO - PID 18707 | 03:52:35 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:36 INFO - PID 18707 | RSS: Main: 169160704 03:52:36 INFO - PID 18707 | 03:52:39 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-dft) 03:52:39 INFO - PID 18707 | RSS: Main: 169840640 03:52:39 INFO - PID 18707 | 03:52:42 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-fft) 03:52:43 INFO - PID 18707 | RSS: Main: 163999744 03:52:43 INFO - PID 18707 | 03:52:45 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator) 03:52:45 INFO - PID 18707 | RSS: Main: 165220352 03:52:45 INFO - PID 18707 | 03:52:48 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:48 INFO - PID 18707 | RSS: Main: 165412864 03:52:48 INFO - PID 18707 | 03:52:51 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:52 INFO - PID 18707 | RSS: Main: 168353792 03:52:52 INFO - PID 18707 | 03:52:55 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:56 INFO - PID 18707 | RSS: Main: 170688512 03:52:56 INFO - PID 18707 | 03:52:59 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial) 03:52:59 INFO - PID 18707 | RSS: Main: 169009152 03:52:59 INFO - PID 18707 | 03:53:01 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:01 INFO - PID 18707 | RSS: Main: 168800256 03:53:01 INFO - PID 18707 | 03:53:03 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:04 INFO - PID 18707 | RSS: Main: 168931328 03:53:04 INFO - PID 18707 | 03:53:06 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:07 INFO - PID 18707 | RSS: Main: 165548032 03:53:07 INFO - PID 18707 | 03:53:09 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:10 INFO - PID 18707 | RSS: Main: 165621760 03:53:10 INFO - PID 18707 | 03:53:13 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:13 INFO - PID 18707 | RSS: Main: 166162432 03:53:13 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | Cycle 1(1): loaded http://localhost:40143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40143/tests/kraken/driver.html?testName=ai-astar) 03:53:15 INFO - PID 18707 | RSS: Main: 167858176 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | __start_tp_report 03:53:15 INFO - PID 18707 | _x_x_mozilla_page_load 03:53:15 INFO - PID 18707 | _x_x_mozilla_page_load_details 03:53:15 INFO - PID 18707 | |i|pagename|runs| 03:53:15 INFO - PID 18707 | |0;ai-astar;101;116;104;106;106;108;108;98;107;109 03:53:15 INFO - PID 18707 | |1;audio-beat-detection;141;113;148;181;119;149;152;112;179;113 03:53:15 INFO - PID 18707 | |2;audio-dft;162;162;162;163;168;161;163;163;169;170 03:53:15 INFO - PID 18707 | |3;audio-fft;75;73;75;157;76;76;76;88;98;76 03:53:15 INFO - PID 18707 | |4;audio-oscillator;78;78;136;78;78;77;129;78;78;130 03:53:15 INFO - PID 18707 | |5;imaging-gaussian-blur;114;115;114;115;113;114;114;114;114;114 03:53:15 INFO - PID 18707 | |6;imaging-darkroom;149;148;149;150;148;148;150;148;156;147 03:53:15 INFO - PID 18707 | |7;imaging-desaturate;94;94;94;94;93;94;95;95;94;94 03:53:15 INFO - PID 18707 | |8;json-parse-financial;48;49;49;49;48;56;50;52;49;49 03:53:15 INFO - PID 18707 | |9;json-stringify-tinderbox;57;55;55;54;54;54;54;54;55;54 03:53:15 INFO - PID 18707 | |10;stanford-crypto-aes;77;78;78;75;83;77;88;77;76;77 03:53:15 INFO - PID 18707 | |11;stanford-crypto-ccm;136;122;120;134;126;117;117;118;128;157 03:53:15 INFO - PID 18707 | |12;stanford-crypto-pbkdf2;168;174;172;170;175;166;161;164;168;166 03:53:15 INFO - PID 18707 | |13;stanford-crypto-sha256-iterative;66;63;61;61;62;65;67;62;61;61 03:53:15 INFO - PID 18707 | __end_tp_report 03:53:15 INFO - PID 18707 | __start_cc_report 03:53:15 INFO - PID 18707 | _x_x_mozilla_cycle_collect,862 03:53:15 INFO - PID 18707 | __end_cc_report 03:53:15 INFO - PID 18707 | __startTimestamp1501411995794__endTimestamp 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | ------- Summary: start ------- 03:53:15 INFO - PID 18707 | Number of tests: 14 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#0] ai-astar Cycles:10 Average:106.30 Median:108.00 stddev:4.83 (4.5%) stddev-sans-first:4.73 03:53:15 INFO - PID 18707 | Values: 101.0 116.0 104.0 106.0 106.0 108.0 108.0 98.0 107.0 109.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:148.50 stddev:26.18 (17.6%) stddev-sans-first:27.77 03:53:15 INFO - PID 18707 | Values: 141.0 113.0 148.0 181.0 119.0 149.0 152.0 112.0 179.0 113.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:3.33 (2.0%) stddev-sans-first:3.43 03:53:15 INFO - PID 18707 | Values: 162.0 162.0 162.0 163.0 168.0 161.0 163.0 163.0 169.0 170.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#3] audio-fft Cycles:10 Average:87.00 Median:76.00 stddev:25.80 (33.9%) stddev-sans-first:27.00 03:53:15 INFO - PID 18707 | Values: 75.0 73.0 75.0 157.0 76.0 76.0 76.0 88.0 98.0 76.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:78.00 stddev:26.06 (33.4%) stddev-sans-first:26.99 03:53:15 INFO - PID 18707 | Values: 78.0 78.0 136.0 78.0 78.0 77.0 129.0 78.0 78.0 130.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:53:15 INFO - PID 18707 | Values: 114.0 115.0 114.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:2.54 (1.7%) stddev-sans-first:2.69 03:53:15 INFO - PID 18707 | Values: 149.0 148.0 149.0 150.0 148.0 148.0 150.0 148.0 156.0 147.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 03:53:15 INFO - PID 18707 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 95.0 95.0 94.0 94.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:49.00 stddev:2.42 (4.9%) stddev-sans-first:2.47 03:53:15 INFO - PID 18707 | Values: 48.0 49.0 49.0 49.0 48.0 56.0 50.0 52.0 49.0 49.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.50 stddev:0.97 (1.8%) stddev-sans-first:0.50 03:53:15 INFO - PID 18707 | Values: 57.0 55.0 55.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:3.92 (5.1%) stddev-sans-first:4.12 03:53:15 INFO - PID 18707 | Values: 77.0 78.0 78.0 75.0 83.0 77.0 88.0 77.0 76.0 77.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:127.00 stddev:12.40 (9.8%) stddev-sans-first:12.77 03:53:15 INFO - PID 18707 | Values: 136.0 122.0 120.0 134.0 126.0 117.0 117.0 118.0 128.0 157.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:4.43 (2.6%) stddev-sans-first:4.69 03:53:15 INFO - PID 18707 | Values: 168.0 174.0 172.0 170.0 175.0 166.0 161.0 164.0 168.0 166.0 03:53:15 INFO - PID 18707 | 03:53:15 INFO - PID 18707 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:62.50 stddev:2.28 (3.7%) stddev-sans-first:2.13 03:53:15 INFO - PID 18707 | Values: 66.0 63.0 61.0 61.0 62.0 65.0 67.0 62.0 61.0 61.0 03:53:15 INFO - PID 18707 | -------- Summary: end -------- 03:53:15 INFO - PID 18707 | 03:53:16 INFO - PID 18707 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:53:16 INFO - TEST-INFO | 18707: exit 0 03:53:16 INFO - TEST-OK | kraken | took 60263ms 03:53:16 INFO - SUITE-END | took 1171s 03:53:16 INFO - Completed test suite (00:19:31) 03:53:16 INFO - javascript benchmark 03:53:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8830.475392731096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.495475678649, 3380.9492857607133, 3390.4405773047442, 3414.1635299351665, 3419.145213696576, 6131.846703832406, 6223.875522489553, 6266.310705822356, 6271.968640156804, 6278.560500764948, 6052.939470605293, 6117.235345581802, 6120.265568131819, 6122.571420000601, 6149.938500614992, 5280.128778751501, 5324.467553244684, 5328.440513746059, 5336.67979921204, 5422.701751403672, 5480.506754392104, 5488.121900495921, 5498.340199176105, 5521.337439507265, 5527.474889885474, 5368.141097424394, 5447.645903016291, 5451.672899626035, 5504.4495550445035, 5537.280153580049, 5258.0535503609335, 5323.387810401776, 5326.653767505139, 5422.674639521641, 5425.728713564306, 5356.705381204032, 5362.2224777407055, 5417.0, 5431.103867861798, 5445.700486473282, 5821.214136091616, 6061.272647282311, 6109.847253818646, 6127.11156882254, 6139.693015349215, 6523.347665233486, 6564.048213009087, 6583.341665833426, 6618.7021584028835, 6629.668516574152, 6676.13210282665, 6758.628275444848, 6775.457963362919, 6780.254172041072, 6782.694778734969, 6160.907586386208, 6163.599366041193, 6252.406021427957, 6271.184745982993, 6277.246730392382, 6572.671366431755, 6678.532502724763, 6681.0, 6684.064231007663, 6843.281455447206, 6440.80677579664, 6441.806745797634, 6442.710078046499, 6448.548601597937, 6457.418832305115, 6489.513286503531, 6540.640264785482, 6562.934370656328, 6566.638834864033, 6566.67166641666, 6489.448396886223, 6505.186851643544, 6617.503687223381, 6678.065070890079, 6708.899366509506, 6658.667066646648, 6727.428168605626, 6754.864902701918, 6757.054012438262, 6764.0530325754435, 4803.687760295639, 4845.297431872359, 4882.584980276716, 4897.0, 4905.9264111038365, 4226.619604235633, 4270.530241673413, 4283.336082907154, 4347.152305300436, 4374.671899607542, 6390.488760899117, 6408.743650254031, 6461.483081353481, 6463.967680161663, 6466.094746735461, 6697.430718388894, 6703.162104736908, 6780.288069752703, 6781.728730850711, 6801.0, 6245.156903817927, 6285.874282514415, 6293.402126798039, 6296.181496405438, 6300.464460520815, 5434.619576629598, 5459.69971651555, 5469.179623056573, 5472.2065300531995, 5474.863128421821, 6935.306469353024, 6936.132983377078, 6937.0, 6950.756723514653, 6956.408705260008, 6522.119513865568, 6569.0, 6598.274189839018, 6605.966970165311, 6606.10817539626, 6927.965360173369, 6932.930670693228, 6955.269696681978, 6962.930370696431, 7154.427645788429, 6520.706568204348, 6568.6058836469965, 6595.901061484177, 6670.466362691071, 6673.432758215606, 6595.505337099833, 6733.898991515229, 6742.089817874524, 6778.93221067783, 6835.14560679915, 6428.132202152649, 6443.96778016107, 6444.033394990602, 6444.194475690539, 6450.548461607643, 6506.479481641552, 6534.0, 6539.411452969065, 6561.573497722633, 6572.277049524453, 6351.809445716636, 6464.612123272619, 6542.051402546699, 6554.213494380705, 6561.704723287368, 6383.808485745435, 6451.70967306463, 6456.6771661415805, 6473.1261279728515, 6486.189226346707, 6145.354737752472, 6274.215723034621, 6300.243970723543, 6300.653464059521, 6304.968475157595], "value": 6047.3770962011595, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.8884308156364, 929.2287401456791, 953.7901661634443, 1178.8408564843749, 1206.2641788509013, 41472.58527414725, 44769.10461790762, 44895.326570101475, 45018.0, 45067.0, 46126.30810537836, 46314.30528542075, 46342.76828615852, 46389.536104638944, 46522.30216546755, 7465.0, 7702.614869256543, 7706.576138312391, 7707.190744971781, 7708.30625243728, 7562.924370756305, 7658.578778167199, 7667.118281397627, 7670.0, 7671.846563068735, 7635.0, 7642.961785191066, 7654.3111119999185, 7685.077790665128, 7687.000689910304, 7594.354479869217, 7632.961835190788, 7633.313001829806, 7640.159582445926, 7663.233676632376, 7468.178500364956, 7532.0, 7534.924650753477, 7537.246275372474, 7548.962255188744, 41409.585904141175, 41668.583314166775, 41732.79133604343, 41774.79112604448, 41866.79066604647, 3443.913902152441, 3470.9305813883834, 3473.0, 3475.7566970312087, 3483.651634836521, 32784.50823237653, 32798.0, 32812.67187328144, 32927.50608740871, 33015.0, 4794.5205479452125, 4850.175470170079, 4865.318855360252, 4868.853934381974, 4903.803847846082, 207906.0, 211026.0, 211253.0, 211427.0, 211963.0, 53098.469015309354, 53138.734306328224, 53273.2009019865, 53453.79277243378, 53637.0, 56130.43869561334, 56551.0, 56677.43322566721, 56736.716316418155, 56898.7155064222, 15236.31436585334, 15497.225138743017, 16299.674006519803, 16426.75359869603, 16764.329426823035, 13543.661408464866, 13570.796438053438, 13572.864271357357, 13576.389062492211, 13589.524366647318, 15366.692666146839, 15485.535433937, 15550.144742039296, 15564.143972081643, 15597.532074037797, 6056.3338032816355, 6075.33171351151, 6078.787242446493, 6145.354737752472, 6190.3190649028575, 1085.9945700271448, 1100.350793032115, 1100.5927806711409, 1108.5177947592822, 1109.4397329348628, 24851.87574062118, 24857.5028499429, 25048.4990300193, 25226.87386563092, 25342.493150136896, 1174.0959461214989, 1199.7060720123452, 1203.1337437045313, 1224.1920332580455, 1229.766344394562, 12990.285534295705, 13404.32978351098, 13470.865291346961, 13501.459941602423, 13531.45874165042, 263446.0, 265014.0, 266236.0, 266298.0, 267720.0, 56825.0, 57255.71372143113, 57319.42680573224, 57369.0, 57731.0, 1516.6966606678488, 1539.1073177556991, 1570.6780110077407, 1578.0925967568694, 1583.3270859884503, 24627.261182164562, 30349.0, 30519.23701907381, 30946.845265774427, 31732.36535269328, 54019.72990135024, 54202.72898635639, 54277.72861135669, 54279.72860135674, 54308.45691543192, 225586.0, 226410.0, 227150.0, 227783.0, 227904.0, 35536.64463355333, 35902.461463077554, 38063.80968095142, 38070.61929380671, 38176.0, 48104.27843582419, 50161.0, 50303.245451318995, 50404.0, 50561.49438505568, 34053.0, 34575.82712086423, 35726.46410303796, 36164.27671446609, 36347.27305453929, 34710.479342809376, 35356.46965295574, 35706.28587428289, 35748.4637730429, 35757.28485430329, 41359.1728165429, 42705.78647106869, 42851.0, 43144.35283470688, 43330.0, 33104.66895331112, 35670.64329356673, 35967.82016089903, 36340.636593633724, 36709.44935825912, 26581.202563923114, 27066.0, 27134.45731085328, 27198.320041999108, 27225.86387068052], "value": 18689.992620172365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3054473542279, 578.8986927287724, 581.9534437245015, 589.1104432307217, 592.3720855892755, 23090.307290781282, 23332.41668958277, 23902.163424280152, 23959.0, 24015.879920600393, 27103.45793084142, 27587.310317242078, 27762.16713498593, 27776.58335124975, 27802.860985695093, 6204.317525072239, 6299.464545513637, 6397.392247736481, 6402.967985160068, 6404.103425520431, 5718.628289161212, 6277.1839660844025, 6299.811005669814, 6306.180196574439, 6312.779052733155, 6264.21697287839, 6267.0286105653695, 6279.748810047616, 6279.780207692732, 6283.0, 6203.503719702436, 6244.0633904914175, 6245.125682404467, 6263.373662633723, 6265.498760099181, 5855.209546711182, 5855.297364316267, 5856.531477481792, 5861.032929566616, 5866.14940833581, 28928.27679308013, 30218.0, 30705.0, 30925.0, 30928.8453557733, 2185.497335612818, 2223.0663121489015, 2223.633100538409, 2225.376894469551, 2225.4770129019666, 20219.797802022087, 20718.0, 20798.064087116116, 20802.751834889954, 20829.89585052065, 2360.9527809443716, 2435.768601982809, 2437.2079074300923, 2462.704475462956, 2504.023430861965, 160010.0, 162067.0, 162690.0, 163145.0, 163209.18395408065, 15258.0, 15725.911263071685, 16043.759343609856, 16333.183340832911, 16365.0, 24429.26712198637, 25126.497470050497, 25524.744752552608, 25636.871815641174, 25690.0, 10591.735206619896, 10602.469876506299, 10660.413677247825, 10716.410597417062, 10924.67225983206, 9742.31803773729, 9791.902080979098, 9828.557714902847, 9865.408075515348, 9921.702348929399, 9811.656592019244, 10005.249606279413, 10270.948645256874, 10323.122534584494, 10470.476476176313, 2875.346675661503, 2878.5682147678017, 2895.4932886744737, 2918.658854296632, 3038.3315670552442, 1032.8605638238892, 1035.891231420705, 1058.5871510111062, 1061.4692653673164, 1094.190299178618, 21323.25368612122, 21437.571248574943, 21593.460163496038, 21867.562648746934, 22268.66597001046, 1119.8432219489277, 1120.5461787975883, 1120.6918097523246, 1132.620572108353, 1134.500819639356, 11313.943430282961, 14282.85717142836, 15163.848361516464, 15487.30307136159, 15700.607484812743, 611706.0, 614831.0, 628288.0, 634813.0, 638451.0, 142142.28928855289, 142545.0, 144760.0, 147652.0, 148603.0, 1339.9062065655505, 1358.8844948179317, 1385.300423286234, 1391.7773156294945, 1394.5537428023138, 22296.665550017085, 23200.883995579916, 23358.64962025605, 23458.64812027855, 23503.17738879131, 62666.0, 62963.6851815738, 64134.0, 66101.66949165224, 66945.3305466939, 81344.59327703323, 81512.18487815045, 81643.5917820407, 82752.17247827686, 82848.58575707083, 15411.922940385226, 15694.0, 15911.124888131264, 15938.60153496172, 15941.920290398473, 23553.764462355157, 24699.0, 25004.749952500242, 25135.622965655897, 25332.493350133263, 20065.39803805888, 20140.0, 20158.59682806365, 20301.08645111003, 20442.48893777608, 16383.918080409998, 17359.479215623553, 17658.5585360367, 17823.28706851763, 18279.360222392683, 20675.379738607866, 20856.270030549465, 20881.791182087985, 20921.790782091983, 21111.8944405277, 14780.556583302518, 15564.84435155634, 15565.0, 15651.843481565038, 15773.0, 20153.496162596053, 20337.59324813525, 20350.898245508677, 20438.591228175057, 20456.89771551192], "value": 12990.528149782514, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.901446898717, 1462.2104063805546, 1464.472789795674, 1477.7266205751937, 1482.2144263540326, 14439.711205775891, 14978.850211497882, 15001.699966000673, 15011.32449039793, 15032.473863414783, 15465.613359665986, 15687.215639218051, 15712.214389280518, 15727.921360393211, 15800.0, 2621.7640412362834, 2657.9601305980427, 2661.0287245155478, 2662.1747258349974, 2662.9201123966313, 2494.3514686181634, 2532.0, 2608.0350270399977, 2708.756211940925, 2712.620233167358, 2623.6326914232022, 2652.085030664418, 2652.1778248742853, 2655.3759866431374, 2655.668041494813, 2522.4576716006054, 2539.390546268901, 2556.6037264224074, 2556.7059788124416, 2587.133310341038, 2550.9489810203877, 2557.1177943609423, 2565.217608629367, 2565.6279839423364, 2567.5763499022823, 14494.492692755808, 14729.116253024853, 14747.483838065617, 14748.557543273719, 14752.55742327732, 7858.410619203582, 8106.229908158715, 8107.95946020272, 8134.959325203336, 8156.510609363457, 5065.544101030925, 5226.8693282667855, 5245.973770131163, 5318.627696061278, 5411.269478620415, 1881.6142690748363, 1898.9715154272697, 1903.6573416784972, 1928.9710654340197, 1949.522367020075, 24331.391715207083, 24461.755382446303, 24622.753772462223, 25394.238172854843, 25459.618105728245, 6743.35938085881, 6876.828079298058, 6889.311068893171, 6926.2034865990045, 7038.085048943707, 17145.657086858442, 17275.913620431817, 17372.47882563525, 17389.65220695579, 17419.041952692725, 7999.640016199169, 8111.351091912633, 8114.553699546582, 8117.0, 8129.796755081052, 7173.820654483576, 7308.415326773846, 7385.593792341473, 7394.149672787591, 7409.444291678145, 5076.289319495274, 5211.374635043819, 5266.34170728659, 5269.156934890476, 5302.125149350391, 1555.9922200388926, 1565.4599163288647, 1575.708493928627, 1587.1905328282428, 1605.7511085781723, 856.674463703801, 871.6382701179067, 871.9694810681596, 897.8114595934927, 915.6337465014047, 7081.92918070823, 7243.818904527324, 7259.782206533812, 7349.30181632744, 7422.777316680508, 707.342171780239, 715.3919168706558, 735.1619154164257, 736.14607055815, 753.7248904150056, 4076.286649836267, 4803.327534145223, 5023.773930173151, 5127.487251274917, 5227.26818245446, 20638.896805515877, 21571.245006425015, 21689.132434702435, 21700.891495542422, 21716.457088572595, 20258.189672413235, 20674.17303307881, 20799.896000520203, 21043.263485777923, 21049.263275785273, 10473.371597704163, 10852.403117828595, 11391.544338226378, 11487.0810335173, 11806.586769463027, 7670.463067585216, 7864.84270314579, 7923.326517246099, 7928.84142317162, 8102.0, 17055.0, 18009.549761256072, 18422.35521756732, 18668.813311867252, 18919.148638311584, 18512.16695248744, 18541.536461588566, 18548.165332560337, 18946.715799262747, 18965.62068758645, 12084.093692973238, 12344.074194435632, 12426.0, 12503.062270329943, 12523.56167534132, 13907.443702252202, 13936.790948135584, 14088.36602352876, 14088.929555352157, 14097.436102555783, 10826.56693732242, 11262.436878156223, 11492.310461372344, 11502.0, 11761.764764704829, 10525.157987360839, 10936.289141205796, 11056.613018544313, 11140.387278699749, 11168.441577921234, 9257.814843702954, 9430.3398762086, 9431.386959847589, 9434.339596228197, 9434.85847712271, 6547.639879806657, 6790.42281406086, 6866.244713081657, 6909.30906909305, 6936.098307220029, 6416.390442907917, 6514.218293804774, 6832.59004459734, 6959.304069593, 7046.718131274896], "value": 6517.40227076198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.70664584756526, 508.83717210492637, 525.1623660261882, 534.3000669123446, 540.3677697094399, 6105.267367915851, 6109.572329936901, 6116.357782432848, 6183.783567575136, 6190.75236990521, 6066.6663333516635, 6078.0, 6095.51235901128, 6128.693565321727, 6129.509639228862, 4875.829345972892, 4899.167141585939, 4904.288878112671, 4911.852644420665, 4943.604511639078, 4566.223741963858, 4682.899518613123, 4715.764211789414, 4837.685550439228, 4840.184930651006, 4635.791389387468, 4638.628909687234, 4670.696404733699, 4717.834875779348, 4739.976300118495, 4673.182193116225, 4673.784815947844, 4703.506131856174, 4715.434147902257, 4727.739974301412, 4235.703500754948, 4248.660107191417, 4257.148570285955, 4268.807903644312, 4297.806598703066, 5830.82507524775, 5912.201852749867, 5932.970335148297, 5949.345571987078, 5958.255218097738, 5582.916256256119, 5664.291963504562, 5674.829755107354, 5681.318241810968, 5756.165356023395, 6404.935950640527, 6425.389587989133, 6452.4515416189215, 6454.354564543555, 6463.644499552523, 4838.346823178897, 4842.394700662418, 4843.782029808667, 4892.143874821892, 4928.950710492921, 6606.174228221473, 6700.443698285116, 6729.596224226562, 6752.291009443987, 6853.17761868574, 4998.6750861193905, 5012.1980483122525, 5024.648274620815, 5030.924536131961, 5036.11867923112, 4973.303737476756, 5009.398872135294, 5044.0, 5057.317262169634, 5087.923681144785, 5618.578606604521, 5631.099024156116, 5648.796969182023, 5680.11958146488, 5732.226149469851, 6466.870662586722, 6516.804495865132, 6563.343665633399, 6568.835779105465, 6577.3422657733845, 1744.127936031984, 1745.7343426016037, 1767.354915455875, 1783.7335491800707, 1791.1939627167567, 1175.7060734816296, 1238.6222202228407, 1254.0782524844233, 1257.4970011995092, 1259.4710221706905, 6127.234095738033, 6132.117904584838, 6177.567570270038, 6228.377162283736, 6281.434670879551, 6569.408753212138, 6574.013897915255, 6592.769253076215, 6593.274739778716, 6637.137172167587, 6167.136600875881, 6240.719167637467, 6244.219472565929, 6258.77813376254, 6267.122602835607, 3483.9722281926893, 3497.5453191085, 3506.9298614027575, 3521.3133438979153, 3541.6812486876306, 6838.931610683929, 6859.211190713132, 6883.208431030395, 6939.340762627542, 6956.860862782716, 6783.607032409246, 6808.863822723518, 6832.282610325944, 6838.48711346651, 6861.416779573692, 6344.0, 6842.605088219084, 6892.0, 6903.240643529208, 6979.40675042627, 6482.0, 6527.314631963765, 6543.5419520633095, 6558.114654521579, 6582.124094633006, 6440.066190402459, 6472.773452929125, 6495.577787443801, 6501.934980650322, 6591.110200122922, 6981.8254543634785, 7031.859362812817, 7039.0, 7041.0, 7058.6470676467, 5050.77271522775, 5053.494650534917, 5072.416672082758, 5076.796928122833, 5085.974570127126, 6403.3276505966205, 6481.773137940149, 6527.5757075789925, 6686.531942764154, 6714.328567143247, 6369.87260254783, 6391.424771770563, 6425.9036114457385, 6475.417212450902, 6537.346265373425, 6361.741581738416, 6421.293657697743, 6426.839329016812, 6465.224173099258, 6503.187101612299, 6453.709583068679, 6457.806265812033, 6458.160439142881, 6459.354064593691, 6489.8702025960165, 6372.96813515948, 6493.610383377012, 6519.630877515585, 6556.409923106943, 6561.901571476336, 6289.811305660837, 6322.49420046386, 6329.335419781041, 6341.968290158704, 6354.555181137276], "value": 5039.100524622094, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.7248697877616, 952.9714108576741, 969.9127078562927, 973.6202880876455, 975.9072888075635, 17991.19039643216, 19228.903855480738, 19278.132484038233, 19328.0, 20351.491212719688, 20375.694364584542, 21705.67441488375, 21826.672599911013, 21967.23114690986, 22095.558088838214, 1036.6319956415477, 1066.7173199102244, 1071.346478648024, 1075.2526993739355, 1075.9085477734402, 1083.2579682917226, 1087.6900083476212, 1090.9727256818603, 1091.0, 1091.3615534912085, 1146.7133216695827, 1148.0643275730295, 1148.161841855446, 1151.2689442204219, 1153.2734377342304, 1123.0341905960868, 1130.2766229613055, 1131.0668698323834, 1132.0773569540797, 1136.2898188632105, 836.0552575589605, 836.2933321343455, 836.9497830130211, 837.1252041616525, 837.2004735477665, 19545.80454195454, 19859.0, 19886.0, 20081.09635066411, 20252.0, 17584.472465826046, 17611.647767044717, 17811.376601818873, 17971.371002015, 18103.456896293133, 16174.27215775293, 16591.170441477876, 16722.24749886258, 16724.916375418168, 17034.23345949423, 3709.3694072007825, 3749.9625003749884, 3755.605661405568, 3761.9090463765474, 3767.4348847672795, 130217.0, 135211.32394338064, 136982.0, 138808.0, 139733.0, 16580.336786528405, 16581.419650312422, 16836.0, 17075.40236091731, 17203.913980430018, 31231.21921951924, 32066.679333206837, 32414.675853241166, 32481.837590812367, 32706.67293327084, 8003.439759216799, 8580.656773729106, 8697.913020869837, 8762.430442021248, 9549.809003819884, 4418.823247070145, 4563.680542362003, 4575.450945886515, 4582.9770851146195, 4585.679002469862, 5445.074337362578, 5461.699606521679, 5542.7782888684005, 5579.246801681802, 5585.553155747531, 1108.2020944919645, 1125.352922069813, 1135.5457816873318, 1139.7720455908852, 1142.4858813533776, 727.421699748701, 740.8110931712379, 741.9666115024729, 746.1941103608091, 763.6334559411514, 11231.900356369866, 12840.486380544673, 13084.214947103204, 13239.205647660978, 13317.267550284634, 702.1889717376438, 712.9465290103263, 720.135836995597, 727.3671905442193, 734.8713975054344, 5892.145638882424, 5984.8803023940145, 6138.600990935664, 6184.257889053342, 6350.079238510482, 127594.0, 130384.0, 130680.0, 134003.32998334945, 134339.0, 113240.0, 113849.0, 114801.0, 115785.4210728941, 118098.40950795192, 101909.0, 102240.48879755553, 103536.48231758793, 104066.0, 104732.47633761934, 11734.765304693688, 12083.516659333529, 12133.150679452354, 12475.812862807246, 13134.343282836011, 42013.0, 43824.0, 44569.331460027475, 45780.542194577625, 46036.53963460323, 78682.0, 81302.59348703218, 82714.0, 83494.58252708698, 86131.0, 20800.791992080492, 20883.0, 21032.684509732062, 21034.47413814667, 21144.259950901644, 21263.68104478465, 21312.14751409988, 21508.0, 22703.318900433012, 22767.0, 20628.484287892923, 21160.576788464452, 21269.89365053165, 21311.57376852423, 21779.891100544395, 20400.897995509928, 20413.183472660927, 20493.180272788923, 20549.79450205479, 21130.577388452453, 20088.0, 20309.79690203079, 20402.79597204009, 20973.370798876058, 21154.259600913894, 13265.270410127536, 13926.442942282196, 13988.58034258974, 14415.0, 14624.707505850036, 15224.771628425804, 15281.847181528043, 15327.693446130792, 15617.609559761097, 15723.842761572696], "value": 9832.03889818359, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 116.0, 104.0, 106.0, 106.0, 108.0, 108.0, 98.0, 107.0, 109.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 148.0, 181.0, 119.0, 149.0, 152.0, 112.0, 179.0, 113.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 168.0, 161.0, 163.0, 163.0, 169.0, 170.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 157.0, 76.0, 76.0, 76.0, 88.0, 98.0, 76.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 136.0, 78.0, 78.0, 77.0, 129.0, 78.0, 78.0, 130.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 150.0, 148.0, 148.0, 150.0, 148.0, 156.0, 147.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 49.0, 49.0, 48.0, 56.0, 50.0, 52.0, 49.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 75.0, 83.0, 77.0, 88.0, 77.0, 76.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 122.0, 120.0, 134.0, 126.0, 117.0, 117.0, 118.0, 128.0, 157.0], "value": 127.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 174.0, 172.0, 170.0, 175.0, 166.0, 161.0, 164.0, 168.0, 166.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 61.0, 61.0, 62.0, 65.0, 67.0, 62.0, 61.0, 61.0], "value": 62.9, "unit": "score"}]}]} 03:53:16 INFO - Return code: 0 03:53:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:16 INFO - # TBPL SUCCESS # 03:53:16 INFO - Running post-action listener: _package_coverage_data 03:53:16 INFO - Running post-action listener: _resource_record_post_action 03:53:16 INFO - [mozharness: 2017-07-30 10:53:16.598838Z] Finished run-tests step (success) 03:53:16 INFO - Running post-run listener: _resource_record_post_run 03:53:16 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 217088; Write bytes: 437587968; Read time: 52; Write time: 305748 03:53:16 INFO - TinderboxPrint: CPU usage
13.1% 03:53:16 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 52 03:53:16 INFO - TinderboxPrint: I/O write bytes / time
437,587,968 / 305,748 03:53:16 INFO - TinderboxPrint: CPU idle
8,242.1 (86.9%) 03:53:16 INFO - TinderboxPrint: CPU user
1,191.4 (12.6%) 03:53:16 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:16 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120958976; Read time: 0; Write time: 93032 03:53:16 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:53:16 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 212992; Write bytes: 316628992; Read time: 32; Write time: 212716 03:53:17 INFO - Running post-run listener: _upload_blobber_files 03:53:17 INFO - Blob upload gear active. 03:53:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:17 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 03:53:17 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'] 03:53:17 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 03:53:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:24 INFO - (blobuploader) - INFO - Done attempting. 03:53:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:53:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:53:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:25 INFO - (blobuploader) - INFO - Done attempting. 03:53:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:26 INFO - (blobuploader) - INFO - Done attempting. 03:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:27 INFO - (blobuploader) - INFO - Done attempting. 03:53:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:27 INFO - Return code: 0 03:53:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a7dda46bad297c3a865e2e44efc73fab9272dcb93ce70d17a4ddcea104e1aa3aa7a5e13a635f4b6cd8329e18f34234c302b50b4f1d7ddb776517da78248f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8cc3acd917fadb86d14c193c5c24d314f4fdf3b9546676ec415bd4e3113bfe5c20c39cd1a6bf2cb85bb6f3a15bf30fe7588c3903959b4dfede0094fca5a2cb6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/466cf77605f140ba755613c24b3133d24c374e5a4aa46b021c7b4f4a4d466c3a796f2c29cd2f82b9e8b11182d8d5577d7647b3b00aa6f4f876d42fc2ba39d71e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13d8649801e8f402957b66a4299000165bbb8115f64da6ffcb2d5346d014dc268e8f9e9d0d0cd7fa86e8f43d2cace7ad6e99ef6bd33b967f4444cd5669950c00"} 03:53:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:27 INFO - Contents: 03:53:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a7dda46bad297c3a865e2e44efc73fab9272dcb93ce70d17a4ddcea104e1aa3aa7a5e13a635f4b6cd8329e18f34234c302b50b4f1d7ddb776517da78248f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8cc3acd917fadb86d14c193c5c24d314f4fdf3b9546676ec415bd4e3113bfe5c20c39cd1a6bf2cb85bb6f3a15bf30fe7588c3903959b4dfede0094fca5a2cb6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/466cf77605f140ba755613c24b3133d24c374e5a4aa46b021c7b4f4a4d466c3a796f2c29cd2f82b9e8b11182d8d5577d7647b3b00aa6f4f876d42fc2ba39d71e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13d8649801e8f402957b66a4299000165bbb8115f64da6ffcb2d5346d014dc268e8f9e9d0d0cd7fa86e8f43d2cace7ad6e99ef6bd33b967f4444cd5669950c00"} 03:53:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:27 INFO - Copying logs to upload dir... 03:53:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.020171 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-30 03:53:27.210021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:53:27.217802) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 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/33a7dda46bad297c3a865e2e44efc73fab9272dcb93ce70d17a4ddcea104e1aa3aa7a5e13a635f4b6cd8329e18f34234c302b50b4f1d7ddb776517da78248f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8cc3acd917fadb86d14c193c5c24d314f4fdf3b9546676ec415bd4e3113bfe5c20c39cd1a6bf2cb85bb6f3a15bf30fe7588c3903959b4dfede0094fca5a2cb6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/466cf77605f140ba755613c24b3133d24c374e5a4aa46b021c7b4f4a4d466c3a796f2c29cd2f82b9e8b11182d8d5577d7647b3b00aa6f4f876d42fc2ba39d71e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13d8649801e8f402957b66a4299000165bbb8115f64da6ffcb2d5346d014dc268e8f9e9d0d0cd7fa86e8f43d2cace7ad6e99ef6bd33b967f4444cd5669950c00"} build_url:https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/O1hVlqEqSA64Rm7ExMLfAg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33a7dda46bad297c3a865e2e44efc73fab9272dcb93ce70d17a4ddcea104e1aa3aa7a5e13a635f4b6cd8329e18f34234c302b50b4f1d7ddb776517da78248f08", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8cc3acd917fadb86d14c193c5c24d314f4fdf3b9546676ec415bd4e3113bfe5c20c39cd1a6bf2cb85bb6f3a15bf30fe7588c3903959b4dfede0094fca5a2cb6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/466cf77605f140ba755613c24b3133d24c374e5a4aa46b021c7b4f4a4d466c3a796f2c29cd2f82b9e8b11182d8d5577d7647b3b00aa6f4f876d42fc2ba39d71e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/13d8649801e8f402957b66a4299000165bbb8115f64da6ffcb2d5346d014dc268e8f9e9d0d0cd7fa86e8f43d2cace7ad6e99ef6bd33b967f4444cd5669950c00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:53:27.248897) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:53:27.249248) ========= 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=8887e36bb8e381bfd44124ac000001a8-1501410490.639819-1290386767 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004351 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:53:27.335144) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:53:27.335466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:53:27.335802) ========= ========= Total master_lag: 0.28 =========