builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1498161043.44 results: success (0) revision: 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.441894) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.442477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.442795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.468803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.469124) ========= 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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-22 12:50:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.9M=0s 2017-06-22 12:50:44 (23.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.183525 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.678487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.678847) ========= 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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020376 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:43.748253) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-22 12:50:43.748627) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 --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 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 --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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-22 12:50:44,594 truncating revision to first 12 chars 2017-06-22 12:50:44,594 Setting DEBUG logging. 2017-06-22 12:50:44,594 attempt 1/10 2017-06-22 12:50:44,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/61edb6b49071?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-22 12:50:45,501 unpacking tar archive at: mozilla-central-61edb6b49071/testing/mozharness/ program finished with exit code 0 elapsedTime=1.259750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-22 12:50:45.023379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:45.023662) ========= script_repo_revision: 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:45.027097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:45.027373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 12:50:45.035417) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-22 12:50:45.035692) ========= /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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:50:45 INFO - MultiFileLogger online at 20170622 12:50:45 in /builds/slave/test 12:50:45 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 12:50:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:50:45 INFO - {'append_to_log': False, 12:50:45 INFO - 'base_work_dir': '/builds/slave/test', 12:50:45 INFO - 'blob_upload_branch': 'Firefox', 12:50:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:50:45 INFO - 'branch': 'Firefox', 12:50:45 INFO - 'buildbot_json_path': 'buildprops.json', 12:50:45 INFO - 'config_files': ('talos/linux_config.py',), 12:50:45 INFO - 'default_actions': ('clobber', 12:50:45 INFO - 'read-buildbot-config', 12:50:45 INFO - 'download-and-extract', 12:50:45 INFO - 'populate-webroot', 12:50:45 INFO - 'create-virtualenv', 12:50:45 INFO - 'install', 12:50:45 INFO - 'setup-mitmproxy', 12:50:45 INFO - 'run-tests'), 12:50:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:50:45 INFO - 'download_minidump_stackwalk': True, 12:50:45 INFO - 'download_symbols': 'ondemand', 12:50:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:50:45 INFO - 'tooltool.py': '/tools/tooltool.py', 12:50:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:50:45 INFO - '/tools/misc-python/virtualenv.py')}, 12:50:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:50:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:50:45 INFO - 'gecko_profile': False, 12:50:45 INFO - 'gecko_profile_interval': 0, 12:50:45 INFO - 'installer_path': 'installer.exe', 12:50:45 INFO - 'log_level': 'info', 12:50:45 INFO - 'log_name': 'talos', 12:50:45 INFO - 'log_to_console': True, 12:50:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:50:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:50:45 INFO - 'opt_config_files': (), 12:50:45 INFO - 'pip_index': False, 12:50:45 INFO - 'suite': 'dromaeojs-e10s', 12:50:45 INFO - 'system_bits': '32', 12:50:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:50:45 INFO - 'title': 'talos-linux64-ix-085', 12:50:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:50:45 INFO - 'use_talos_json': True, 12:50:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:50:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:50:45 INFO - 'work_dir': 'build'} 12:50:45 INFO - [mozharness: 2017-06-22 19:50:45.985182Z] Running clobber step. 12:50:45 INFO - Running pre-action listener: _resource_record_pre_action 12:50:45 INFO - Running main action method: clobber 12:50:45 INFO - rmtree: /builds/slave/test/build 12:50:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:50:47 INFO - Running post-action listener: _resource_record_post_action 12:50:47 INFO - [mozharness: 2017-06-22 19:50:47.019571Z] Finished clobber step (success) 12:50:47 INFO - [mozharness: 2017-06-22 19:50:47.019672Z] Running read-buildbot-config step. 12:50:47 INFO - Running pre-action listener: _resource_record_pre_action 12:50:47 INFO - Running main action method: read_buildbot_config 12:50:47 INFO - Using buildbot properties: 12:50:47 INFO - { 12:50:47 INFO - "project": "", 12:50:47 INFO - "product": "firefox", 12:50:47 INFO - "who": "kwierso@gmail.com", 12:50:47 INFO - "installer_path": "public/build/target.tar.bz2", 12:50:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 12:50:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:50:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 12:50:47 INFO - "stage_platform": "linux64-stylo", 12:50:47 INFO - "basedir": "/builds/slave/test", 12:50:47 INFO - "buildnumber": 147, 12:50:47 INFO - "platform": "ubuntu64_hw_stylo", 12:50:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:50:47 INFO - "slavebuilddir": "test", 12:50:47 INFO - "taskId": "SkUZRrL1T0Kn5Sa_IXGFew", 12:50:47 INFO - "branch": "mozilla-central", 12:50:47 INFO - "script_repo_revision": "production", 12:50:47 INFO - "revision": "61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5", 12:50:47 INFO - "slavename": "talos-linux64-ix-085", 12:50:47 INFO - "repo_path": "mozilla-central" 12:50:47 INFO - } 12:50:47 INFO - Finding installer, test and symbols from parent task. 12:50:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkUZRrL1T0Kn5Sa_IXGFew'}, attempt #1 12:50:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SkUZRrL1T0Kn5Sa_IXGFew'}, attempt #1 12:50:47 INFO - Task dependencies: OW6PbA6IThqTkQNyK__M-w 12:50:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w'}, attempt #1 12:50:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 12:50:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/test_packages.json 12:50:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.crashreporter-symbols.zip 12:50:48 INFO - Running post-action listener: _resource_record_post_action 12:50:48 INFO - [mozharness: 2017-06-22 19:50:48.425206Z] Finished read-buildbot-config step (success) 12:50:48 INFO - [mozharness: 2017-06-22 19:50:48.425424Z] Running download-and-extract step. 12:50:48 INFO - Running pre-action listener: _resource_record_pre_action 12:50:48 INFO - Running main action method: download_and_extract 12:50:48 INFO - mkdir: /builds/slave/test/build/tests 12:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:50:48 INFO - trying https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.test_packages.json 12:50:48 INFO - Downloading https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:50:48 INFO - Downloaded 989 bytes. 12:50:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:50:48 INFO - Using the following test package requirements: 12:50:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:50:48 INFO - u'common': [u'target.common.tests.zip'], 12:50:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:50:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:50:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:50:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:50:48 INFO - u'mozbase': [u'target.common.tests.zip'], 12:50:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:50:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:50:48 INFO - u'web-platform': [u'target.common.tests.zip', 12:50:48 INFO - u'target.web-platform.tests.tar.gz'], 12:50:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:50:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:50:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip 12:50:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:50:48 INFO - Fetch https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip into memory 12:50:50 INFO - Content-Length response header: 67975082 12:50:50 INFO - Bytes received: 67975082 12:51:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip 12:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.common.tests.zip into memory 12:51:03 INFO - Content-Length response header: 67975082 12:51:03 INFO - Bytes received: 67975082 12:51:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.talos.tests.zip 12:51:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:51:15 INFO - Fetch https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.talos.tests.zip into memory 12:51:15 INFO - Content-Length response header: 14441306 12:51:15 INFO - Bytes received: 14441306 12:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:51:16 INFO - trying https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 12:51:16 INFO - Downloading https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:51:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:51:48 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2: The read operation timed out 12:51:48 INFO - retry: attempt #1 caught SSLError exception: The read operation timed out 12:51:48 INFO - retry: Failed, sleeping 30 seconds before retrying 12:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #2 12:52:19 INFO - Downloaded 61584096 bytes. 12:52:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 12:52:19 INFO - mkdir: /builds/slave/test/properties 12:52:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:52:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:52:19 INFO - Contents: 12:52:19 INFO - build_url:https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 12:52:19 INFO - Running post-action listener: _resource_record_post_action 12:52:19 INFO - Running post-action listener: set_extra_try_arguments 12:52:19 INFO - [mozharness: 2017-06-22 19:52:19.243846Z] Finished download-and-extract step (success) 12:52:19 INFO - [mozharness: 2017-06-22 19:52:19.243942Z] Running populate-webroot step. 12:52:19 INFO - Running pre-action listener: _resource_record_pre_action 12:52:19 INFO - Running main action method: populate_webroot 12:52:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:52:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:52:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:52:19 INFO - '--tppagecycles', 12:52:19 INFO - '7'], 12:52:19 INFO - 'tests': ['tsvgm']}}, 12:52:19 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:52:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:52:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:52:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:52:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['damp', 'tps']}, 12:52:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'tests': ['damp', 'tps']}, 12:52:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['dromaeo_dom']}, 12:52:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:52:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:52:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:52:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:52:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'other-e10s': {'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['a11yr', 12:52:19 INFO - 'ts_paint', 12:52:19 INFO - 'tpaint', 12:52:19 INFO - 'sessionrestore', 12:52:19 INFO - 'sessionrestore_no_auto_restore', 12:52:19 INFO - 'tabpaint']}, 12:52:19 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:52:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:52:19 INFO - 'bloom_basic_ref']}, 12:52:19 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:52:19 INFO - 'talos_options': ['--mitmproxy', 12:52:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:52:19 INFO - '--firstNonBlankPaint'], 12:52:19 INFO - 'tests': ['quantum_pageload_google', 12:52:19 INFO - 'quantum_pageload_youtube', 12:52:19 INFO - 'quantum_pageload_amazon', 12:52:19 INFO - 'quantum_pageload_facebook']}, 12:52:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['tsvgx', 12:52:19 INFO - 'tsvgr_opacity', 12:52:19 INFO - 'tart', 12:52:19 INFO - 'tscrollx', 12:52:19 INFO - 'cart', 12:52:19 INFO - 'tsvg_static']}, 12:52:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:52:19 INFO - 'tsvgr_opacity', 12:52:19 INFO - 'tart', 12:52:19 INFO - 'tscrollx', 12:52:19 INFO - 'cart', 12:52:19 INFO - 'tsvg_static']}, 12:52:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'talos_options': ['--disable-e10s'], 12:52:19 INFO - 'tests': ['tp5o']}, 12:52:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:52:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'talos_options': ['--disable-e10s', 12:52:19 INFO - '--xperf_path', 12:52:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:19 INFO - 'tests': ['tp5n']}, 12:52:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:52:19 INFO - 'talos_options': ['--xperf_path', 12:52:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:52:19 INFO - 'tests': ['tp5n']}}, 12:52:19 INFO - 'talos.zip': {'path': '', 12:52:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:52:19 INFO - Running post-action listener: _resource_record_post_action 12:52:19 INFO - [mozharness: 2017-06-22 19:52:19.258757Z] Finished populate-webroot step (success) 12:52:19 INFO - [mozharness: 2017-06-22 19:52:19.258846Z] Running create-virtualenv step. 12:52:19 INFO - Running pre-action listener: _resource_record_pre_action 12:52:19 INFO - Running main action method: create_virtualenv 12:52:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:52:19 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 12:52:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:52:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:52:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:52:20 INFO - Using real prefix '/usr' 12:52:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:52:20 INFO - Installing distribute.............................................................................................................................................................................................done. 12:52:21 INFO - Installing pip.................done. 12:52:21 INFO - Return code: 0 12:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:52:22 INFO - Reading from file tmpfile_stdout 12:52:22 INFO - Output received: 12:52:22 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) 12:52:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:22 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:22 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 12:52:22 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 12:52:22 INFO - Using env: {'DISPLAY': ':0', 12:52:22 INFO - 'HOME': '/home/cltbld', 12:52:22 INFO - 'LANG': 'en_US.UTF-8', 12:52:22 INFO - 'LANGUAGE': 'en_US:en', 12:52:22 INFO - 'LOGNAME': 'cltbld', 12:52:22 INFO - 'MAIL': '/var/mail/cltbld', 12:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:22 INFO - 'MOZ_NO_REMOTE': '1', 12:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:22 INFO - 'NO_EM_RESTART': '1', 12:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:22 INFO - 'PWD': '/builds/slave/test', 12:52:22 INFO - 'SHELL': '/bin/bash', 12:52:22 INFO - 'SHLVL': '1', 12:52:22 INFO - 'TERM': 'linux', 12:52:22 INFO - 'TMOUT': '86400', 12:52:22 INFO - 'USER': 'cltbld', 12:52:22 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:22 INFO - '_': '/tools/buildbot/bin/python'} 12:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:22 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 12:52:22 INFO - Cleaning up... 12:52:22 INFO - Return code: 0 12:52:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:22 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:22 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 12:52:22 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 12:52:22 INFO - Using env: {'DISPLAY': ':0', 12:52:22 INFO - 'HOME': '/home/cltbld', 12:52:22 INFO - 'LANG': 'en_US.UTF-8', 12:52:22 INFO - 'LANGUAGE': 'en_US:en', 12:52:22 INFO - 'LOGNAME': 'cltbld', 12:52:22 INFO - 'MAIL': '/var/mail/cltbld', 12:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:22 INFO - 'MOZ_NO_REMOTE': '1', 12:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:22 INFO - 'NO_EM_RESTART': '1', 12:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:22 INFO - 'PWD': '/builds/slave/test', 12:52:22 INFO - 'SHELL': '/bin/bash', 12:52:22 INFO - 'SHLVL': '1', 12:52:22 INFO - 'TERM': 'linux', 12:52:22 INFO - 'TMOUT': '86400', 12:52:22 INFO - 'USER': 'cltbld', 12:52:22 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:22 INFO - '_': '/tools/buildbot/bin/python'} 12:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:22 INFO - Downloading/unpacking psutil>=3.1.1 12:52: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 12:52: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 12:52: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 12:52: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 12:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:52:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:23 INFO - Installing collected packages: psutil 12:52:23 INFO - Running setup.py install for psutil 12:52:23 INFO - building 'psutil._psutil_linux' extension 12:52:23 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:52:23 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 12:52:23 INFO - building 'psutil._psutil_posix' extension 12:52:23 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 12:52:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:52:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:52:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:52:24 INFO - Successfully installed psutil 12:52:24 INFO - Cleaning up... 12:52:24 INFO - Return code: 0 12:52:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:52:24 INFO - Using env: {'DISPLAY': ':0', 12:52:24 INFO - 'HOME': '/home/cltbld', 12:52:24 INFO - 'LANG': 'en_US.UTF-8', 12:52:24 INFO - 'LANGUAGE': 'en_US:en', 12:52:24 INFO - 'LOGNAME': 'cltbld', 12:52:24 INFO - 'MAIL': '/var/mail/cltbld', 12:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:24 INFO - 'MOZ_NO_REMOTE': '1', 12:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:24 INFO - 'NO_EM_RESTART': '1', 12:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:24 INFO - 'PWD': '/builds/slave/test', 12:52:24 INFO - 'SHELL': '/bin/bash', 12:52:24 INFO - 'SHLVL': '1', 12:52:24 INFO - 'TERM': 'linux', 12:52:24 INFO - 'TMOUT': '86400', 12:52:24 INFO - 'USER': 'cltbld', 12:52:24 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:24 INFO - '_': '/tools/buildbot/bin/python'} 12:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:52:24 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 12:52:24 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 12:52:24 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 12:52:24 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 12:52:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:52:25 INFO - Installing collected packages: mozsystemmonitor 12:52:25 INFO - Running setup.py install for mozsystemmonitor 12:52:25 INFO - Successfully installed mozsystemmonitor 12:52:25 INFO - Cleaning up... 12:52:25 INFO - Return code: 0 12:52:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:52:25 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')]} 12:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:25 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')]} 12:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:25 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:25 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 12:52:25 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 12:52:25 INFO - Using env: {'DISPLAY': ':0', 12:52:25 INFO - 'HOME': '/home/cltbld', 12:52:25 INFO - 'LANG': 'en_US.UTF-8', 12:52:25 INFO - 'LANGUAGE': 'en_US:en', 12:52:25 INFO - 'LOGNAME': 'cltbld', 12:52:25 INFO - 'MAIL': '/var/mail/cltbld', 12:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:25 INFO - 'MOZ_NO_REMOTE': '1', 12:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:25 INFO - 'NO_EM_RESTART': '1', 12:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:25 INFO - 'PWD': '/builds/slave/test', 12:52:25 INFO - 'SHELL': '/bin/bash', 12:52:25 INFO - 'SHLVL': '1', 12:52:25 INFO - 'TERM': 'linux', 12:52:25 INFO - 'TMOUT': '86400', 12:52:25 INFO - 'USER': 'cltbld', 12:52:25 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:25 INFO - '_': '/tools/buildbot/bin/python'} 12:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:52: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 12:52: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 12:52: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 12:52: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 12:52:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:27 INFO - warning: no files found matching '*.txt' 12:52:27 INFO - no previously-included directories found matching 'build' 12:52:27 INFO - no previously-included directories found matching 'dist' 12:52:27 INFO - no previously-included directories found matching '.git*' 12:52:27 INFO - Installing collected packages: jsonschema, functools32 12:52:27 INFO - Running setup.py install for functools32 12:52:27 INFO - warning: no files found matching '*.txt' 12:52:27 INFO - no previously-included directories found matching 'build' 12:52:27 INFO - no previously-included directories found matching 'dist' 12:52:27 INFO - no previously-included directories found matching '.git*' 12:52:27 INFO - Successfully installed jsonschema functools32 12:52:27 INFO - Cleaning up... 12:52:27 INFO - Return code: 0 12:52:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:52:27 INFO - Using env: {'DISPLAY': ':0', 12:52:27 INFO - 'HOME': '/home/cltbld', 12:52:27 INFO - 'LANG': 'en_US.UTF-8', 12:52:27 INFO - 'LANGUAGE': 'en_US:en', 12:52:27 INFO - 'LOGNAME': 'cltbld', 12:52:27 INFO - 'MAIL': '/var/mail/cltbld', 12:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:27 INFO - 'MOZ_NO_REMOTE': '1', 12:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:27 INFO - 'NO_EM_RESTART': '1', 12:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:27 INFO - 'PWD': '/builds/slave/test', 12:52:27 INFO - 'SHELL': '/bin/bash', 12:52:27 INFO - 'SHLVL': '1', 12:52:27 INFO - 'TERM': 'linux', 12:52:27 INFO - 'TMOUT': '86400', 12:52:27 INFO - 'USER': 'cltbld', 12:52:27 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:27 INFO - '_': '/tools/buildbot/bin/python'} 12:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:52:27 INFO - Cleaning up... 12:52:27 INFO - Return code: 0 12:52:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:52:27 INFO - Using env: {'DISPLAY': ':0', 12:52:27 INFO - 'HOME': '/home/cltbld', 12:52:27 INFO - 'LANG': 'en_US.UTF-8', 12:52:27 INFO - 'LANGUAGE': 'en_US:en', 12:52:27 INFO - 'LOGNAME': 'cltbld', 12:52:27 INFO - 'MAIL': '/var/mail/cltbld', 12:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:27 INFO - 'MOZ_NO_REMOTE': '1', 12:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:27 INFO - 'NO_EM_RESTART': '1', 12:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:27 INFO - 'PWD': '/builds/slave/test', 12:52:27 INFO - 'SHELL': '/bin/bash', 12:52:27 INFO - 'SHLVL': '1', 12:52:27 INFO - 'TERM': 'linux', 12:52:27 INFO - 'TMOUT': '86400', 12:52:27 INFO - 'USER': 'cltbld', 12:52:27 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:27 INFO - '_': '/tools/buildbot/bin/python'} 12:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:27 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:52:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:29 INFO - Downloading docopt-0.6.1.tar.gz 12:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:29 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:29 INFO - Running setup.py install for blobuploader 12:52:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:52:29 INFO - Running setup.py install for requests 12:52:29 INFO - Running setup.py install for docopt 12:52:30 INFO - Successfully installed blobuploader requests docopt 12:52:30 INFO - Cleaning up... 12:52:30 INFO - Return code: 0 12:52:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:52:30 INFO - Using env: {'DISPLAY': ':0', 12:52:30 INFO - 'HOME': '/home/cltbld', 12:52:30 INFO - 'LANG': 'en_US.UTF-8', 12:52:30 INFO - 'LANGUAGE': 'en_US:en', 12:52:30 INFO - 'LOGNAME': 'cltbld', 12:52:30 INFO - 'MAIL': '/var/mail/cltbld', 12:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:30 INFO - 'MOZ_NO_REMOTE': '1', 12:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:30 INFO - 'NO_EM_RESTART': '1', 12:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:30 INFO - 'PWD': '/builds/slave/test', 12:52:30 INFO - 'SHELL': '/bin/bash', 12:52:30 INFO - 'SHLVL': '1', 12:52:30 INFO - 'TERM': 'linux', 12:52:30 INFO - 'TMOUT': '86400', 12:52:30 INFO - 'USER': 'cltbld', 12:52:30 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:30 INFO - '_': '/tools/buildbot/bin/python'} 12:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:30 INFO - Running setup.py (path:/tmp/pip-tCZSaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:30 INFO - Running setup.py (path:/tmp/pip-eRZVyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:30 INFO - Running setup.py (path:/tmp/pip-ACqMta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:30 INFO - Running setup.py (path:/tmp/pip-K4gZFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:30 INFO - Running setup.py (path:/tmp/pip-VX5Cb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:30 INFO - Running setup.py (path:/tmp/pip-u7GjUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:30 INFO - Running setup.py (path:/tmp/pip-c3i5pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:30 INFO - Running setup.py (path:/tmp/pip-5fxf2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:30 INFO - Running setup.py (path:/tmp/pip-0epOpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:30 INFO - Running setup.py (path:/tmp/pip-tDBRZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:31 INFO - Running setup.py (path:/tmp/pip-I8_Pvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:31 INFO - Running setup.py (path:/tmp/pip-gpdc1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:31 INFO - Running setup.py (path:/tmp/pip-Q80kTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:31 INFO - Running setup.py (path:/tmp/pip-PfcXRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:31 INFO - Running setup.py (path:/tmp/pip-eC2AmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:31 INFO - Running setup.py (path:/tmp/pip-l0iH3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:31 INFO - Running setup.py (path:/tmp/pip-rtNS5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:31 INFO - Running setup.py install for manifestparser 12:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:52:31 INFO - Running setup.py install for mozcrash 12:52:31 INFO - Running setup.py install for mozdebug 12:52:31 INFO - Running setup.py install for mozdevice 12:52:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:52:31 INFO - Running setup.py install for mozfile 12:52:32 INFO - Running setup.py install for mozhttpd 12:52:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozinfo 12:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozInstall 12:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozleak 12:52:32 INFO - Running setup.py install for mozlog 12:52:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for moznetwork 12:52:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozprocess 12:52:32 INFO - Running setup.py install for mozprofile 12:52:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozrunner 12:52:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:52:32 INFO - Running setup.py install for mozscreenshot 12:52:33 INFO - Running setup.py install for moztest 12:52:33 INFO - Running setup.py install for mozversion 12:52:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:52:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:33 INFO - Cleaning up... 12:52:33 INFO - Return code: 0 12:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52: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')]} 12:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52: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')]} 12:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:33 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:33 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 12:52:33 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 12:52:33 INFO - Using env: {'DISPLAY': ':0', 12:52:33 INFO - 'HOME': '/home/cltbld', 12:52:33 INFO - 'LANG': 'en_US.UTF-8', 12:52:33 INFO - 'LANGUAGE': 'en_US:en', 12:52:33 INFO - 'LOGNAME': 'cltbld', 12:52:33 INFO - 'MAIL': '/var/mail/cltbld', 12:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:33 INFO - 'MOZ_NO_REMOTE': '1', 12:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:33 INFO - 'NO_EM_RESTART': '1', 12:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:33 INFO - 'PWD': '/builds/slave/test', 12:52:33 INFO - 'SHELL': '/bin/bash', 12:52:33 INFO - 'SHLVL': '1', 12:52:33 INFO - 'TERM': 'linux', 12:52:33 INFO - 'TMOUT': '86400', 12:52:33 INFO - 'USER': 'cltbld', 12:52:33 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:33 INFO - '_': '/tools/buildbot/bin/python'} 12:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:52:33 INFO - Running setup.py (path:/tmp/pip-d5zDW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:52:33 INFO - Running setup.py (path:/tmp/pip-TIPlyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:52:33 INFO - Running setup.py (path:/tmp/pip-vYQwz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:52:33 INFO - Running setup.py (path:/tmp/pip-l_G58e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:52:33 INFO - Running setup.py (path:/tmp/pip-Ne7y_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:52:33 INFO - Running setup.py (path:/tmp/pip-0zOeri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:52:33 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)) 12:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:52:33 INFO - Running setup.py (path:/tmp/pip-O7acwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:52:34 INFO - Running setup.py (path:/tmp/pip-WMx5B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:52:34 INFO - Running setup.py (path:/tmp/pip-OVELh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:52:34 INFO - Running setup.py (path:/tmp/pip-ta1FWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:52:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:52:34 INFO - Running setup.py (path:/tmp/pip-eeuHjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:52:34 INFO - Running setup.py (path:/tmp/pip-scWFLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:52:34 INFO - Running setup.py (path:/tmp/pip-suEXlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:52:34 INFO - Running setup.py (path:/tmp/pip-10nTVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:34 INFO - Running setup.py (path:/tmp/pip-PWspJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:52:34 INFO - Running setup.py (path:/tmp/pip-_ivLJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:52:34 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)) 12:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:52:34 INFO - Running setup.py (path:/tmp/pip-zObfsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:52:34 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)) 12:52:34 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)) 12:52:34 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)) 12:52:34 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)) 12:52:34 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)) 12:52:34 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)) 12:52:34 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)) 12:52:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:35 INFO - Downloading blessings-1.6.tar.gz 12:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:35 INFO - Installing collected packages: blessings 12:52:35 INFO - Running setup.py install for blessings 12:52:35 INFO - Successfully installed blessings 12:52:35 INFO - Cleaning up... 12:52:36 INFO - Return code: 0 12:52:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:36 INFO - Reading from file tmpfile_stdout 12:52:36 INFO - Current package versions: 12:52:36 INFO - argparse == 1.2.1 12:52:36 INFO - blessings == 1.6 12:52:36 INFO - blobuploader == 1.2.4 12:52:36 INFO - docopt == 0.6.1 12:52:36 INFO - functools32 == 3.2.3-2 12:52:36 INFO - jsonschema == 2.5.1 12:52:36 INFO - manifestparser == 1.1 12:52:36 INFO - mozInstall == 1.13 12:52:36 INFO - mozcrash == 1.0 12:52:36 INFO - mozdebug == 0.1 12:52:36 INFO - mozdevice == 0.51 12:52:36 INFO - mozfile == 1.2 12:52:36 INFO - mozhttpd == 0.7 12:52:36 INFO - mozinfo == 0.10 12:52:36 INFO - mozleak == 0.1 12:52:36 INFO - mozlog == 3.4 12:52:36 INFO - moznetwork == 0.27 12:52:36 INFO - mozprocess == 0.25 12:52:36 INFO - mozprofile == 0.28 12:52:36 INFO - mozrunner == 6.13 12:52:36 INFO - mozscreenshot == 0.1 12:52:36 INFO - mozsystemmonitor == 0.3 12:52:36 INFO - moztest == 0.8 12:52:36 INFO - mozversion == 1.4 12:52:36 INFO - psutil == 3.1.1 12:52:36 INFO - requests == 1.2.3 12:52:36 INFO - wsgiref == 0.1.2 12:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:52:36 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')]} 12:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:36 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')]} 12:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:36 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:36 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 12:52:36 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 12:52:36 INFO - Using env: {'DISPLAY': ':0', 12:52:36 INFO - 'HOME': '/home/cltbld', 12:52:36 INFO - 'LANG': 'en_US.UTF-8', 12:52:36 INFO - 'LANGUAGE': 'en_US:en', 12:52:36 INFO - 'LOGNAME': 'cltbld', 12:52:36 INFO - 'MAIL': '/var/mail/cltbld', 12:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:36 INFO - 'MOZ_NO_REMOTE': '1', 12:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:36 INFO - 'NO_EM_RESTART': '1', 12:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:36 INFO - 'PWD': '/builds/slave/test', 12:52:36 INFO - 'SHELL': '/bin/bash', 12:52:36 INFO - 'SHLVL': '1', 12:52:36 INFO - 'TERM': 'linux', 12:52:36 INFO - 'TMOUT': '86400', 12:52:36 INFO - 'USER': 'cltbld', 12:52:36 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:36 INFO - '_': '/tools/buildbot/bin/python'} 12:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 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)) 12:52:36 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:52:36 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 12:52:36 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 12:52:36 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 12:52:36 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 12:52:37 INFO - Downloading marionette_driver-1.4.0.tar.gz 12:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 12:52:37 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)) 12:52:37 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)) 12:52:37 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)) 12:52:37 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)) 12:52:37 INFO - Installing collected packages: marionette-driver 12:52:37 INFO - Running setup.py install for marionette-driver 12:52:37 INFO - Successfully installed marionette-driver 12:52:37 INFO - Cleaning up... 12:52:37 INFO - Return code: 0 12:52:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:37 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 0x1cc93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20479a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, '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': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', '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 12:52:37 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 12:52:37 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 12:52:37 INFO - Using env: {'DISPLAY': ':0', 12:52:37 INFO - 'HOME': '/home/cltbld', 12:52:37 INFO - 'LANG': 'en_US.UTF-8', 12:52:37 INFO - 'LANGUAGE': 'en_US:en', 12:52:37 INFO - 'LOGNAME': 'cltbld', 12:52:37 INFO - 'MAIL': '/var/mail/cltbld', 12:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:37 INFO - 'MOZ_NO_REMOTE': '1', 12:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:37 INFO - 'NO_EM_RESTART': '1', 12:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:37 INFO - 'PWD': '/builds/slave/test', 12:52:37 INFO - 'SHELL': '/bin/bash', 12:52:37 INFO - 'SHLVL': '1', 12:52:37 INFO - 'TERM': 'linux', 12:52:37 INFO - 'TMOUT': '86400', 12:52:37 INFO - 'USER': 'cltbld', 12:52:37 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:37 INFO - '_': '/tools/buildbot/bin/python'} 12:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:52:37 INFO - Cleaning up... 12:52:38 INFO - Return code: 0 12:52:38 INFO - Running post-action listener: _resource_record_post_action 12:52:38 INFO - Running post-action listener: _start_resource_monitoring 12:52:38 INFO - Starting resource monitoring. 12:52:38 INFO - [mozharness: 2017-06-22 19:52:38.030240Z] Finished create-virtualenv step (success) 12:52:38 INFO - [mozharness: 2017-06-22 19:52:38.030751Z] Running install step. 12:52:38 INFO - Running pre-action listener: _resource_record_pre_action 12:52:38 INFO - Running main action method: install 12:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:52:38 INFO - Reading from file tmpfile_stdout 12:52:38 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:52:38 INFO - Reading from file tmpfile_stdout 12:52:38 INFO - Output received: 12:52:38 INFO - Usage: mozinstall [options] installer 12:52:38 INFO - Options: 12:52:38 INFO - -h, --help show this help message and exit 12:52:38 INFO - -d DEST, --destination=DEST 12:52:38 INFO - Directory to install application into. [default: 12:52:38 INFO - "/builds/slave/test"] 12:52:38 INFO - --app=APP Application being installed. [default: firefox] 12:52:38 INFO - mkdir: /builds/slave/test/build/application 12:52:38 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'] 12:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:52:56 INFO - Reading from file tmpfile_stdout 12:52:56 INFO - Output received: 12:52:56 INFO - /builds/slave/test/build/application/firefox/firefox 12:52:56 INFO - Running post-action listener: _resource_record_post_action 12:52:56 INFO - [mozharness: 2017-06-22 19:52:56.226779Z] Finished install step (success) 12:52:56 INFO - [mozharness: 2017-06-22 19:52:56.227062Z] Running setup-mitmproxy step. 12:52:56 INFO - Running pre-action listener: _resource_record_pre_action 12:52:56 INFO - Running main action method: setup_mitmproxy 12:52:56 INFO - Skipping: mitmproxy is not required 12:52:56 INFO - Running post-action listener: _resource_record_post_action 12:52:56 INFO - [mozharness: 2017-06-22 19:52:56.228187Z] Finished setup-mitmproxy step (success) 12:52:56 INFO - [mozharness: 2017-06-22 19:52:56.228473Z] Running run-tests step. 12:52:56 INFO - Running pre-action listener: _resource_record_pre_action 12:52:56 INFO - Running main action method: run_tests 12:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:52:56 INFO - Python 2.7.3 12:52:56 INFO - Return code: 0 12:52:56 INFO - grabbing minidump binary from tooltool 12:52:56 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')]} 12:52:56 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 0x2045140>, '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 0x2045a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2045ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:52:56 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 12:52:56 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 12:52:56 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 12:52:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:56 INFO - Return code: 0 12:52:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:52:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:52:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:52:56 INFO - ENV: RUST_BACKTRACE is now 1 12:52:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:52:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:52:56 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/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 12:52:56 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/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 12:52:56 INFO - Using env: {'DISPLAY': ':0', 12:52:56 INFO - 'HOME': '/home/cltbld', 12:52:56 INFO - 'LANG': 'en_US.UTF-8', 12:52:56 INFO - 'LANGUAGE': 'en_US:en', 12:52:56 INFO - 'LOGNAME': 'cltbld', 12:52:56 INFO - 'MAIL': '/var/mail/cltbld', 12:52:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:52:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:56 INFO - 'MOZ_NO_REMOTE': '1', 12:52:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:56 INFO - 'NO_EM_RESTART': '1', 12:52:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:52:56 INFO - 'PWD': '/builds/slave/test', 12:52:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:52:56 INFO - 'RUST_BACKTRACE': '1', 12:52:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:52:56 INFO - 'SHELL': '/bin/bash', 12:52:56 INFO - 'SHLVL': '1', 12:52:56 INFO - 'TERM': 'linux', 12:52:56 INFO - 'TMOUT': '86400', 12:52:56 INFO - 'USER': 'cltbld', 12:52:56 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606', 12:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:56 INFO - '_': '/tools/buildbot/bin/python'} 12:52:56 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/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 12:52:56 INFO - mozversion application_buildid: 20170622190605 12:52:56 INFO - mozversion application_changeset: 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 12:52:56 INFO - mozversion application_display_name: Nightly 12:52:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:56 INFO - mozversion application_name: Firefox 12:52:56 INFO - mozversion application_remotingname: firefox 12:52:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:52:56 INFO - mozversion application_vendor: Mozilla 12:52:56 INFO - mozversion application_version: 56.0a1 12:52:56 INFO - mozversion platform_buildid: 20170622190605 12:52:56 INFO - mozversion platform_changeset: 61edb6b490719686c8e9f8e3bf4bdd401aa1c2b5 12:52:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:52:56 INFO - mozversion platform_version: 56.0a1 12:52:56 INFO - using testdate: 1498161176 12:52:56 INFO - actual date: 1498161176 12:52:56 INFO - starting webserver on 'localhost:50822' 12:52:56 INFO - SUITE-START | Running 2 tests 12:52:56 INFO - TEST-START | dromaeo_css 12:52:56 INFO - operating with platform_type : linux_ 12:52:56 INFO - Initialising browser for dromaeo_css test... 12:52:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50822/getInfo.html -profile /tmp/tmpHOuU2x/profile 12:52:56 INFO - TEST-INFO | started process 10115 (/builds/slave/test/build/application/firefox/firefox http://localhost:50822/getInfo.html) 12:53:03 INFO - TEST-INFO | 10115: exit 0 12:53:03 INFO - Browser initialized. 12:53:03 INFO - Running cycle 1/1 for dromaeo_css test... 12:53:03 INFO - TEST-INFO | started process 10344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHOuU2x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:53:15 INFO - PID 10344 | RSS: Main: 179122176 12:53:15 INFO - PID 10344 | 12:56:18 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50822/tests/dromaeo/cssquery-ext.html) 12:56:20 INFO - PID 10344 | RSS: Main: 184733696 12:56:20 INFO - PID 10344 | 12:59:22 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-ext.html (next: http://localhost:50822/tests/dromaeo/cssquery-jquery.html) 12:59:22 INFO - PID 10344 | RSS: Main: 183341056 12:59:22 INFO - PID 10344 | 13:02:24 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50822/tests/dromaeo/cssquery-mootools.html) 13:02:24 INFO - PID 10344 | RSS: Main: 186380288 13:02:24 INFO - PID 10344 | 13:05:26 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50822/tests/dromaeo/cssquery-prototype.html) 13:05:27 INFO - PID 10344 | RSS: Main: 183427072 13:05:27 INFO - PID 10344 | 13:08:30 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50822/tests/dromaeo/cssquery-yui.html) 13:08:30 INFO - PID 10344 | RSS: Main: 186793984 13:08:30 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | Cycle 1(1): loaded http://localhost:50822/tests/dromaeo/cssquery-yui.html (next: http://localhost:50822/tests/dromaeo/cssquery-dojo.html) 13:11:32 INFO - PID 10344 | RSS: Main: 181837824 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | __start_tp_report 13:11:32 INFO - PID 10344 | _x_x_mozilla_page_load 13:11:32 INFO - PID 10344 | _x_x_mozilla_page_load_details 13:11:32 INFO - PID 10344 | |i|pagename|runs| 13:11:32 INFO - PID 10344 | |0;dojo.html;2955.143008527527;3006.6842981486943;3006.774491913107;3019.048999565137;3027.7729170312227;5893.086571581406;5902.557308201881;5945.286565612128;6012.098185272212;6072.757089716417;5918.88162236755;5926.96278151324;6030.427109424609;6042.184305118808;6051.576389652726;5523.7238138093135;5524.14375771756;5562.3047119110115;5565.66606003639;5632.831015069554;5474.72626368682;5475.945240547603;5509.338879334486;5514.834554963358;5517.889642207154;5532.861678458031;5562.054450743343;5599.7480113394995;5620.775168993236;5641.717914104278;5607.130894711327;5623.634463759842;5634.239377684001;5650.802221922254;5658.660480371191;5532;5543.334799824047;5564.554835613141;5570.749316280737;5608.859778505529;5796;5871.236739223917;5962.403759624046;6004.909926351108;6054.273487181523;6450.451711604473;6474.773382931575;6545.574537655038;6547.181602299713;6552.4758019358815;6478;6495.058216558573;6505.284418713938;6556.3443655634055;6572.80281591553;6090.6041107328765;6125.632462052246;6129.325774164839;6142.600730952474;6149.13912052313;6447.2263328400895;6561.934380656227;6565.967170164118;6572.014197870262;6680.498962577826;6401.007843784221;6414.326495717883;6420.871582568322;6429.807105786834;6434.581752186093;6430.871382572323;6522.249941256816;6531.706073226716;6533.379328963741;6534.9673251634385;6489.610623362613;6507.544471887017;6518.869622607522;6533.8366540835905;6536.084948107269;6268.937310626927;6496.7726129585235;6509.218893732687;6513.837154071091;6539.542232043711;5235.764390602432;5241.68549887008;5264.315638966987;5273.762680679379;5290.761915713802;4521.525239849834;4525.977370113194;4550.408446901882;4557.703749256288;4600.240960241589;5609.27079479665;5616.6068375213345;5617.634853734494;5623.971880140573;5649.265595472644;6424.357564243538;6476.481881449473;6522.902156467657;6523.608583485006;6544.509161812883;5442.836714898559;5502.174673798882;5532.834014979557;5569.944300556943;5584.804531841447;5666.433356664383;5683.54531637468;5684.346300175533;5709.971450142806;5768.567357448208;6249.312575616769;6275.968620156961;6288.465480434214;6302.432781049728;6332.841678958063;6502.642354670538;6547.181602299713;6559.7376104955265;6574.76988305407;6588;6298.653574053471;6330.968345158245;6342.365763423621;6345.016522439029;6364.4908407326375;6208.72060757258;6331.873362532631;6336.746530138743;6370.936290637034;6393.648349340645;6373.904391434039;6412.2625898022325;6482.546221764431;6486.383793539606;6496.512761542997;6364.93635063662;6380.457661098673;6384.680765961591;6398.71205795731;6411.967940160456;6358.078078678658;6367.3314301997625;6375;6392.744290228339;6400.45596124316;6137.570370074052;6143.416375444325;6211.409916058148;6241.21984751906;6281.434670879643;6267.843303917439;6277;6290.1508296381235;6291.685415729286;6305.873882522415;6109.7387008107025;6143.911070236141;6175.042868355412;6183.598066125687;6189.659568723763 13:11:32 INFO - PID 10344 | |1;ext.html;802.6668932393058;834.0533494483761;867.8047439326152;873.3275377958972;1167.3987896233436;29721.40557188855;30269.39461210777;30403.543946840815;40146.99999999993;41463;40608.39087413691;40870.59129408705;40984.18031639373;41021;41131.58868411315;7538.396928245741;7604.505707129047;7652.846943061136;7677.500962437452;7681.692732290701;7649.6940122395035;7685.923140768577;7695.345895598881;7752.302292793675;7768.689252429925;7444.441666874979;7718.073831140271;7720.420968427362;7731.188225236354;7758.107817600991;7610.086789585258;7640.885386719204;7648.770536883874;7649.502782319131;7697.8075548111465;7579.810504737426;7595.772126836204;7623.695052197905;7624.085109786805;7649.885251721173;37025.25949481022;37048.07379815499;37396;37426.43860342097;37433.62566374329;3465.1337165708574;3500.824958752052;3501.229729459515;3505.6494350564994;3506.4389697648253;29648.555271670728;29681;29686.257843553867;29741.256468588243;29863;3751.681107105899;3778;3782.1868298315994;3784.791836448994;3842.500474938268;165479;169695.15152424158;174901;177539;177887;40174.397384039265;46885.53114468812;47055.52944470511;47128.29307560389;47687.52312476831;50391;50492.49507504951;50496.49503504991;50747;50856.23715644268;14748.115113093249;14824.851751482563;14825.77761333581;14844.777328340084;14852.183129927742;12060.577879774166;12086.69783255408;12093.75812483763;12102.878971210352;12192.08559358034;14215;14222.573322800332;14328.426862925366;14400.639984000274;14471.348789304506;5625.943740562624;5676.318841739017;5751.396103409165;5777.19119323295;5832.766689332464;971.9222462203007;972.3960213867783;975.6097560975667;986.2701600815489;999.5901680311038;21866;22198.223062192745;22234.332970010924;22561.66157507639;23001.309960701205;1049.1134990932649;1057.5981127171626;1077.8329358949375;1078.3799315393524;1095.1786160379716;11749.647510574696;11828.822567661491;11851.88148118525;11877.465514051888;12036.63890083299;214594;219071;219885;220292;220387;49412.28232447178;49779.50220497821;49848;49850.25224621633;50082;1453.0409929446514;1455.2650911289732;1471.4408524760736;1489.3223583269587;1492.9253537323307;21413.571728565654;21782.17821782161;21818.890905546006;22156.667649985586;22878.199263025715;35972.64027359798;36277.45583816192;36320.636793631726;36391.09022274359;36440.635593643725;180528;180833.09583451998;181090;181476;181788;29526;29959.700402996565;30071;31221.687783122787;32274;40712.79643601881;41777.37333940054;41788;41900.790496047324;42162.36756448595;29304.26739331534;29660.55509167321;30045.399092018473;30247;32039.199020024687;29628.407431851672;29702.55446168266;29943.251418713837;30756;31323.84338078295;32362.734608578114;33099;33155;33507.66492335143;33591;27463.313417164733;28549.42901142007;29182.56226156567;29870.701292986792;30080.821603045013;21574.676379854;23581.174658887543;23699.881500592386;23707.40731481727;24177.63733543963 13:11:32 INFO - PID 10344 | |2;jquery.html;561.932568091829;567.7447530756978;571.608448212974;574.6236215278993;589.713988715473;21411.785882141176;22357.776422235773;22374.216902408418;22411.663825042637;22781.658275125887;24110.156144534943;25643.74356256437;25644.743552564516;25767.355816104606;25816.74183258167;6392.264889537704;6532.379423954717;6532.869342613145;6535.281119076898;6538.542302038859;6099.847503812396;6449.064885591586;6511.57674751142;6518.739250429977;6528.183977002875;4065.6340929316357;4727.692699974508;6462.256840463337;6503.512236582252;6518.413342799147;6434.260060093103;6450.6452145132;6482.513811464159;6503.837404064889;6504.544681872271;6059.7273122709585;6062.757489700407;6066.96966515169;6069.119977603267;6075.513958883279;28587.14238572846;29145.271368215752;29232.853835730897;29451.558226626617;29484.936054476195;1959.480737604536;1978.1395093134533;1997.0314397517193;2000.469875482998;2011.3664195778283;17753.644927101384;18068.554515638716;18222.90888545562;18306.542336441562;18408.171632276444;2280.612295909683;2286.5769832581027;2319;2328.8020518255967;2361.7047869016374;118550;120322.1951670717;121110;122049;122348.16477752841;14210;14320.641983950276;14648.633784155481;14813.925930370495;15227.390904363701;23850.16524421637;23891;23913.641295380585;23914.760852391602;23950.401239969142;9570.56932438042;9775.706728798148;9793.657221997339;10107.140893024176;10111.595536178618;8861.73414797557;8941.910580894239;9037.819243615091;9114.13415725505;9146.451212927113;9063.229625481776;9079.182873541413;9157.130072643089;9157.862632060524;9239.122283383067;2633.8288011279205;2667.213172114231;2702.0412648150245;2789.8326100434037;2798.9860050699617;964.5563041001078;972.9221662267001;978.9167920726676;1005.9597616095274;1009.7980403919246;19860.60278794416;20116.99415029272;22054.669179962315;25532;25601;1039.5841663334727;1053.5891002509027;1059.6767985764416;1064.8775390829999;1068.2628985999636;11285.21003529745;11386.487608057658;11422.714432139262;11652.41737913101;11711.531538738525;527011;538884;543577;545127;558130;105834.4708276469;106413;108165;108278.45860770646;109168;1204.590439250659;1216.3796463803524;1233.6792433967232;1249.7063190150307;1260.590308149855;19088.33190838314;21105.522613416913;21301.89349053245;21388.465288367293;21567.784322157204;50071.49928500814;50711.2393314108;51296.74351628218;51491;53172.46827531675;65174.69650606866;65393;65974.67012664906;66082.66958665368;66422;12738.617841464771;12883.484660613845;12932.41804118798;12962;12964.416601252778;16998.57503562421;18633.254669813057;18831;19108.713369299192;19339.323123690603;14296.499622513162;15332.846671533589;15339.156346401054;15418.074915505105;15462.768058479356;14018.369173387426;14494;14691.338889749773;14789.852101478848;15006.624834378792;15765;16021.279042443351;16103.4701703338;16107.275172617496;16113.919430402773;12110.576129835767;12553.560625378068;12709.491620335082;12891.290978996245;12938.029647776642;15182.848171518144;15593.986390884556;15655.45205917833;15661.138637375054;15846.920765396098 13:11:32 INFO - PID 10344 | |3;mootools.html;1344.8520662727099;1431.4703559682912;1432.5201057645688;1444.4222311075569;1444.783282507623;12526.436310366033;12846.293453860035;13049.282289474075;13100.803487947689;13149.47402103917;12903;13256;13309.334533273322;13351.1989280643;13362.799558006638;2601.752833480821;2638.0766731643866;2646.9735302647014;2648.4305874237034;2648.6291919131336;2545.6945166580035;2596.234110937278;2611.986940065297;2619.738026197384;2624.252088154876;2482.888270027844;2502.186789293478;2538.378097366148;2538.6192071189284;2550.41340491687;2463.7659422354936;2483.0316176691103;2494.663220465232;2500.7999360051244;2501.687289088864;2433.8174636902127;2445.987770061156;2458.0045081741746;2470.876456177184;2472.24596498068;12953.546625868144;13044.217346959213;13095.083344165912;13114.409851556702;13135.277559734212;6918.861622767567;7247.275272472763;7249.927500724978;7251.274872512759;7262.854742905165;4011.5186177658575;4212.368144778277;4262.91474170518;4291.828326866922;4319.0713996490595;1575.2989919485833;1606.4698649445654;1628.4137710424238;1647.4316360855485;1655.354411779407;19094.23623055076;19832.801671983383;19863.304784332624;20180.09189586472;20213.797862021485;5592.217089607459;5718.914216286759;5932.495737862244;6151.3541078186145;6222.502199824094;14405.85594144066;14450.421983120768;14462.132272063709;14470.565883023526;14485.275736213147;7023.543469674557;7096.290370962863;7124.394426473704;7126.394256488256;7135.82160445993;6527.445167160749;6768.627725475146;6813.046173535709;6833;6834.521583489208;4628.3288923105965;4720.150372932905;4786.545278198566;4820.807167713252;4884.242942343943;1354.2010213973804;1356.1117468058437;1356.1930651262483;1369.8630136986221;1370.6504841265414;918.4581097152578;921.8985911549725;941.5951141009294;948.800751842107;969.5830792759182;7875.094364148082;7889.02604125191;7999.520028798291;8037.397195210266;8282.337413007066;968.6464440479174;986.9407835529892;1013.2350075692805;1023.7082431506984;1037.0873631204643;4990.775415106256;5136.743162841843;5289.788408463695;5293.444188360167;5386.784528618811;17372.131393430278;18007.18967646459;18014.63970720578;18037.458876233733;18055;17096.401625943283;17178.39875604348;17321.56696082608;17353.30586776515;17410.912945435193;9795.412275263507;10154.119679974448;10352.171826253882;10427.270091093551;10640.787184256425;7380.630968451448;7547.207543208104;7915.287624113857;8355.702181899784;8397.95801020991;14741.484048058266;14891.553253402415;15062.472813451477;15077.924610376878;15135.470258540898;14239.35922883452;14526.491572794901;14863.108213507225;15247.847521524644;15635.29641166173;10039.598416063567;10462.47687615601;11110.944445277722;11141.331520108819;11234.887651123385;12405.13164078542;12539.498420063095;12543.24740515572;12559.811602826148;12567.18313309632;9919.40483570988;10262.538185781508;10366.948165259428;10454.163666906781;10499.107575856138;9805.313628045968;10053.949730251303;10457.215708822021;10464.267501275142;10678.359298442118;9017.774555636162;9209.493477858781;9214.723558293263;9215.907840921505;9224.815503690023;6767.458603311822;6901.792946211622;6919.688614012281;7016.649167541705;7154.284571542804;6855.965720171566;6863.07348507965;6935.479839012195;7058.223595404399;7136.3934065602925 13:11:32 INFO - PID 10344 | |4;prototype.html;486.45031114840225;491.4741226887232;497.780976370397;510.35185314650397;521.397785557681;6110.908336374952;6120.6021608595465;6157.969210153954;6165.907511387327;6180.289266734327;5857.912131318034;6021.87956240876;6056.515478761699;6058.0917011141455;6063.454289113979;4920.163572192718;4924.448798628429;4928.876778080541;4928.890999525114;4940.493149589392;4950.851474455772;4980.2529620557025;4983.975080124595;4994.576545684481;4997.5252351026775;4681.74250416227;4908.7300198489065;4940.110780059588;4943.283223932528;4971.105201063807;4864.743349569127;4877.390326209206;4881.389826271716;4907.1657818171;4912.238603016538;4357.106793107437;4375.2124617568825;4381.123775244963;4402;4405.9118817623785;5851.771128063112;5853.619514731528;5855.209546711182;5904.586678932476;5933.584649074566;5582.469665381782;5584.246126772915;5584.425967380879;5602.1596760485845;5627.6904770237625;6423.64669943153;6428.774992875274;6431.967840160816;6437.388448097423;6453.354664533556;4796.760161991887;4800.271902115236;4805.831795887128;4809.831655892062;4840.636952228597;6732.932670673328;6751.982570370622;6753.15585551806;6771.864562708767;6784.6607669616815;4943.579795717333;4949.8515044548;4955.207166853286;4958.603311735053;4959.132151873408;4956.132676781549;5002.6482256887975;5018.372703412074;5018.673786203885;5041.420236672756;5598.3282006159525;5604.131359639263;5604.719764011783;5607.887842243133;5628.409017053233;6413.711382987777;6425.421712045938;6458.58019228758;6470.9029364559565;6483.655950513074;1624.5532478568489;1703.173960629094;1704.7442883567564;1742.6407402226284;1762.9206685699173;1210.2496452199694;1215.750771091924;1216.5802798034663;1222.443788076423;1247.9500819967282;5435.42927992563;5502.669839809624;5525.806596769094;5569.777208911679;5687.488126068673;6542.672866356663;6567;6600.765624843888;6623.4038936495945;6662.766803161866;5607.355219107612;5639.605227634026;5649.6327738696855;5657.858553536194;5701.116326969326;3499.16020155166;3509.8063710181136;3510.140015696171;3511.543499345069;3531.2760884018717;6262.843428914313;6362.872742545123;6367.840803979938;6416.935830641633;6440.61356318613;6740.056392105109;6743.426808721314;6746.898796518056;6757.864842703217;6776.9322306777285;6417.807465776034;6424.26120996082;6430.067640192053;6432.903506447407;6454.935450645527;6562.934370656232;6569.835754105994;6584;6594;6609.570377925419;6482.837929051623;6537.967310163419;6552.312007239362;6552.410283074356;6560.212774467094;6202.534809889186;6421.325760795049;6423.197100362455;6429.292777794532;6438.871222575616;4787.329773831736;4847.5394837490385;4910.263460480956;4917.655764096479;4919.385076865392;6522.608643481406;6535.3464653534265;6569.178852643419;6578.309277525982;6612.140421745143;6315.810525684236;6334.303226644974;6370.757702248017;6384.648844313421;6392.93607063942;6378.330275321025;6380.521460890359;6388.329225431263;6390.6260154067095;6406.412409050947;6258.342873998165;6270.843228919131;6310.305866354789;6311.526635502264;6344.746210151542;6373.5857169283845;6417.294097649348;6439.871202575829;6444.323346048597;6445.709943052668;6170.938290617216;6200;6217.4715149212825;6217.4715149212825;6223.533235007302 13:11:32 INFO - PID 10344 | |5;yui.html;842.0695131879277;857.8841856349393;861.3410740783302;862.710991817741;869.200335691164;16498.340066397344;16847.83152168478;16860.15699215039;16878.66242675149;16952.23714932828;16073.357065717386;16232.83767162328;18428.631427371445;18873.81126188738;20391.49021274465;1041.604190407644;1085.045160258971;1086.3427626286102;1086.9891301087007;1087.081416203311;1073.441810258665;1073.7154654016654;1074.409075008746;1076.88154303027;1078.573963284502;1109.589451902797;1111.5998240633367;1117.2235296468957;1133.9716507087305;1136.5056200552744;1053.852460655505;1085;1091.579741799405;1098.9890101098968;1112.8386383974319;785.6935795039939;790.7785819970418;792.8731402975554;794.4438892775081;794.8410317936435;16996.40512582066;17014.40449584271;17197.484075477754;17214.31142754288;17255.65488690219;18913.33803316891;19607.019649017493;19632.312869049514;19740.50648733779;19778;14862.108273503625;15369.231538423033;15452.227388630523;15471.767923481157;15581.454649087227;3577.0878426001464;3598.712103031751;3611.512445819807;3624.2751449710163;3633.291508155911;90197.54901225517;92254.07745922521;92508.53745731295;93937.530312348;96164;14551.272436378138;14764.335604897806;14852.2573871306;14860.62848428798;14905.403783848742;24356.512869742506;25905.093321734024;26252;26276.474470510482;26288.211353659422;7905.960470197727;7954.284114429729;7955.2840244378285;7972.3622110231045;7983.2415920487465;3982.5021872265966;3999.5400528939545;4066.1461093170174;4127.09203975125;4140.0891803803115;4647.117047760915;4726.385569875894;4745.881352966204;4759.190937540627;4775.808967641325;900.1718419054486;913.5614904845711;926.935114541989;933.4912472702393;934.3973137326386;682.1779755394738;684.6302996381899;684.9246582875879;702.0767690486994;708.6563016936782;11450.770984580427;11532.538698452136;11697.883021169679;11855.881441185651;12008.579699710468;614.6066517428849;681.4786688183543;700.7792545348301;705.4109818301775;714.1002337055347;5260.92108618371;5386.622936394493;5603.831885043455;5669.092945128759;5750.5112065474905;87500;87976;91647.54176229076;94002;95022.52488737651;77472;79593;80630.19369806227;82288;83385.16614833774;65318.673406633614;65556;65794.34205657979;67397.66301168561;69163;11220.831687524857;13024.47902083906;13175.538856140372;13342.733145336844;13460.125091868997;30490.847545762128;32972;33115.33769324648;33289.667103328655;33714.98855034353;56913;59954.40045599663;60028.69985650044;60715.39284607097;62353;17987;18187.54531136732;18301.99339036366;18396.080195990413;18508.81491185071;19779.20883164715;20372.89813550923;20956.47608809792;21150;21298;18370.448886533424;18878.811211888256;18960.715589265896;19053.237870485027;19170.90414547974;17199.656006880043;18087.276508939496;18148.364807231683;18502.537436564195;19084.809151908303;17547.21037553339;17611.64776704433;17747.82252177462;18036.917784932946;18705.25178992825;11827.940860295643;12445.191062580903;12584.370781461073;13029.804552931902;13453.663658408617;13877.79183312231;14064.507742228972;14502.564923052325;14742.63143421423;15208.923955380153 13:11:32 INFO - PID 10344 | __end_tp_report 13:11:32 INFO - PID 10344 | __start_cc_report 13:11:32 INFO - PID 10344 | _x_x_mozilla_cycle_collect,371 13:11:32 INFO - PID 10344 | __end_cc_report 13:11:32 INFO - PID 10344 | __startTimestamp1498162292682__endTimestamp 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | ------- Summary: start ------- 13:11:32 INFO - PID 10344 | Number of tests: 6 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#0] dojo.html Cycles:165 Average:5967.64 Median:6208.72 stddev:706.01 (11.4%) stddev-sans-first:667.45 13:11:32 INFO - PID 10344 | Values: 2955.1 3006.7 3006.8 3019.0 3027.8 5893.1 5902.6 5945.3 6012.1 6072.8 5918.9 5927.0 6030.4 6042.2 6051.6 5523.7 5524.1 5562.3 5565.7 5632.8 5474.7 5475.9 5509.3 5514.8 5517.9 5532.9 5562.1 5599.7 5620.8 5641.7 5607.1 5623.6 5634.2 5650.8 5658.7 5532.0 5543.3 5564.6 5570.7 5608.9 5796.0 5871.2 5962.4 6004.9 6054.3 6450.5 6474.8 6545.6 6547.2 6552.5 6478.0 6495.1 6505.3 6556.3 6572.8 6090.6 6125.6 6129.3 6142.6 6149.1 6447.2 6561.9 6566.0 6572.0 6680.5 6401.0 6414.3 6420.9 6429.8 6434.6 6430.9 6522.2 6531.7 6533.4 6535.0 6489.6 6507.5 6518.9 6533.8 6536.1 6268.9 6496.8 6509.2 6513.8 6539.5 5235.8 5241.7 5264.3 5273.8 5290.8 4521.5 4526.0 4550.4 4557.7 4600.2 5609.3 5616.6 5617.6 5624.0 5649.3 6424.4 6476.5 6522.9 6523.6 6544.5 5442.8 5502.2 5532.8 5569.9 5584.8 5666.4 5683.5 5684.3 5710.0 5768.6 6249.3 6276.0 6288.5 6302.4 6332.8 6502.6 6547.2 6559.7 6574.8 6588.0 6298.7 6331.0 6342.4 6345.0 6364.5 6208.7 6331.9 6336.7 6370.9 6393.6 6373.9 6412.3 6482.5 6486.4 6496.5 6364.9 6380.5 6384.7 6398.7 6412.0 6358.1 6367.3 6375.0 6392.7 6400.5 6137.6 6143.4 6211.4 6241.2 6281.4 6267.8 6277.0 6290.2 6291.7 6305.9 6109.7 6143.9 6175.0 6183.6 6189.7 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#1] ext.html Cycles:180 Average:35261.83 Median:33127.00 stddev:49749.47 (150.2%) stddev-sans-first:49821.74 13:11:32 INFO - PID 10344 | Values: 802.7 834.1 867.8 873.3 1167.4 29721.4 30269.4 30403.5 40147.0 41463.0 40608.4 40870.6 40984.2 41021.0 41131.6 7538.4 7604.5 7652.8 7677.5 7681.7 7649.7 7685.9 7695.3 7752.3 7768.7 7444.4 7718.1 7720.4 7731.2 7758.1 7610.1 7640.9 7648.8 7649.5 7697.8 7579.8 7595.8 7623.7 7624.1 7649.9 37025.3 37048.1 37396.0 37426.4 37433.6 3465.1 3500.8 3501.2 3505.6 3506.4 29648.6 29681.0 29686.3 29741.3 29863.0 3751.7 3778.0 3782.2 3784.8 3842.5 165479.0 169695.2 174901.0 177539.0 177887.0 40174.4 46885.5 47055.5 47128.3 47687.5 50391.0 50492.5 50496.5 50747.0 50856.2 14748.1 14824.9 14825.8 14844.8 14852.2 12060.6 12086.7 12093.8 12102.9 12192.1 14215.0 14222.6 14328.4 14400.6 14471.3 5625.9 5676.3 5751.4 5777.2 5832.8 971.9 972.4 975.6 986.3 999.6 21866.0 22198.2 22234.3 22561.7 23001.3 1049.1 1057.6 1077.8 1078.4 1095.2 11749.6 11828.8 11851.9 11877.5 12036.6 214594.0 219071.0 219885.0 220292.0 220387.0 49412.3 49779.5 49848.0 49850.3 50082.0 1453.0 1455.3 1471.4 1489.3 1492.9 21413.6 21782.2 21818.9 22156.7 22878.2 35972.6 36277.5 36320.6 36391.1 36440.6 180528.0 180833.1 181090.0 181476.0 181788.0 29526.0 29959.7 30071.0 31221.7 32274.0 40712.8 41777.4 41788.0 41900.8 42162.4 29304.3 29660.6 30045.4 30247.0 32039.2 29628.4 29702.6 29943.3 30756.0 31323.8 32362.7 33099.0 33155.0 33507.7 33591.0 27463.3 28549.4 29182.6 29870.7 30080.8 21574.7 23581.2 23699.9 23707.4 24177.6 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#2] jquery.html Cycles:180 Average:34784.43 Median:22596.66 stddev:90056.46 (398.5%) stddev-sans-first:90272.44 13:11:32 INFO - PID 10344 | Values: 561.9 567.7 571.6 574.6 589.7 21411.8 22357.8 22374.2 22411.7 22781.7 24110.2 25643.7 25644.7 25767.4 25816.7 6392.3 6532.4 6532.9 6535.3 6538.5 6099.8 6449.1 6511.6 6518.7 6528.2 4065.6 4727.7 6462.3 6503.5 6518.4 6434.3 6450.6 6482.5 6503.8 6504.5 6059.7 6062.8 6067.0 6069.1 6075.5 28587.1 29145.3 29232.9 29451.6 29484.9 1959.5 1978.1 1997.0 2000.5 2011.4 17753.6 18068.6 18222.9 18306.5 18408.2 2280.6 2286.6 2319.0 2328.8 2361.7 118550.0 120322.2 121110.0 122049.0 122348.2 14210.0 14320.6 14648.6 14813.9 15227.4 23850.2 23891.0 23913.6 23914.8 23950.4 9570.6 9775.7 9793.7 10107.1 10111.6 8861.7 8941.9 9037.8 9114.1 9146.5 9063.2 9079.2 9157.1 9157.9 9239.1 2633.8 2667.2 2702.0 2789.8 2799.0 964.6 972.9 978.9 1006.0 1009.8 19860.6 20117.0 22054.7 25532.0 25601.0 1039.6 1053.6 1059.7 1064.9 1068.3 11285.2 11386.5 11422.7 11652.4 11711.5 527011.0 538884.0 543577.0 545127.0 558130.0 105834.5 106413.0 108165.0 108278.5 109168.0 1204.6 1216.4 1233.7 1249.7 1260.6 19088.3 21105.5 21301.9 21388.5 21567.8 50071.5 50711.2 51296.7 51491.0 53172.5 65174.7 65393.0 65974.7 66082.7 66422.0 12738.6 12883.5 12932.4 12962.0 12964.4 16998.6 18633.3 18831.0 19108.7 19339.3 14296.5 15332.8 15339.2 15418.1 15462.8 14018.4 14494.0 14691.3 14789.9 15006.6 15765.0 16021.3 16103.5 16107.3 16113.9 12110.6 12553.6 12709.5 12891.3 12938.0 15182.8 15594.0 15655.5 15661.1 15846.9 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#3] mootools.html Cycles:180 Average:8112.02 Median:2477.57 stddev:5294.94 (213.7%) stddev-sans-first:5285.38 13:11:32 INFO - PID 10344 | Values: 1344.9 1431.5 1432.5 1444.4 1444.8 12526.4 12846.3 13049.3 13100.8 13149.5 12903.0 13256.0 13309.3 13351.2 13362.8 2601.8 2638.1 2647.0 2648.4 2648.6 2545.7 2596.2 2612.0 2619.7 2624.3 2482.9 2502.2 2538.4 2538.6 2550.4 2463.8 2483.0 2494.7 2500.8 2501.7 2433.8 2446.0 2458.0 2470.9 2472.2 12953.5 13044.2 13095.1 13114.4 13135.3 6918.9 7247.3 7249.9 7251.3 7262.9 4011.5 4212.4 4262.9 4291.8 4319.1 1575.3 1606.5 1628.4 1647.4 1655.4 19094.2 19832.8 19863.3 20180.1 20213.8 5592.2 5718.9 5932.5 6151.4 6222.5 14405.9 14450.4 14462.1 14470.6 14485.3 7023.5 7096.3 7124.4 7126.4 7135.8 6527.4 6768.6 6813.0 6833.0 6834.5 4628.3 4720.2 4786.5 4820.8 4884.2 1354.2 1356.1 1356.2 1369.9 1370.7 918.5 921.9 941.6 948.8 969.6 7875.1 7889.0 7999.5 8037.4 8282.3 968.6 986.9 1013.2 1023.7 1037.1 4990.8 5136.7 5289.8 5293.4 5386.8 17372.1 18007.2 18014.6 18037.5 18055.0 17096.4 17178.4 17321.6 17353.3 17410.9 9795.4 10154.1 10352.2 10427.3 10640.8 7380.6 7547.2 7915.3 8355.7 8398.0 14741.5 14891.6 15062.5 15077.9 15135.5 14239.4 14526.5 14863.1 15247.8 15635.3 10039.6 10462.5 11110.9 11141.3 11234.9 12405.1 12539.5 12543.2 12559.8 12567.2 9919.4 10262.5 10366.9 10454.2 10499.1 9805.3 10053.9 10457.2 10464.3 10678.4 9017.8 9209.5 9214.7 9215.9 9224.8 6767.5 6901.8 6919.7 7016.6 7154.3 6856.0 6863.1 6935.5 7058.2 7136.4 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#4] prototype.html Cycles:180 Average:5406.86 Median:5977.73 stddev:1510.39 (25.3%) stddev-sans-first:1468.78 13:11:32 INFO - PID 10344 | Values: 486.5 491.5 497.8 510.4 521.4 6110.9 6120.6 6158.0 6165.9 6180.3 5857.9 6021.9 6056.5 6058.1 6063.5 4920.2 4924.4 4928.9 4928.9 4940.5 4950.9 4980.3 4984.0 4994.6 4997.5 4681.7 4908.7 4940.1 4943.3 4971.1 4864.7 4877.4 4881.4 4907.2 4912.2 4357.1 4375.2 4381.1 4402.0 4405.9 5851.8 5853.6 5855.2 5904.6 5933.6 5582.5 5584.2 5584.4 5602.2 5627.7 6423.6 6428.8 6432.0 6437.4 6453.4 4796.8 4800.3 4805.8 4809.8 4840.6 6732.9 6752.0 6753.2 6771.9 6784.7 4943.6 4949.9 4955.2 4958.6 4959.1 4956.1 5002.6 5018.4 5018.7 5041.4 5598.3 5604.1 5604.7 5607.9 5628.4 6413.7 6425.4 6458.6 6470.9 6483.7 1624.6 1703.2 1704.7 1742.6 1762.9 1210.2 1215.8 1216.6 1222.4 1248.0 5435.4 5502.7 5525.8 5569.8 5687.5 6542.7 6567.0 6600.8 6623.4 6662.8 5607.4 5639.6 5649.6 5657.9 5701.1 3499.2 3509.8 3510.1 3511.5 3531.3 6262.8 6362.9 6367.8 6416.9 6440.6 6740.1 6743.4 6746.9 6757.9 6776.9 6417.8 6424.3 6430.1 6432.9 6454.9 6562.9 6569.8 6584.0 6594.0 6609.6 6482.8 6538.0 6552.3 6552.4 6560.2 6202.5 6421.3 6423.2 6429.3 6438.9 4787.3 4847.5 4910.3 4917.7 4919.4 6522.6 6535.3 6569.2 6578.3 6612.1 6315.8 6334.3 6370.8 6384.6 6392.9 6378.3 6380.5 6388.3 6390.6 6406.4 6258.3 6270.8 6310.3 6311.5 6344.7 6373.6 6417.3 6439.9 6444.3 6445.7 6170.9 6200.0 6217.5 6217.5 6223.5 13:11:32 INFO - PID 10344 | 13:11:32 INFO - PID 10344 | [#5] yui.html Cycles:180 Average:20322.51 Median:20382.19 stddev:25212.01 (123.7%) stddev-sans-first:25240.30 13:11:32 INFO - PID 10344 | Values: 842.1 857.9 861.3 862.7 869.2 16498.3 16847.8 16860.2 16878.7 16952.2 16073.4 16232.8 18428.6 18873.8 20391.5 1041.6 1085.0 1086.3 1087.0 1087.1 1073.4 1073.7 1074.4 1076.9 1078.6 1109.6 1111.6 1117.2 1134.0 1136.5 1053.9 1085.0 1091.6 1099.0 1112.8 785.7 790.8 792.9 794.4 794.8 16996.4 17014.4 17197.5 17214.3 17255.7 18913.3 19607.0 19632.3 19740.5 19778.0 14862.1 15369.2 15452.2 15471.8 15581.5 3577.1 3598.7 3611.5 3624.3 3633.3 90197.5 92254.1 92508.5 93937.5 96164.0 14551.3 14764.3 14852.3 14860.6 14905.4 24356.5 25905.1 26252.0 26276.5 26288.2 7906.0 7954.3 7955.3 7972.4 7983.2 3982.5 3999.5 4066.1 4127.1 4140.1 4647.1 4726.4 4745.9 4759.2 4775.8 900.2 913.6 926.9 933.5 934.4 682.2 684.6 684.9 702.1 708.7 11450.8 11532.5 11697.9 11855.9 12008.6 614.6 681.5 700.8 705.4 714.1 5260.9 5386.6 5603.8 5669.1 5750.5 87500.0 87976.0 91647.5 94002.0 95022.5 77472.0 79593.0 80630.2 82288.0 83385.2 65318.7 65556.0 65794.3 67397.7 69163.0 11220.8 13024.5 13175.5 13342.7 13460.1 30490.8 32972.0 33115.3 33289.7 33715.0 56913.0 59954.4 60028.7 60715.4 62353.0 17987.0 18187.5 18302.0 18396.1 18508.8 19779.2 20372.9 20956.5 21150.0 21298.0 18370.4 18878.8 18960.7 19053.2 19170.9 17199.7 18087.3 18148.4 18502.5 19084.8 17547.2 17611.6 17747.8 18036.9 18705.3 11827.9 12445.2 12584.4 13029.8 13453.7 13877.8 14064.5 14502.6 14742.6 15208.9 13:11:32 INFO - PID 10344 | -------- Summary: end -------- 13:11:32 INFO - PID 10344 | 13:11:33 INFO - TEST-INFO | 10344: exit 0 13:11:33 INFO - TEST-OK | dromaeo_css | took 1116746ms 13:11:33 INFO - TEST-START | kraken 13:11:33 INFO - operating with platform_type : linux_ 13:11:33 INFO - Initialising browser for kraken test... 13:11:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50822/getInfo.html -profile /tmp/tmpi3VzQb/profile 13:11:33 INFO - TEST-INFO | started process 10764 (/builds/slave/test/build/application/firefox/firefox http://localhost:50822/getInfo.html) 13:11:39 INFO - TEST-INFO | 10764: exit 0 13:11:39 INFO - Browser initialized. 13:11:39 INFO - Running cycle 1/1 for kraken test... 13:11:39 INFO - TEST-INFO | started process 10995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi3VzQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:11:51 INFO - PID 10995 | RSS: Main: 172818432 13:11:51 INFO - PID 10995 | 13:11:53 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50822/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:54 INFO - PID 10995 | RSS: Main: 177045504 13:11:54 INFO - PID 10995 | 13:11:57 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50822/tests/kraken/driver.html?testName=audio-dft) 13:11:58 INFO - PID 10995 | RSS: Main: 177573888 13:11:58 INFO - PID 10995 | 13:12:01 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50822/tests/kraken/driver.html?testName=audio-fft) 13:12:01 INFO - PID 10995 | RSS: Main: 176472064 13:12:01 INFO - PID 10995 | 13:12:03 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50822/tests/kraken/driver.html?testName=audio-oscillator) 13:12:04 INFO - PID 10995 | RSS: Main: 176836608 13:12:04 INFO - PID 10995 | 13:12:06 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:12:07 INFO - PID 10995 | RSS: Main: 177344512 13:12:07 INFO - PID 10995 | 13:12:10 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50822/tests/kraken/driver.html?testName=imaging-darkroom) 13:12:10 INFO - PID 10995 | RSS: Main: 179806208 13:12:10 INFO - PID 10995 | 13:12:14 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50822/tests/kraken/driver.html?testName=imaging-desaturate) 13:12:14 INFO - PID 10995 | RSS: Main: 180891648 13:12:14 INFO - PID 10995 | 13:12:17 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50822/tests/kraken/driver.html?testName=json-parse-financial) 13:12:18 INFO - PID 10995 | RSS: Main: 180031488 13:12:18 INFO - PID 10995 | 13:12:19 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:12:20 INFO - PID 10995 | RSS: Main: 179818496 13:12:20 INFO - PID 10995 | 13:12:22 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:12:22 INFO - PID 10995 | RSS: Main: 179990528 13:12:22 INFO - PID 10995 | 13:12:24 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:12:25 INFO - PID 10995 | RSS: Main: 180084736 13:12:25 INFO - PID 10995 | 13:12:28 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:12:29 INFO - PID 10995 | RSS: Main: 179982336 13:12:29 INFO - PID 10995 | 13:12:32 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:32 INFO - PID 10995 | RSS: Main: 180666368 13:12:32 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | Cycle 1(1): loaded http://localhost:50822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50822/tests/kraken/driver.html?testName=ai-astar) 13:12:34 INFO - PID 10995 | RSS: Main: 181321728 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | __start_tp_report 13:12:34 INFO - PID 10995 | _x_x_mozilla_page_load 13:12:34 INFO - PID 10995 | _x_x_mozilla_page_load_details 13:12:34 INFO - PID 10995 | |i|pagename|runs| 13:12:34 INFO - PID 10995 | |0;ai-astar;101;108;111;108;109;108;110;109;108;109 13:12:34 INFO - PID 10995 | |1;audio-beat-detection;152;120;149;172;119;151;156;122;182;120 13:12:34 INFO - PID 10995 | |2;audio-dft;165;162;163;162;163;173;161;163;164;166 13:12:34 INFO - PID 10995 | |3;audio-fft;74;74;75;168;73;74;74;74;99;74 13:12:34 INFO - PID 10995 | |4;audio-oscillator;82;82;132;82;81;81;128;82;82;130 13:12:34 INFO - PID 10995 | |5;imaging-gaussian-blur;113;113;113;114;114;114;113;113;113;115 13:12:34 INFO - PID 10995 | |6;imaging-darkroom;150;152;151;150;151;149;149;150;150;152 13:12:34 INFO - PID 10995 | |7;imaging-desaturate;95;95;94;94;95;94;94;94;94;95 13:12:34 INFO - PID 10995 | |8;json-parse-financial;57;54;54;55;55;55;55;53;54;55 13:12:34 INFO - PID 10995 | |9;json-stringify-tinderbox;53;53;53;53;53;54;53;54;55;54 13:12:34 INFO - PID 10995 | |10;stanford-crypto-aes;79;76;77;77;76;77;77;77;76;77 13:12:34 INFO - PID 10995 | |11;stanford-crypto-ccm;134;125;134;135;125;140;126;123;124;183 13:12:34 INFO - PID 10995 | |12;stanford-crypto-pbkdf2;184;182;185;181;184;182;183;191;180;180 13:12:34 INFO - PID 10995 | |13;stanford-crypto-sha256-iterative;71;70;68;69;67;67;71;71;67;65 13:12:34 INFO - PID 10995 | __end_tp_report 13:12:34 INFO - PID 10995 | __start_cc_report 13:12:34 INFO - PID 10995 | _x_x_mozilla_cycle_collect,944 13:12:34 INFO - PID 10995 | __end_cc_report 13:12:34 INFO - PID 10995 | __startTimestamp1498162354666__endTimestamp 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | ------- Summary: start ------- 13:12:34 INFO - PID 10995 | Number of tests: 14 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.69 (2.5%) stddev-sans-first:1.05 13:12:34 INFO - PID 10995 | Values: 101.0 108.0 111.0 108.0 109.0 108.0 110.0 109.0 108.0 109.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:23.02 (15.2%) stddev-sans-first:24.25 13:12:34 INFO - PID 10995 | Values: 152.0 120.0 149.0 172.0 119.0 151.0 156.0 122.0 182.0 120.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.43 (2.1%) stddev-sans-first:3.62 13:12:34 INFO - PID 10995 | Values: 165.0 162.0 163.0 162.0 163.0 173.0 161.0 163.0 164.0 166.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#3] audio-fft Cycles:10 Average:85.90 Median:74.00 stddev:29.90 (40.4%) stddev-sans-first:31.40 13:12:34 INFO - PID 10995 | Values: 74.0 74.0 75.0 168.0 73.0 74.0 74.0 74.0 99.0 74.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:82.00 stddev:23.35 (28.5%) stddev-sans-first:24.19 13:12:34 INFO - PID 10995 | Values: 82.0 82.0 132.0 82.0 81.0 81.0 128.0 82.0 82.0 130.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:113.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 13:12:34 INFO - PID 10995 | Values: 113.0 113.0 113.0 114.0 114.0 114.0 113.0 113.0 113.0 115.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 13:12:34 INFO - PID 10995 | Values: 150.0 152.0 151.0 150.0 151.0 149.0 149.0 150.0 150.0 152.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:12:34 INFO - PID 10995 | Values: 95.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:0.73 13:12:34 INFO - PID 10995 | Values: 57.0 54.0 54.0 55.0 55.0 55.0 55.0 53.0 54.0 55.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:53.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 13:12:34 INFO - PID 10995 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 53.0 54.0 55.0 54.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:0.88 (1.1%) stddev-sans-first:0.50 13:12:34 INFO - PID 10995 | Values: 79.0 76.0 77.0 77.0 76.0 77.0 77.0 77.0 76.0 77.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:134.00 stddev:17.88 (13.3%) stddev-sans-first:18.96 13:12:34 INFO - PID 10995 | Values: 134.0 125.0 134.0 135.0 125.0 140.0 126.0 123.0 124.0 183.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:183.50 stddev:3.22 (1.8%) stddev-sans-first:3.41 13:12:34 INFO - PID 10995 | Values: 184.0 182.0 185.0 181.0 184.0 182.0 183.0 191.0 180.0 180.0 13:12:34 INFO - PID 10995 | 13:12:34 INFO - PID 10995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.50 stddev:2.12 (3.0%) stddev-sans-first:2.06 13:12:34 INFO - PID 10995 | Values: 71.0 70.0 68.0 69.0 67.0 67.0 71.0 71.0 67.0 65.0 13:12:34 INFO - PID 10995 | -------- Summary: end -------- 13:12:34 INFO - PID 10995 | 13:12:35 INFO - TEST-INFO | 10995: exit 0 13:12:35 INFO - TEST-OK | kraken | took 62130ms 13:12:35 INFO - SUITE-END | took 1178s 13:12:35 INFO - Completed test suite (00:19:39) 13:12:35 INFO - javascript benchmark 13:12:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8120.704989220659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.143008527527, 3006.6842981486943, 3006.774491913107, 3019.048999565137, 3027.7729170312227, 5893.086571581406, 5902.557308201881, 5945.286565612128, 6012.098185272212, 6072.757089716417, 5918.88162236755, 5926.96278151324, 6030.427109424609, 6042.184305118808, 6051.576389652726, 5523.7238138093135, 5524.14375771756, 5562.3047119110115, 5565.66606003639, 5632.831015069554, 5474.72626368682, 5475.945240547603, 5509.338879334486, 5514.834554963358, 5517.889642207154, 5532.861678458031, 5562.054450743343, 5599.7480113394995, 5620.775168993236, 5641.717914104278, 5607.130894711327, 5623.634463759842, 5634.239377684001, 5650.802221922254, 5658.660480371191, 5532.0, 5543.334799824047, 5564.554835613141, 5570.749316280737, 5608.859778505529, 5796.0, 5871.236739223917, 5962.403759624046, 6004.909926351108, 6054.273487181523, 6450.451711604473, 6474.773382931575, 6545.574537655038, 6547.181602299713, 6552.4758019358815, 6478.0, 6495.058216558573, 6505.284418713938, 6556.3443655634055, 6572.80281591553, 6090.6041107328765, 6125.632462052246, 6129.325774164839, 6142.600730952474, 6149.13912052313, 6447.2263328400895, 6561.934380656227, 6565.967170164118, 6572.014197870262, 6680.498962577826, 6401.007843784221, 6414.326495717883, 6420.871582568322, 6429.807105786834, 6434.581752186093, 6430.871382572323, 6522.249941256816, 6531.706073226716, 6533.379328963741, 6534.9673251634385, 6489.610623362613, 6507.544471887017, 6518.869622607522, 6533.8366540835905, 6536.084948107269, 6268.937310626927, 6496.7726129585235, 6509.218893732687, 6513.837154071091, 6539.542232043711, 5235.764390602432, 5241.68549887008, 5264.315638966987, 5273.762680679379, 5290.761915713802, 4521.525239849834, 4525.977370113194, 4550.408446901882, 4557.703749256288, 4600.240960241589, 5609.27079479665, 5616.6068375213345, 5617.634853734494, 5623.971880140573, 5649.265595472644, 6424.357564243538, 6476.481881449473, 6522.902156467657, 6523.608583485006, 6544.509161812883, 5442.836714898559, 5502.174673798882, 5532.834014979557, 5569.944300556943, 5584.804531841447, 5666.433356664383, 5683.54531637468, 5684.346300175533, 5709.971450142806, 5768.567357448208, 6249.312575616769, 6275.968620156961, 6288.465480434214, 6302.432781049728, 6332.841678958063, 6502.642354670538, 6547.181602299713, 6559.7376104955265, 6574.76988305407, 6588.0, 6298.653574053471, 6330.968345158245, 6342.365763423621, 6345.016522439029, 6364.4908407326375, 6208.72060757258, 6331.873362532631, 6336.746530138743, 6370.936290637034, 6393.648349340645, 6373.904391434039, 6412.2625898022325, 6482.546221764431, 6486.383793539606, 6496.512761542997, 6364.93635063662, 6380.457661098673, 6384.680765961591, 6398.71205795731, 6411.967940160456, 6358.078078678658, 6367.3314301997625, 6375.0, 6392.744290228339, 6400.45596124316, 6137.570370074052, 6143.416375444325, 6211.409916058148, 6241.21984751906, 6281.434670879643, 6267.843303917439, 6277.0, 6290.1508296381235, 6291.685415729286, 6305.873882522415, 6109.7387008107025, 6143.911070236141, 6175.042868355412, 6183.598066125687, 6189.659568723763], "value": 5913.778016533633, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.6668932393058, 834.0533494483761, 867.8047439326152, 873.3275377958972, 1167.3987896233436, 29721.40557188855, 30269.39461210777, 30403.543946840815, 40146.99999999993, 41463.0, 40608.39087413691, 40870.59129408705, 40984.18031639373, 41021.0, 41131.58868411315, 7538.396928245741, 7604.505707129047, 7652.846943061136, 7677.500962437452, 7681.692732290701, 7649.6940122395035, 7685.923140768577, 7695.345895598881, 7752.302292793675, 7768.689252429925, 7444.441666874979, 7718.073831140271, 7720.420968427362, 7731.188225236354, 7758.107817600991, 7610.086789585258, 7640.885386719204, 7648.770536883874, 7649.502782319131, 7697.8075548111465, 7579.810504737426, 7595.772126836204, 7623.695052197905, 7624.085109786805, 7649.885251721173, 37025.25949481022, 37048.07379815499, 37396.0, 37426.43860342097, 37433.62566374329, 3465.1337165708574, 3500.824958752052, 3501.229729459515, 3505.6494350564994, 3506.4389697648253, 29648.555271670728, 29681.0, 29686.257843553867, 29741.256468588243, 29863.0, 3751.681107105899, 3778.0, 3782.1868298315994, 3784.791836448994, 3842.500474938268, 165479.0, 169695.15152424158, 174901.0, 177539.0, 177887.0, 40174.397384039265, 46885.53114468812, 47055.52944470511, 47128.29307560389, 47687.52312476831, 50391.0, 50492.49507504951, 50496.49503504991, 50747.0, 50856.23715644268, 14748.115113093249, 14824.851751482563, 14825.77761333581, 14844.777328340084, 14852.183129927742, 12060.577879774166, 12086.69783255408, 12093.75812483763, 12102.878971210352, 12192.08559358034, 14215.0, 14222.573322800332, 14328.426862925366, 14400.639984000274, 14471.348789304506, 5625.943740562624, 5676.318841739017, 5751.396103409165, 5777.19119323295, 5832.766689332464, 971.9222462203007, 972.3960213867783, 975.6097560975667, 986.2701600815489, 999.5901680311038, 21866.0, 22198.223062192745, 22234.332970010924, 22561.66157507639, 23001.309960701205, 1049.1134990932649, 1057.5981127171626, 1077.8329358949375, 1078.3799315393524, 1095.1786160379716, 11749.647510574696, 11828.822567661491, 11851.88148118525, 11877.465514051888, 12036.63890083299, 214594.0, 219071.0, 219885.0, 220292.0, 220387.0, 49412.28232447178, 49779.50220497821, 49848.0, 49850.25224621633, 50082.0, 1453.0409929446514, 1455.2650911289732, 1471.4408524760736, 1489.3223583269587, 1492.9253537323307, 21413.571728565654, 21782.17821782161, 21818.890905546006, 22156.667649985586, 22878.199263025715, 35972.64027359798, 36277.45583816192, 36320.636793631726, 36391.09022274359, 36440.635593643725, 180528.0, 180833.09583451998, 181090.0, 181476.0, 181788.0, 29526.0, 29959.700402996565, 30071.0, 31221.687783122787, 32274.0, 40712.79643601881, 41777.37333940054, 41788.0, 41900.790496047324, 42162.36756448595, 29304.26739331534, 29660.55509167321, 30045.399092018473, 30247.0, 32039.199020024687, 29628.407431851672, 29702.55446168266, 29943.251418713837, 30756.0, 31323.84338078295, 32362.734608578114, 33099.0, 33155.0, 33507.66492335143, 33591.0, 27463.313417164733, 28549.42901142007, 29182.56226156567, 29870.701292986792, 30080.821603045013, 21574.676379854, 23581.174658887543, 23699.881500592386, 23707.40731481727, 24177.63733543963], "value": 16361.105342751953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.932568091829, 567.7447530756978, 571.608448212974, 574.6236215278993, 589.713988715473, 21411.785882141176, 22357.776422235773, 22374.216902408418, 22411.663825042637, 22781.658275125887, 24110.156144534943, 25643.74356256437, 25644.743552564516, 25767.355816104606, 25816.74183258167, 6392.264889537704, 6532.379423954717, 6532.869342613145, 6535.281119076898, 6538.542302038859, 6099.847503812396, 6449.064885591586, 6511.57674751142, 6518.739250429977, 6528.183977002875, 4065.6340929316357, 4727.692699974508, 6462.256840463337, 6503.512236582252, 6518.413342799147, 6434.260060093103, 6450.6452145132, 6482.513811464159, 6503.837404064889, 6504.544681872271, 6059.7273122709585, 6062.757489700407, 6066.96966515169, 6069.119977603267, 6075.513958883279, 28587.14238572846, 29145.271368215752, 29232.853835730897, 29451.558226626617, 29484.936054476195, 1959.480737604536, 1978.1395093134533, 1997.0314397517193, 2000.469875482998, 2011.3664195778283, 17753.644927101384, 18068.554515638716, 18222.90888545562, 18306.542336441562, 18408.171632276444, 2280.612295909683, 2286.5769832581027, 2319.0, 2328.8020518255967, 2361.7047869016374, 118550.0, 120322.1951670717, 121110.0, 122049.0, 122348.16477752841, 14210.0, 14320.641983950276, 14648.633784155481, 14813.925930370495, 15227.390904363701, 23850.16524421637, 23891.0, 23913.641295380585, 23914.760852391602, 23950.401239969142, 9570.56932438042, 9775.706728798148, 9793.657221997339, 10107.140893024176, 10111.595536178618, 8861.73414797557, 8941.910580894239, 9037.819243615091, 9114.13415725505, 9146.451212927113, 9063.229625481776, 9079.182873541413, 9157.130072643089, 9157.862632060524, 9239.122283383067, 2633.8288011279205, 2667.213172114231, 2702.0412648150245, 2789.8326100434037, 2798.9860050699617, 964.5563041001078, 972.9221662267001, 978.9167920726676, 1005.9597616095274, 1009.7980403919246, 19860.60278794416, 20116.99415029272, 22054.669179962315, 25532.0, 25601.0, 1039.5841663334727, 1053.5891002509027, 1059.6767985764416, 1064.8775390829999, 1068.2628985999636, 11285.21003529745, 11386.487608057658, 11422.714432139262, 11652.41737913101, 11711.531538738525, 527011.0, 538884.0, 543577.0, 545127.0, 558130.0, 105834.4708276469, 106413.0, 108165.0, 108278.45860770646, 109168.0, 1204.590439250659, 1216.3796463803524, 1233.6792433967232, 1249.7063190150307, 1260.590308149855, 19088.33190838314, 21105.522613416913, 21301.89349053245, 21388.465288367293, 21567.784322157204, 50071.49928500814, 50711.2393314108, 51296.74351628218, 51491.0, 53172.46827531675, 65174.69650606866, 65393.0, 65974.67012664906, 66082.66958665368, 66422.0, 12738.617841464771, 12883.484660613845, 12932.41804118798, 12962.0, 12964.416601252778, 16998.57503562421, 18633.254669813057, 18831.0, 19108.713369299192, 19339.323123690603, 14296.499622513162, 15332.846671533589, 15339.156346401054, 15418.074915505105, 15462.768058479356, 14018.369173387426, 14494.0, 14691.338889749773, 14789.852101478848, 15006.624834378792, 15765.0, 16021.279042443351, 16103.4701703338, 16107.275172617496, 16113.919430402773, 12110.576129835767, 12553.560625378068, 12709.491620335082, 12891.290978996245, 12938.029647776642, 15182.848171518144, 15593.986390884556, 15655.45205917833, 15661.138637375054, 15846.920765396098], "value": 11512.757130525206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.8520662727099, 1431.4703559682912, 1432.5201057645688, 1444.4222311075569, 1444.783282507623, 12526.436310366033, 12846.293453860035, 13049.282289474075, 13100.803487947689, 13149.47402103917, 12903.0, 13256.0, 13309.334533273322, 13351.1989280643, 13362.799558006638, 2601.752833480821, 2638.0766731643866, 2646.9735302647014, 2648.4305874237034, 2648.6291919131336, 2545.6945166580035, 2596.234110937278, 2611.986940065297, 2619.738026197384, 2624.252088154876, 2482.888270027844, 2502.186789293478, 2538.378097366148, 2538.6192071189284, 2550.41340491687, 2463.7659422354936, 2483.0316176691103, 2494.663220465232, 2500.7999360051244, 2501.687289088864, 2433.8174636902127, 2445.987770061156, 2458.0045081741746, 2470.876456177184, 2472.24596498068, 12953.546625868144, 13044.217346959213, 13095.083344165912, 13114.409851556702, 13135.277559734212, 6918.861622767567, 7247.275272472763, 7249.927500724978, 7251.274872512759, 7262.854742905165, 4011.5186177658575, 4212.368144778277, 4262.91474170518, 4291.828326866922, 4319.0713996490595, 1575.2989919485833, 1606.4698649445654, 1628.4137710424238, 1647.4316360855485, 1655.354411779407, 19094.23623055076, 19832.801671983383, 19863.304784332624, 20180.09189586472, 20213.797862021485, 5592.217089607459, 5718.914216286759, 5932.495737862244, 6151.3541078186145, 6222.502199824094, 14405.85594144066, 14450.421983120768, 14462.132272063709, 14470.565883023526, 14485.275736213147, 7023.543469674557, 7096.290370962863, 7124.394426473704, 7126.394256488256, 7135.82160445993, 6527.445167160749, 6768.627725475146, 6813.046173535709, 6833.0, 6834.521583489208, 4628.3288923105965, 4720.150372932905, 4786.545278198566, 4820.807167713252, 4884.242942343943, 1354.2010213973804, 1356.1117468058437, 1356.1930651262483, 1369.8630136986221, 1370.6504841265414, 918.4581097152578, 921.8985911549725, 941.5951141009294, 948.800751842107, 969.5830792759182, 7875.094364148082, 7889.02604125191, 7999.520028798291, 8037.397195210266, 8282.337413007066, 968.6464440479174, 986.9407835529892, 1013.2350075692805, 1023.7082431506984, 1037.0873631204643, 4990.775415106256, 5136.743162841843, 5289.788408463695, 5293.444188360167, 5386.784528618811, 17372.131393430278, 18007.18967646459, 18014.63970720578, 18037.458876233733, 18055.0, 17096.401625943283, 17178.39875604348, 17321.56696082608, 17353.30586776515, 17410.912945435193, 9795.412275263507, 10154.119679974448, 10352.171826253882, 10427.270091093551, 10640.787184256425, 7380.630968451448, 7547.207543208104, 7915.287624113857, 8355.702181899784, 8397.95801020991, 14741.484048058266, 14891.553253402415, 15062.472813451477, 15077.924610376878, 15135.470258540898, 14239.35922883452, 14526.491572794901, 14863.108213507225, 15247.847521524644, 15635.29641166173, 10039.598416063567, 10462.47687615601, 11110.944445277722, 11141.331520108819, 11234.887651123385, 12405.13164078542, 12539.498420063095, 12543.24740515572, 12559.811602826148, 12567.18313309632, 9919.40483570988, 10262.538185781508, 10366.948165259428, 10454.163666906781, 10499.107575856138, 9805.313628045968, 10053.949730251303, 10457.215708822021, 10464.267501275142, 10678.359298442118, 9017.774555636162, 9209.493477858781, 9214.723558293263, 9215.907840921505, 9224.815503690023, 6767.458603311822, 6901.792946211622, 6919.688614012281, 7016.649167541705, 7154.284571542804, 6855.965720171566, 6863.07348507965, 6935.479839012195, 7058.223595404399, 7136.3934065602925], "value": 6030.9031647425045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.45031114840225, 491.4741226887232, 497.780976370397, 510.35185314650397, 521.397785557681, 6110.908336374952, 6120.6021608595465, 6157.969210153954, 6165.907511387327, 6180.289266734327, 5857.912131318034, 6021.87956240876, 6056.515478761699, 6058.0917011141455, 6063.454289113979, 4920.163572192718, 4924.448798628429, 4928.876778080541, 4928.890999525114, 4940.493149589392, 4950.851474455772, 4980.2529620557025, 4983.975080124595, 4994.576545684481, 4997.5252351026775, 4681.74250416227, 4908.7300198489065, 4940.110780059588, 4943.283223932528, 4971.105201063807, 4864.743349569127, 4877.390326209206, 4881.389826271716, 4907.1657818171, 4912.238603016538, 4357.106793107437, 4375.2124617568825, 4381.123775244963, 4402.0, 4405.9118817623785, 5851.771128063112, 5853.619514731528, 5855.209546711182, 5904.586678932476, 5933.584649074566, 5582.469665381782, 5584.246126772915, 5584.425967380879, 5602.1596760485845, 5627.6904770237625, 6423.64669943153, 6428.774992875274, 6431.967840160816, 6437.388448097423, 6453.354664533556, 4796.760161991887, 4800.271902115236, 4805.831795887128, 4809.831655892062, 4840.636952228597, 6732.932670673328, 6751.982570370622, 6753.15585551806, 6771.864562708767, 6784.6607669616815, 4943.579795717333, 4949.8515044548, 4955.207166853286, 4958.603311735053, 4959.132151873408, 4956.132676781549, 5002.6482256887975, 5018.372703412074, 5018.673786203885, 5041.420236672756, 5598.3282006159525, 5604.131359639263, 5604.719764011783, 5607.887842243133, 5628.409017053233, 6413.711382987777, 6425.421712045938, 6458.58019228758, 6470.9029364559565, 6483.655950513074, 1624.5532478568489, 1703.173960629094, 1704.7442883567564, 1742.6407402226284, 1762.9206685699173, 1210.2496452199694, 1215.750771091924, 1216.5802798034663, 1222.443788076423, 1247.9500819967282, 5435.42927992563, 5502.669839809624, 5525.806596769094, 5569.777208911679, 5687.488126068673, 6542.672866356663, 6567.0, 6600.765624843888, 6623.4038936495945, 6662.766803161866, 5607.355219107612, 5639.605227634026, 5649.6327738696855, 5657.858553536194, 5701.116326969326, 3499.16020155166, 3509.8063710181136, 3510.140015696171, 3511.543499345069, 3531.2760884018717, 6262.843428914313, 6362.872742545123, 6367.840803979938, 6416.935830641633, 6440.61356318613, 6740.056392105109, 6743.426808721314, 6746.898796518056, 6757.864842703217, 6776.9322306777285, 6417.807465776034, 6424.26120996082, 6430.067640192053, 6432.903506447407, 6454.935450645527, 6562.934370656232, 6569.835754105994, 6584.0, 6594.0, 6609.570377925419, 6482.837929051623, 6537.967310163419, 6552.312007239362, 6552.410283074356, 6560.212774467094, 6202.534809889186, 6421.325760795049, 6423.197100362455, 6429.292777794532, 6438.871222575616, 4787.329773831736, 4847.5394837490385, 4910.263460480956, 4917.655764096479, 4919.385076865392, 6522.608643481406, 6535.3464653534265, 6569.178852643419, 6578.309277525982, 6612.140421745143, 6315.810525684236, 6334.303226644974, 6370.757702248017, 6384.648844313421, 6392.93607063942, 6378.330275321025, 6380.521460890359, 6388.329225431263, 6390.6260154067095, 6406.412409050947, 6258.342873998165, 6270.843228919131, 6310.305866354789, 6311.526635502264, 6344.746210151542, 6373.5857169283845, 6417.294097649348, 6439.871202575829, 6444.323346048597, 6445.709943052668, 6170.938290617216, 6200.0, 6217.4715149212825, 6217.4715149212825, 6223.533235007302], "value": 4962.6392557007475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.0695131879277, 857.8841856349393, 861.3410740783302, 862.710991817741, 869.200335691164, 16498.340066397344, 16847.83152168478, 16860.15699215039, 16878.66242675149, 16952.23714932828, 16073.357065717386, 16232.83767162328, 18428.631427371445, 18873.81126188738, 20391.49021274465, 1041.604190407644, 1085.045160258971, 1086.3427626286102, 1086.9891301087007, 1087.081416203311, 1073.441810258665, 1073.7154654016654, 1074.409075008746, 1076.88154303027, 1078.573963284502, 1109.589451902797, 1111.5998240633367, 1117.2235296468957, 1133.9716507087305, 1136.5056200552744, 1053.852460655505, 1085.0, 1091.579741799405, 1098.9890101098968, 1112.8386383974319, 785.6935795039939, 790.7785819970418, 792.8731402975554, 794.4438892775081, 794.8410317936435, 16996.40512582066, 17014.40449584271, 17197.484075477754, 17214.31142754288, 17255.65488690219, 18913.33803316891, 19607.019649017493, 19632.312869049514, 19740.50648733779, 19778.0, 14862.108273503625, 15369.231538423033, 15452.227388630523, 15471.767923481157, 15581.454649087227, 3577.0878426001464, 3598.712103031751, 3611.512445819807, 3624.2751449710163, 3633.291508155911, 90197.54901225517, 92254.07745922521, 92508.53745731295, 93937.530312348, 96164.0, 14551.272436378138, 14764.335604897806, 14852.2573871306, 14860.62848428798, 14905.403783848742, 24356.512869742506, 25905.093321734024, 26252.0, 26276.474470510482, 26288.211353659422, 7905.960470197727, 7954.284114429729, 7955.2840244378285, 7972.3622110231045, 7983.2415920487465, 3982.5021872265966, 3999.5400528939545, 4066.1461093170174, 4127.09203975125, 4140.0891803803115, 4647.117047760915, 4726.385569875894, 4745.881352966204, 4759.190937540627, 4775.808967641325, 900.1718419054486, 913.5614904845711, 926.935114541989, 933.4912472702393, 934.3973137326386, 682.1779755394738, 684.6302996381899, 684.9246582875879, 702.0767690486994, 708.6563016936782, 11450.770984580427, 11532.538698452136, 11697.883021169679, 11855.881441185651, 12008.579699710468, 614.6066517428849, 681.4786688183543, 700.7792545348301, 705.4109818301775, 714.1002337055347, 5260.92108618371, 5386.622936394493, 5603.831885043455, 5669.092945128759, 5750.5112065474905, 87500.0, 87976.0, 91647.54176229076, 94002.0, 95022.52488737651, 77472.0, 79593.0, 80630.19369806227, 82288.0, 83385.16614833774, 65318.673406633614, 65556.0, 65794.34205657979, 67397.66301168561, 69163.0, 11220.831687524857, 13024.47902083906, 13175.538856140372, 13342.733145336844, 13460.125091868997, 30490.847545762128, 32972.0, 33115.33769324648, 33289.667103328655, 33714.98855034353, 56913.0, 59954.40045599663, 60028.69985650044, 60715.39284607097, 62353.0, 17987.0, 18187.54531136732, 18301.99339036366, 18396.080195990413, 18508.81491185071, 19779.20883164715, 20372.89813550923, 20956.47608809792, 21150.0, 21298.0, 18370.448886533424, 18878.811211888256, 18960.715589265896, 19053.237870485027, 19170.90414547974, 17199.656006880043, 18087.276508939496, 18148.364807231683, 18502.537436564195, 19084.809151908303, 17547.21037553339, 17611.64776704433, 17747.82252177462, 18036.917784932946, 18705.25178992825, 11827.940860295643, 12445.191062580903, 12584.370781461073, 13029.804552931902, 13453.663658408617, 13877.79183312231, 14064.507742228972, 14502.564923052325, 14742.63143421423, 15208.923955380153], "value": 8601.684413692921, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 108.0, 111.0, 108.0, 109.0, 108.0, 110.0, 109.0, 108.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 149.0, 172.0, 119.0, 151.0, 156.0, 122.0, 182.0, 120.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 162.0, 163.0, 173.0, 161.0, 163.0, 164.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 168.0, 73.0, 74.0, 74.0, 74.0, 99.0, 74.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 132.0, 82.0, 81.0, 81.0, 128.0, 82.0, 82.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 150.0, 151.0, 149.0, 149.0, 150.0, 150.0, 152.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 55.0, 55.0, 55.0, 55.0, 53.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 53.0, 54.0, 55.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 77.0, 76.0, 77.0, 77.0, 77.0, 76.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 125.0, 134.0, 135.0, 125.0, 140.0, 126.0, 123.0, 124.0, 183.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 181.0, 184.0, 182.0, 183.0, 191.0, 180.0, 180.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 68.0, 69.0, 67.0, 67.0, 71.0, 71.0, 67.0, 65.0], "value": 68.6, "unit": "score"}]}]} 13:12:35 INFO - Return code: 0 13:12:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:12:36 INFO - # TBPL SUCCESS # 13:12:36 INFO - Running post-action listener: _resource_record_post_action 13:12:36 INFO - [mozharness: 2017-06-22 20:12:36.015904Z] Finished run-tests step (success) 13:12:36 INFO - Running post-run listener: _resource_record_post_run 13:12:36 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 340619264; Read time: 388; Write time: 319792 13:12:36 INFO - TinderboxPrint: CPU usage
13.2% 13:12:36 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 388 13:12:36 INFO - TinderboxPrint: I/O write bytes / time
340,619,264 / 319,792 13:12:36 INFO - TinderboxPrint: CPU idle
8,283.6 (86.8%) 13:12:36 INFO - TinderboxPrint: CPU user
1,209.6 (12.7%) 13:12:36 INFO - TinderboxPrint: Swap in / out
0 / 0 13:12:36 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13766656; Read time: 0; Write time: 2880 13:12:36 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:12:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326852608; Read time: 380; Write time: 316912 13:12:36 INFO - Running post-run listener: _upload_blobber_files 13:12:36 INFO - Blob upload gear active. 13:12:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:12:36 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 13:12:36 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'] 13:12:36 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 13:12:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:12:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:12:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:37 INFO - (blobuploader) - INFO - Done attempting. 13:12:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:44 INFO - (blobuploader) - INFO - Done attempting. 13:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:45 INFO - (blobuploader) - INFO - Done attempting. 13:12:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:12:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:12:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:12:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:12:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:12:46 INFO - (blobuploader) - INFO - Done attempting. 13:12:46 INFO - (blobuploader) - INFO - Iteration through files over. 13:12:46 INFO - Return code: 0 13:12:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:12:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:12:46 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8c0439ba749d7701a5627949ec0ff4791b9dad7c0b017ecc9ae399415402f8bd4fd8b78cd8028b0379fae1a283e93503f1694273afd958575452b768e8d429f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a820ddbf5a123f604e88680a2d264cf9fbe2995d10edc30266c03e6ce7f4760daae528e66b1266f1faf8ed192fc76e35ccf71e3c258915bbc9f97ca8412e9647", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0d595c734c7e348df5d3d795c54f97c0154c4a9fc4a4e0a60cec0f43bde32b8df9a448f5c64686c6dd5966c6c166a3f2532a4e3bfaa3a600376d6d2d5b9af0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d1187640577c32922cd0263b979c2d1c88da84b37472ddbc65510475a2a7938d0d552fd6b3c0968629689d530cc8885bab7f629d06fe46d2937091a40a36b7"} 13:12:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:12:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:12:46 INFO - Contents: 13:12:46 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8c0439ba749d7701a5627949ec0ff4791b9dad7c0b017ecc9ae399415402f8bd4fd8b78cd8028b0379fae1a283e93503f1694273afd958575452b768e8d429f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a820ddbf5a123f604e88680a2d264cf9fbe2995d10edc30266c03e6ce7f4760daae528e66b1266f1faf8ed192fc76e35ccf71e3c258915bbc9f97ca8412e9647", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0d595c734c7e348df5d3d795c54f97c0154c4a9fc4a4e0a60cec0f43bde32b8df9a448f5c64686c6dd5966c6c166a3f2532a4e3bfaa3a600376d6d2d5b9af0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d1187640577c32922cd0263b979c2d1c88da84b37472ddbc65510475a2a7938d0d552fd6b3c0968629689d530cc8885bab7f629d06fe46d2937091a40a36b7"} 13:12:46 INFO - Running post-run listener: copy_logs_to_upload_dir 13:12:46 INFO - Copying logs to upload dir... 13:12:46 INFO - mkdir: /builds/slave/test/build/upload/logs 13:12:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.234123 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-22 13:12:45.378137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 13:12:45.383240) ========= 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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 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/f8c0439ba749d7701a5627949ec0ff4791b9dad7c0b017ecc9ae399415402f8bd4fd8b78cd8028b0379fae1a283e93503f1694273afd958575452b768e8d429f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a820ddbf5a123f604e88680a2d264cf9fbe2995d10edc30266c03e6ce7f4760daae528e66b1266f1faf8ed192fc76e35ccf71e3c258915bbc9f97ca8412e9647", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0d595c734c7e348df5d3d795c54f97c0154c4a9fc4a4e0a60cec0f43bde32b8df9a448f5c64686c6dd5966c6c166a3f2532a4e3bfaa3a600376d6d2d5b9af0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d1187640577c32922cd0263b979c2d1c88da84b37472ddbc65510475a2a7938d0d552fd6b3c0968629689d530cc8885bab7f629d06fe46d2937091a40a36b7"} build_url:https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/OW6PbA6IThqTkQNyK__M-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f8c0439ba749d7701a5627949ec0ff4791b9dad7c0b017ecc9ae399415402f8bd4fd8b78cd8028b0379fae1a283e93503f1694273afd958575452b768e8d429f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a820ddbf5a123f604e88680a2d264cf9fbe2995d10edc30266c03e6ce7f4760daae528e66b1266f1faf8ed192fc76e35ccf71e3c258915bbc9f97ca8412e9647", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd0d595c734c7e348df5d3d795c54f97c0154c4a9fc4a4e0a60cec0f43bde32b8df9a448f5c64686c6dd5966c6c166a3f2532a4e3bfaa3a600376d6d2d5b9af0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/05d1187640577c32922cd0263b979c2d1c88da84b37472ddbc65510475a2a7938d0d552fd6b3c0968629689d530cc8885bab7f629d06fe46d2937091a40a36b7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 13:12:45.407288) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 13:12:45.407608) ========= 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=5c37b704b588aaa989324530000001d0-1498151954.95547-1863577606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 13:12:45.490396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 13:12:45.490699) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 13:12:45.494004) ========= ========= Total master_lag: 0.29 =========