builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1499255342.43 results: success (0) revision: 211d4dd61025c0a40caea7a54c9066e051bdde8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:02.434154) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:02.434546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:02.435081) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:02.476761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 04:49:02.477028) ========= 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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-05 04:49:02-- 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% 38.5K=0.3s 2017-07-05 04:49:04 (38.5 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.654386 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 04:49:04.168062) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:04.168372) ========= 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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015508 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:04.220113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 04:49:04.220421) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 211d4dd61025c0a40caea7a54c9066e051bdde8c --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 211d4dd61025c0a40caea7a54c9066e051bdde8c --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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-05 04:49:04,297 truncating revision to first 12 chars 2017-07-05 04:49:04,297 Setting DEBUG logging. 2017-07-05 04:49:04,297 attempt 1/10 2017-07-05 04:49:04,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/211d4dd61025?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-05 04:49:05,049 unpacking tar archive at: mozilla-central-211d4dd61025/testing/mozharness/ program finished with exit code 0 elapsedTime=1.089004 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 04:49:05.344152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:05.344430) ========= script_repo_revision: 211d4dd61025c0a40caea7a54c9066e051bdde8c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:05.347815) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:05.348077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-05 04:49:05.357983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-07-05 04:49:05.358268) ========= /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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:05 INFO - MultiFileLogger online at 20170705 04:49:05 in /builds/slave/test 04:49:05 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 04:49:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:05 INFO - {'append_to_log': False, 04:49:05 INFO - 'base_work_dir': '/builds/slave/test', 04:49:05 INFO - 'blob_upload_branch': 'Firefox', 04:49:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:05 INFO - 'branch': 'Firefox', 04:49:05 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:05 INFO - 'code_coverage': False, 04:49:05 INFO - 'config_files': ('talos/linux_config.py',), 04:49:05 INFO - 'default_actions': ('clobber', 04:49:05 INFO - 'read-buildbot-config', 04:49:05 INFO - 'download-and-extract', 04:49:05 INFO - 'populate-webroot', 04:49:05 INFO - 'create-virtualenv', 04:49:05 INFO - 'install', 04:49:05 INFO - 'setup-mitmproxy', 04:49:05 INFO - 'run-tests'), 04:49:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:05 INFO - 'disable_ccov_upload': False, 04:49:05 INFO - 'download_minidump_stackwalk': True, 04:49:05 INFO - 'download_symbols': 'ondemand', 04:49:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:05 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:05 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:05 INFO - 'gecko_profile': False, 04:49:05 INFO - 'gecko_profile_interval': 0, 04:49:05 INFO - 'installer_path': 'installer.exe', 04:49:05 INFO - 'log_level': 'info', 04:49:05 INFO - 'log_name': 'talos', 04:49:05 INFO - 'log_to_console': True, 04:49:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:05 INFO - 'opt_config_files': (), 04:49:05 INFO - 'pip_index': False, 04:49:05 INFO - 'suite': 'dromaeojs-e10s', 04:49:05 INFO - 'system_bits': '32', 04:49:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:05 INFO - 'title': 'talos-linux64-ix-009', 04:49:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:05 INFO - 'use_talos_json': True, 04:49:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:05 INFO - 'work_dir': 'build'} 04:49:05 INFO - [mozharness: 2017-07-05 11:49:05.628460Z] Running clobber step. 04:49:05 INFO - Running pre-action listener: _resource_record_pre_action 04:49:05 INFO - Running main action method: clobber 04:49:05 INFO - rmtree: /builds/slave/test/build 04:49:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:06 INFO - Running post-action listener: _resource_record_post_action 04:49:06 INFO - [mozharness: 2017-07-05 11:49:06.622066Z] Finished clobber step (success) 04:49:06 INFO - [mozharness: 2017-07-05 11:49:06.622170Z] Running read-buildbot-config step. 04:49:06 INFO - Running pre-action listener: _resource_record_pre_action 04:49:06 INFO - Running main action method: read_buildbot_config 04:49:06 INFO - Using buildbot properties: 04:49:06 INFO - { 04:49:06 INFO - "project": "", 04:49:06 INFO - "product": "firefox", 04:49:06 INFO - "who": "cbook@mozilla.com", 04:49:06 INFO - "installer_path": "public/build/target.tar.bz2", 04:49:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:49:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:49:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:49:06 INFO - "stage_platform": "linux64-stylosequential", 04:49:06 INFO - "basedir": "/builds/slave/test", 04:49:06 INFO - "buildnumber": 88, 04:49:06 INFO - "platform": "ubuntu64_hw_styloseq", 04:49:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:49:06 INFO - "slavebuilddir": "test", 04:49:06 INFO - "taskId": "TmFcObHtSraEE1sp8zA-Bg", 04:49:06 INFO - "branch": "mozilla-central", 04:49:06 INFO - "script_repo_revision": "production", 04:49:06 INFO - "revision": "211d4dd61025c0a40caea7a54c9066e051bdde8c", 04:49:06 INFO - "slavename": "talos-linux64-ix-009", 04:49:06 INFO - "repo_path": "mozilla-central" 04:49:06 INFO - } 04:49:06 INFO - Finding installer, test and symbols from parent task. 04:49:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TmFcObHtSraEE1sp8zA-Bg'}, attempt #1 04:49:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TmFcObHtSraEE1sp8zA-Bg'}, attempt #1 04:49:09 INFO - Task dependencies: LLj2jiK5RPiWxDTqXrBl0A 04:49:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A'}, attempt #1 04:49:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 04:49:09 INFO - Set test_url: https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/test_packages.json 04:49:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.crashreporter-symbols.zip 04:49:09 INFO - Running post-action listener: _resource_record_post_action 04:49:09 INFO - [mozharness: 2017-07-05 11:49:09.849259Z] Finished read-buildbot-config step (success) 04:49:09 INFO - [mozharness: 2017-07-05 11:49:09.849484Z] Running download-and-extract step. 04:49:09 INFO - Running pre-action listener: _resource_record_pre_action 04:49:09 INFO - Running main action method: download_and_extract 04:49:09 INFO - mkdir: /builds/slave/test/build/tests 04:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:09 INFO - trying https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.test_packages.json 04:49:09 INFO - Downloading https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:49:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:49:11 INFO - Downloaded 989 bytes. 04:49:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:49:11 INFO - Using the following test package requirements: 04:49:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:49:11 INFO - u'common': [u'target.common.tests.zip'], 04:49:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:49:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:49:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:49:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:49:11 INFO - u'mozbase': [u'target.common.tests.zip'], 04:49:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:49:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:49:11 INFO - u'web-platform': [u'target.common.tests.zip', 04:49:11 INFO - u'target.web-platform.tests.tar.gz'], 04:49:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:49:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:49:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip 04:49:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:49:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip into memory 04:49:13 INFO - Content-Length response header: 67426378 04:49:13 INFO - Bytes received: 67426378 04:49:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:49:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip 04:49:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:49:24 INFO - Fetch https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.common.tests.zip into memory 04:49:27 INFO - Content-Length response header: 67426378 04:49:27 INFO - Bytes received: 67426378 04:49:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.talos.tests.zip 04:49:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:49:40 INFO - Fetch https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.talos.tests.zip into memory 04:49:41 INFO - Content-Length response header: 14472293 04:49:41 INFO - Bytes received: 14472293 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:49:42 INFO - trying https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 04:49:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:49:44 INFO - Downloaded 62071214 bytes. 04:49:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 04:49:44 INFO - mkdir: /builds/slave/test/properties 04:49:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:44 INFO - Contents: 04:49:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 04:49:44 INFO - Running post-action listener: _resource_record_post_action 04:49:44 INFO - Running post-action listener: set_extra_try_arguments 04:49:44 INFO - [mozharness: 2017-07-05 11:49:44.560165Z] Finished download-and-extract step (success) 04:49:44 INFO - [mozharness: 2017-07-05 11:49:44.560263Z] Running populate-webroot step. 04:49:44 INFO - Running pre-action listener: _resource_record_pre_action 04:49:44 INFO - Running main action method: populate_webroot 04:49:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:44 INFO - '--tppagecycles', 04:49:44 INFO - '7'], 04:49:44 INFO - 'tests': ['tsvgm']}}, 04:49:44 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:44 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['damp', 'tps']}, 04:49:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'tests': ['damp', 'tps']}, 04:49:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['dromaeo_dom']}, 04:49:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:49:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:49:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:49:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_many_windows', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_many_windows', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_many_windows', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['a11yr', 04:49:44 INFO - 'ts_paint', 04:49:44 INFO - 'tpaint', 04:49:44 INFO - 'sessionrestore', 04:49:44 INFO - 'sessionrestore_no_auto_restore', 04:49:44 INFO - 'tabpaint']}, 04:49:44 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 04:49:44 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:49:44 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:49:44 INFO - 'talos_options': ['--mitmproxy', 04:49:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:49:44 INFO - '--firstNonBlankPaint'], 04:49:44 INFO - 'tests': ['quantum_pageload_google', 04:49:44 INFO - 'quantum_pageload_youtube', 04:49:44 INFO - 'quantum_pageload_amazon', 04:49:44 INFO - 'quantum_pageload_facebook']}, 04:49:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['tsvgx', 04:49:44 INFO - 'tsvgr_opacity', 04:49:44 INFO - 'tart', 04:49:44 INFO - 'tscrollx', 04:49:44 INFO - 'cart', 04:49:44 INFO - 'tsvg_static']}, 04:49:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:44 INFO - 'tsvgr_opacity', 04:49:44 INFO - 'tart', 04:49:44 INFO - 'tscrollx', 04:49:44 INFO - 'cart', 04:49:44 INFO - 'tsvg_static']}, 04:49:44 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'talos_options': ['--disable-e10s'], 04:49:44 INFO - 'tests': ['tp5o']}, 04:49:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:49:44 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'talos_options': ['--disable-e10s', 04:49:44 INFO - '--xperf_path', 04:49:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:44 INFO - 'tests': ['tp5n']}, 04:49:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:49:44 INFO - 'talos_options': ['--xperf_path', 04:49:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:44 INFO - 'tests': ['tp5n']}}, 04:49:44 INFO - 'talos.zip': {'path': '', 04:49:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:44 INFO - Running post-action listener: _resource_record_post_action 04:49:44 INFO - [mozharness: 2017-07-05 11:49:44.575480Z] Finished populate-webroot step (success) 04:49:44 INFO - [mozharness: 2017-07-05 11:49:44.575571Z] Running create-virtualenv step. 04:49:44 INFO - Running pre-action listener: _resource_record_pre_action 04:49:44 INFO - Running main action method: create_virtualenv 04:49:44 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:44 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 04:49:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:49:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:44 INFO - Using real prefix '/usr' 04:49:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:47 INFO - Installing pip.................done. 04:49:47 INFO - Return code: 0 04:49:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:47 INFO - Reading from file tmpfile_stdout 04:49:47 INFO - Output received: 04:49:47 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) 04:49:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:47 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')]} 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:47 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')]} 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:47 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:49:47 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 04:49:47 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 04:49:47 INFO - Using env: {'DISPLAY': ':0', 04:49:47 INFO - 'HOME': '/home/cltbld', 04:49:47 INFO - 'LANG': 'en_US.UTF-8', 04:49:47 INFO - 'LANGUAGE': 'en_US:en', 04:49:47 INFO - 'LOGNAME': 'cltbld', 04:49:47 INFO - 'MAIL': '/var/mail/cltbld', 04:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:47 INFO - 'MOZ_NO_REMOTE': '1', 04:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:47 INFO - 'NO_EM_RESTART': '1', 04:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:47 INFO - 'PWD': '/builds/slave/test', 04:49:47 INFO - 'SHELL': '/bin/bash', 04:49:47 INFO - 'SHLVL': '1', 04:49:47 INFO - 'TERM': 'linux', 04:49:47 INFO - 'TMOUT': '86400', 04:49:47 INFO - 'USER': 'cltbld', 04:49:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:47 INFO - '_': '/tools/buildbot/bin/python'} 04:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:48 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 04:49:48 INFO - Cleaning up... 04:49:48 INFO - Return code: 0 04:49:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49: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')]} 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:49:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:49:48 INFO - Using env: {'DISPLAY': ':0', 04:49:48 INFO - 'HOME': '/home/cltbld', 04:49:48 INFO - 'LANG': 'en_US.UTF-8', 04:49:48 INFO - 'LANGUAGE': 'en_US:en', 04:49:48 INFO - 'LOGNAME': 'cltbld', 04:49:48 INFO - 'MAIL': '/var/mail/cltbld', 04:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:48 INFO - 'MOZ_NO_REMOTE': '1', 04:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:48 INFO - 'NO_EM_RESTART': '1', 04:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:48 INFO - 'PWD': '/builds/slave/test', 04:49:48 INFO - 'SHELL': '/bin/bash', 04:49:48 INFO - 'SHLVL': '1', 04:49:48 INFO - 'TERM': 'linux', 04:49:48 INFO - 'TMOUT': '86400', 04:49:48 INFO - 'USER': 'cltbld', 04:49:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:48 INFO - '_': '/tools/buildbot/bin/python'} 04:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:48 INFO - Downloading/unpacking psutil>=3.1.1 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:55 INFO - Installing collected packages: psutil 04:49:55 INFO - Running setup.py install for psutil 04:49:55 INFO - building 'psutil._psutil_linux' extension 04:49:55 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 04:49:56 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 04:49:56 INFO - building 'psutil._psutil_posix' extension 04:49:56 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 04:49:56 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 04:49:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:56 INFO - Successfully installed psutil 04:49:56 INFO - Cleaning up... 04:49:56 INFO - Return code: 0 04:49:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49: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')]} 04:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:56 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:49:56 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 04:49:56 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 04:49:56 INFO - Using env: {'DISPLAY': ':0', 04:49:56 INFO - 'HOME': '/home/cltbld', 04:49:56 INFO - 'LANG': 'en_US.UTF-8', 04:49:56 INFO - 'LANGUAGE': 'en_US:en', 04:49:56 INFO - 'LOGNAME': 'cltbld', 04:49:56 INFO - 'MAIL': '/var/mail/cltbld', 04:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:56 INFO - 'MOZ_NO_REMOTE': '1', 04:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:56 INFO - 'NO_EM_RESTART': '1', 04:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:56 INFO - 'PWD': '/builds/slave/test', 04:49:56 INFO - 'SHELL': '/bin/bash', 04:49:56 INFO - 'SHLVL': '1', 04:49:56 INFO - 'TERM': 'linux', 04:49:56 INFO - 'TMOUT': '86400', 04:49:56 INFO - 'USER': 'cltbld', 04:49:56 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:56 INFO - '_': '/tools/buildbot/bin/python'} 04:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:57 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 04:49:57 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 04:49:57 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 04:49:57 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 04:49:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:58 INFO - Installing collected packages: mozsystemmonitor 04:49:58 INFO - Running setup.py install for mozsystemmonitor 04:49:58 INFO - Successfully installed mozsystemmonitor 04:49:58 INFO - Cleaning up... 04:49:58 INFO - Return code: 0 04:49:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:58 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')]} 04:49:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:58 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')]} 04:49:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:59 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:49:59 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 04:49:59 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 04:49:59 INFO - Using env: {'DISPLAY': ':0', 04:49:59 INFO - 'HOME': '/home/cltbld', 04:49:59 INFO - 'LANG': 'en_US.UTF-8', 04:49:59 INFO - 'LANGUAGE': 'en_US:en', 04:49:59 INFO - 'LOGNAME': 'cltbld', 04:49:59 INFO - 'MAIL': '/var/mail/cltbld', 04:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:59 INFO - 'MOZ_NO_REMOTE': '1', 04:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:59 INFO - 'NO_EM_RESTART': '1', 04:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:59 INFO - 'PWD': '/builds/slave/test', 04:49:59 INFO - 'SHELL': '/bin/bash', 04:49:59 INFO - 'SHLVL': '1', 04:49:59 INFO - 'TERM': 'linux', 04:49:59 INFO - 'TMOUT': '86400', 04:49:59 INFO - 'USER': 'cltbld', 04:49:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:59 INFO - '_': '/tools/buildbot/bin/python'} 04:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:00 INFO - warning: no files found matching '*.txt' 04:50:00 INFO - no previously-included directories found matching 'build' 04:50:00 INFO - no previously-included directories found matching 'dist' 04:50:00 INFO - no previously-included directories found matching '.git*' 04:50:00 INFO - Installing collected packages: jsonschema, functools32 04:50:00 INFO - Running setup.py install for functools32 04:50:00 INFO - warning: no files found matching '*.txt' 04:50:00 INFO - no previously-included directories found matching 'build' 04:50:00 INFO - no previously-included directories found matching 'dist' 04:50:00 INFO - no previously-included directories found matching '.git*' 04:50:00 INFO - Successfully installed jsonschema functools32 04:50:00 INFO - Cleaning up... 04:50:00 INFO - Return code: 0 04:50:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:01 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50:01 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 04:50:01 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 04:50:01 INFO - Using env: {'DISPLAY': ':0', 04:50:01 INFO - 'HOME': '/home/cltbld', 04:50:01 INFO - 'LANG': 'en_US.UTF-8', 04:50:01 INFO - 'LANGUAGE': 'en_US:en', 04:50:01 INFO - 'LOGNAME': 'cltbld', 04:50:01 INFO - 'MAIL': '/var/mail/cltbld', 04:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:01 INFO - 'MOZ_NO_REMOTE': '1', 04:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:01 INFO - 'NO_EM_RESTART': '1', 04:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:01 INFO - 'PWD': '/builds/slave/test', 04:50:01 INFO - 'SHELL': '/bin/bash', 04:50:01 INFO - 'SHLVL': '1', 04:50:01 INFO - 'TERM': 'linux', 04:50:01 INFO - 'TMOUT': '86400', 04:50:01 INFO - 'USER': 'cltbld', 04:50:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:01 INFO - '_': '/tools/buildbot/bin/python'} 04:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:50:01 INFO - Cleaning up... 04:50:01 INFO - Return code: 0 04:50:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:50:01 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')]} 04:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:01 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')]} 04:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:01 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50:01 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 04:50:01 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 04:50:01 INFO - Using env: {'DISPLAY': ':0', 04:50:01 INFO - 'HOME': '/home/cltbld', 04:50:01 INFO - 'LANG': 'en_US.UTF-8', 04:50:01 INFO - 'LANGUAGE': 'en_US:en', 04:50:01 INFO - 'LOGNAME': 'cltbld', 04:50:01 INFO - 'MAIL': '/var/mail/cltbld', 04:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:01 INFO - 'MOZ_NO_REMOTE': '1', 04:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:01 INFO - 'NO_EM_RESTART': '1', 04:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:01 INFO - 'PWD': '/builds/slave/test', 04:50:01 INFO - 'SHELL': '/bin/bash', 04:50:01 INFO - 'SHLVL': '1', 04:50:01 INFO - 'TERM': 'linux', 04:50:01 INFO - 'TMOUT': '86400', 04:50:01 INFO - 'USER': 'cltbld', 04:50:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:01 INFO - '_': '/tools/buildbot/bin/python'} 04:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:50:01 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 04:50:01 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 04:50:01 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 04:50:01 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 04:50:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50:05 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 04:50:05 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 04:50:05 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 04:50:05 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 04:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:50:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50:08 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 04:50:08 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 04:50:08 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 04:50:08 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 04:50:09 INFO - Downloading docopt-0.6.1.tar.gz 04:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:09 INFO - Running setup.py install for blobuploader 04:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:50:09 INFO - Running setup.py install for requests 04:50:09 INFO - Running setup.py install for docopt 04:50:09 INFO - Successfully installed blobuploader requests docopt 04:50:09 INFO - Cleaning up... 04:50:09 INFO - Return code: 0 04:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:09 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50:09 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 04:50:09 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 04:50:09 INFO - Using env: {'DISPLAY': ':0', 04:50:09 INFO - 'HOME': '/home/cltbld', 04:50:09 INFO - 'LANG': 'en_US.UTF-8', 04:50:09 INFO - 'LANGUAGE': 'en_US:en', 04:50:09 INFO - 'LOGNAME': 'cltbld', 04:50:09 INFO - 'MAIL': '/var/mail/cltbld', 04:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:09 INFO - 'MOZ_NO_REMOTE': '1', 04:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:09 INFO - 'NO_EM_RESTART': '1', 04:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:09 INFO - 'PWD': '/builds/slave/test', 04:50:09 INFO - 'SHELL': '/bin/bash', 04:50:09 INFO - 'SHLVL': '1', 04:50:09 INFO - 'TERM': 'linux', 04:50:09 INFO - 'TMOUT': '86400', 04:50:09 INFO - 'USER': 'cltbld', 04:50:09 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:09 INFO - '_': '/tools/buildbot/bin/python'} 04:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:10 INFO - Running setup.py (path:/tmp/pip-xDhKEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:10 INFO - Running setup.py (path:/tmp/pip-DRtc2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:10 INFO - Running setup.py (path:/tmp/pip-OrjukS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:10 INFO - Running setup.py (path:/tmp/pip-grkEj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:10 INFO - Running setup.py (path:/tmp/pip-YxOnBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:10 INFO - Running setup.py (path:/tmp/pip-KLM3fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:10 INFO - Running setup.py (path:/tmp/pip-CHIVgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:10 INFO - Running setup.py (path:/tmp/pip-pGSKuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:10 INFO - Running setup.py (path:/tmp/pip-7C_TJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:10 INFO - Running setup.py (path:/tmp/pip-bYp0Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:10 INFO - Running setup.py (path:/tmp/pip-1sIMjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:10 INFO - Running setup.py (path:/tmp/pip-LJRcGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:11 INFO - Running setup.py (path:/tmp/pip-14pT0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:11 INFO - Running setup.py (path:/tmp/pip-2DBMNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:11 INFO - Running setup.py (path:/tmp/pip-oEjAW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:11 INFO - Running setup.py (path:/tmp/pip-iOSLUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:11 INFO - Running setup.py (path:/tmp/pip-bi7tfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:11 INFO - Running setup.py install for manifestparser 04:50:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:11 INFO - Running setup.py install for mozcrash 04:50:11 INFO - Running setup.py install for mozdebug 04:50:11 INFO - Running setup.py install for mozdevice 04:50:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:11 INFO - Running setup.py install for mozfile 04:50:11 INFO - Running setup.py install for mozhttpd 04:50:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:11 INFO - Running setup.py install for mozinfo 04:50:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for mozInstall 04:50:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for mozleak 04:50:12 INFO - Running setup.py install for mozlog 04:50:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for moznetwork 04:50:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for mozprocess 04:50:12 INFO - Running setup.py install for mozprofile 04:50:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for mozrunner 04:50:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:12 INFO - Running setup.py install for mozscreenshot 04:50:12 INFO - Running setup.py install for moztest 04:50:13 INFO - Running setup.py install for mozversion 04:50:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:13 INFO - Cleaning up... 04:50:13 INFO - Return code: 0 04:50:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:13 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50:13 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 04:50:13 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 04:50:13 INFO - Using env: {'DISPLAY': ':0', 04:50:13 INFO - 'HOME': '/home/cltbld', 04:50:13 INFO - 'LANG': 'en_US.UTF-8', 04:50:13 INFO - 'LANGUAGE': 'en_US:en', 04:50:13 INFO - 'LOGNAME': 'cltbld', 04:50:13 INFO - 'MAIL': '/var/mail/cltbld', 04:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:13 INFO - 'MOZ_NO_REMOTE': '1', 04:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:13 INFO - 'NO_EM_RESTART': '1', 04:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:13 INFO - 'PWD': '/builds/slave/test', 04:50:13 INFO - 'SHELL': '/bin/bash', 04:50:13 INFO - 'SHLVL': '1', 04:50:13 INFO - 'TERM': 'linux', 04:50:13 INFO - 'TMOUT': '86400', 04:50:13 INFO - 'USER': 'cltbld', 04:50:13 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:13 INFO - '_': '/tools/buildbot/bin/python'} 04:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:13 INFO - Running setup.py (path:/tmp/pip-PKEu4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:13 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)) 04:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:13 INFO - Running setup.py (path:/tmp/pip-ZjIa8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:13 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)) 04:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:13 INFO - Running setup.py (path:/tmp/pip-V6cNGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:13 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)) 04:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:13 INFO - Running setup.py (path:/tmp/pip-pII5bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:13 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)) 04:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:13 INFO - Running setup.py (path:/tmp/pip-tEIiiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:14 INFO - Running setup.py (path:/tmp/pip-VsRVQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:14 INFO - Running setup.py (path:/tmp/pip-aR_2XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:14 INFO - Running setup.py (path:/tmp/pip-wvlPSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:14 INFO - Running setup.py (path:/tmp/pip-v4N4Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:14 INFO - Running setup.py (path:/tmp/pip-cBDlqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:14 INFO - Running setup.py (path:/tmp/pip-e8C4ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:14 INFO - Running setup.py (path:/tmp/pip-xHPKMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:14 INFO - Running setup.py (path:/tmp/pip-e7dY1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:14 INFO - Running setup.py (path:/tmp/pip-3Q9tHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:14 INFO - Running setup.py (path:/tmp/pip-NOc0n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:14 INFO - Running setup.py (path:/tmp/pip-NosLFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:14 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)) 04:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:14 INFO - Running setup.py (path:/tmp/pip-7b1SXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:14 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)) 04:50:14 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)) 04:50:14 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)) 04:50:14 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)) 04:50:14 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)) 04:50:14 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)) 04:50:14 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)) 04:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:16 INFO - Downloading blessings-1.6.tar.gz 04:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:16 INFO - Installing collected packages: blessings 04:50:16 INFO - Running setup.py install for blessings 04:50:16 INFO - Successfully installed blessings 04:50:16 INFO - Cleaning up... 04:50:16 INFO - Return code: 0 04:50:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:16 INFO - Reading from file tmpfile_stdout 04:50:16 INFO - Current package versions: 04:50:16 INFO - argparse == 1.2.1 04:50:16 INFO - blessings == 1.6 04:50:16 INFO - blobuploader == 1.2.4 04:50:16 INFO - docopt == 0.6.1 04:50:16 INFO - functools32 == 3.2.3-2 04:50:16 INFO - jsonschema == 2.5.1 04:50:16 INFO - manifestparser == 1.1 04:50:16 INFO - mozInstall == 1.13 04:50:16 INFO - mozcrash == 1.0 04:50:16 INFO - mozdebug == 0.1 04:50:16 INFO - mozdevice == 0.51 04:50:16 INFO - mozfile == 1.2 04:50:16 INFO - mozhttpd == 0.7 04:50:16 INFO - mozinfo == 0.10 04:50:16 INFO - mozleak == 0.1 04:50:16 INFO - mozlog == 3.5 04:50:16 INFO - moznetwork == 0.27 04:50:16 INFO - mozprocess == 0.25 04:50:16 INFO - mozprofile == 0.28 04:50:16 INFO - mozrunner == 6.13 04:50:16 INFO - mozscreenshot == 0.1 04:50:16 INFO - mozsystemmonitor == 0.3 04:50:16 INFO - moztest == 0.8 04:50:16 INFO - mozversion == 1.4 04:50:16 INFO - psutil == 3.1.1 04:50:16 INFO - requests == 1.2.3 04:50:16 INFO - wsgiref == 0.1.2 04:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50: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')]} 04:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:16 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 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50:16 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 04:50:16 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 04:50:16 INFO - Using env: {'DISPLAY': ':0', 04:50:16 INFO - 'HOME': '/home/cltbld', 04:50:16 INFO - 'LANG': 'en_US.UTF-8', 04:50:16 INFO - 'LANGUAGE': 'en_US:en', 04:50:16 INFO - 'LOGNAME': 'cltbld', 04:50:16 INFO - 'MAIL': '/var/mail/cltbld', 04:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:16 INFO - 'MOZ_NO_REMOTE': '1', 04:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:16 INFO - 'NO_EM_RESTART': '1', 04:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:16 INFO - 'PWD': '/builds/slave/test', 04:50:16 INFO - 'SHELL': '/bin/bash', 04:50:16 INFO - 'SHLVL': '1', 04:50:16 INFO - 'TERM': 'linux', 04:50:16 INFO - 'TMOUT': '86400', 04:50:16 INFO - 'USER': 'cltbld', 04:50:16 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:16 INFO - '_': '/tools/buildbot/bin/python'} 04:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 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)) 04:50:16 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:20 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:50:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:50:20 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 04:50:20 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 04:50:20 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 04:50:20 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 04:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:50:20 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)) 04:50:20 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)) 04:50:20 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)) 04:50:20 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)) 04:50:20 INFO - Installing collected packages: marionette-driver, simplejson 04:50:20 INFO - Running setup.py install for marionette-driver 04:50:20 INFO - Running setup.py install for simplejson 04:50:20 INFO - building 'simplejson._speedups' extension 04:50:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:50:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:50:21 INFO - Successfully installed marionette-driver simplejson 04:50:21 INFO - Cleaning up... 04:50:21 INFO - Return code: 0 04:50:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2150fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, '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': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', '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 04:50: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', 'jsonschema'] in /builds/slave/test/build 04:50: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 jsonschema 04:50:22 INFO - Using env: {'DISPLAY': ':0', 04:50:22 INFO - 'HOME': '/home/cltbld', 04:50:22 INFO - 'LANG': 'en_US.UTF-8', 04:50:22 INFO - 'LANGUAGE': 'en_US:en', 04:50:22 INFO - 'LOGNAME': 'cltbld', 04:50:22 INFO - 'MAIL': '/var/mail/cltbld', 04:50:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:22 INFO - 'MOZ_NO_REMOTE': '1', 04:50:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:22 INFO - 'NO_EM_RESTART': '1', 04:50:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:22 INFO - 'PWD': '/builds/slave/test', 04:50:22 INFO - 'SHELL': '/bin/bash', 04:50:22 INFO - 'SHLVL': '1', 04:50:22 INFO - 'TERM': 'linux', 04:50:22 INFO - 'TMOUT': '86400', 04:50:22 INFO - 'USER': 'cltbld', 04:50:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:22 INFO - '_': '/tools/buildbot/bin/python'} 04:50:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:50:22 INFO - Cleaning up... 04:50:22 INFO - Return code: 0 04:50:22 INFO - Running post-action listener: _resource_record_post_action 04:50:22 INFO - Running post-action listener: _start_resource_monitoring 04:50:22 INFO - Starting resource monitoring. 04:50:22 INFO - [mozharness: 2017-07-05 11:50:22.436577Z] Finished create-virtualenv step (success) 04:50:22 INFO - [mozharness: 2017-07-05 11:50:22.437580Z] Running install step. 04:50:22 INFO - Running pre-action listener: _resource_record_pre_action 04:50:22 INFO - Running main action method: install 04:50:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:22 INFO - Reading from file tmpfile_stdout 04:50:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:22 INFO - Reading from file tmpfile_stdout 04:50:22 INFO - Output received: 04:50:22 INFO - Usage: mozinstall [options] installer 04:50:22 INFO - Options: 04:50:22 INFO - -h, --help show this help message and exit 04:50:22 INFO - -d DEST, --destination=DEST 04:50:22 INFO - Directory to install application into. [default: 04:50:22 INFO - "/builds/slave/test"] 04:50:22 INFO - --app=APP Application being installed. [default: firefox] 04:50:22 INFO - mkdir: /builds/slave/test/build/application 04:50:22 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'] 04:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:50:40 INFO - Reading from file tmpfile_stdout 04:50:40 INFO - Output received: 04:50:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:50:40 INFO - Running post-action listener: _resource_record_post_action 04:50:40 INFO - [mozharness: 2017-07-05 11:50:40.809591Z] Finished install step (success) 04:50:40 INFO - [mozharness: 2017-07-05 11:50:40.809737Z] Running setup-mitmproxy step. 04:50:40 INFO - Running pre-action listener: _resource_record_pre_action 04:50:40 INFO - Running main action method: setup_mitmproxy 04:50:40 INFO - Skipping: mitmproxy is not required 04:50:40 INFO - Running post-action listener: _resource_record_post_action 04:50:40 INFO - [mozharness: 2017-07-05 11:50:40.810263Z] Finished setup-mitmproxy step (success) 04:50:40 INFO - [mozharness: 2017-07-05 11:50:40.810375Z] Running run-tests step. 04:50:40 INFO - Running pre-action listener: _resource_record_pre_action 04:50:40 INFO - Running pre-action listener: _set_gcov_prefix 04:50:40 INFO - Running main action method: run_tests 04:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:40 INFO - Python 2.7.3 04:50:40 INFO - Return code: 0 04:50:40 INFO - grabbing minidump binary from tooltool 04:50:40 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')]} 04:50:40 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 0x21542a0>, '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 0x21552b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214f4d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:40 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 04:50:40 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 04:50:40 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 04:50:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:40 INFO - Return code: 0 04:50:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:50:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:40 INFO - ENV: RUST_BACKTRACE is now 1 04:50:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:50:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:40 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/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 04:50:40 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/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 04:50:40 INFO - Using env: {'DISPLAY': ':0', 04:50:40 INFO - 'HOME': '/home/cltbld', 04:50:40 INFO - 'LANG': 'en_US.UTF-8', 04:50:40 INFO - 'LANGUAGE': 'en_US:en', 04:50:40 INFO - 'LOGNAME': 'cltbld', 04:50:40 INFO - 'MAIL': '/var/mail/cltbld', 04:50:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:40 INFO - 'MOZ_NO_REMOTE': '1', 04:50:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:40 INFO - 'NO_EM_RESTART': '1', 04:50:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:40 INFO - 'PWD': '/builds/slave/test', 04:50:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:40 INFO - 'RUST_BACKTRACE': '1', 04:50:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:50:40 INFO - 'SHELL': '/bin/bash', 04:50:40 INFO - 'SHLVL': '1', 04:50:40 INFO - 'TERM': 'linux', 04:50:40 INFO - 'TMOUT': '86400', 04:50:40 INFO - 'USER': 'cltbld', 04:50:40 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439', 04:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:40 INFO - '_': '/tools/buildbot/bin/python'} 04:50:40 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/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 04:50:41 INFO - mozversion application_buildid: 20170705110149 04:50:41 INFO - mozversion application_changeset: 211d4dd61025c0a40caea7a54c9066e051bdde8c 04:50:41 INFO - mozversion application_display_name: Nightly 04:50:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:41 INFO - mozversion application_name: Firefox 04:50:41 INFO - mozversion application_remotingname: firefox 04:50:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:41 INFO - mozversion application_vendor: Mozilla 04:50:41 INFO - mozversion application_version: 56.0a1 04:50:41 INFO - mozversion platform_buildid: 20170705110149 04:50:41 INFO - mozversion platform_changeset: 211d4dd61025c0a40caea7a54c9066e051bdde8c 04:50:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:41 INFO - mozversion platform_version: 56.0a1 04:50:41 INFO - using testdate: 1499255441 04:50:41 INFO - actual date: 1499255441 04:50:41 INFO - starting webserver on 'localhost:36142' 04:50:41 INFO - SUITE-START | Running 2 tests 04:50:41 INFO - TEST-START | dromaeo_css 04:50:41 INFO - Initialising browser for dromaeo_css test... 04:50:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36142/getInfo.html -profile /tmp/tmp5oJdsH/profile 04:50:41 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox http://localhost:36142/getInfo.html) 04:50:52 INFO - TEST-INFO | 3351: exit 0 04:50:52 INFO - Browser initialized. 04:50:52 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:52 INFO - TEST-INFO | started process 3575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5oJdsH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:03 INFO - PID 3575 | RSS: Main: 171630592 04:51:03 INFO - PID 3575 | 04:54:03 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36142/tests/dromaeo/cssquery-ext.html) 04:54:05 INFO - PID 3575 | RSS: Main: 179761152 04:54:05 INFO - PID 3575 | 04:57:07 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-ext.html (next: http://localhost:36142/tests/dromaeo/cssquery-jquery.html) 04:57:08 INFO - PID 3575 | RSS: Main: 177053696 04:57:08 INFO - PID 3575 | 05:00:09 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36142/tests/dromaeo/cssquery-mootools.html) 05:00:10 INFO - PID 3575 | RSS: Main: 180015104 05:00:10 INFO - PID 3575 | 05:03:12 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36142/tests/dromaeo/cssquery-prototype.html) 05:03:12 INFO - PID 3575 | RSS: Main: 177905664 05:03:12 INFO - PID 3575 | 05:06:16 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36142/tests/dromaeo/cssquery-yui.html) 05:06:16 INFO - PID 3575 | RSS: Main: 177885184 05:06:16 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | Cycle 1(1): loaded http://localhost:36142/tests/dromaeo/cssquery-yui.html (next: http://localhost:36142/tests/dromaeo/cssquery-dojo.html) 05:09:18 INFO - PID 3575 | RSS: Main: 181796864 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | __start_tp_report 05:09:18 INFO - PID 3575 | _x_x_mozilla_page_load 05:09:18 INFO - PID 3575 | _x_x_mozilla_page_load_details 05:09:18 INFO - PID 3575 | |i|pagename|runs| 05:09:18 INFO - PID 3575 | |0;dojo.html;3109.2693217093965;3141.8271995040277;3149.716525512704;3171.175494371464;3176.142441540784;6116.510679145663;6151.907721384172;6162.445379915813;6168;6207.410296021871;6147.969260153704;6208.503319734422;6210.31686514483;6213.875722485559;6221.222347206599;5567.47109024642;5641.069223578115;5643.633163844337;5673.290838645169;5688.459596338362;5667.801626943058;5671.517920976722;5674.914876276859;5679.687617181074;5703.657780533161;5662.6036177467595;5708.914366284509;5710.714464276791;5726;5738.885222295552;5677.318721753416;5681.346645135821;5690.089585666315;5693.146028095819;5704.828855134353;5596.132599447093;5630.042892708249;5660.575456840754;5684.090545512699;5745.454181852759;6169.167162433104;6206.596571222901;6251.593646412968;6288.654124023177;6309.526785491061;6584.835379115512;6587;6641.302663220341;6675.465962723019;6702.128723265993;6547.443467305285;6650.634215118166;6670.599764014126;6680.265170831205;6687.264400915944;6098.024316109401;6131.172291740647;6147.538934579924;6162.784302549389;6214.968925155391;6721.227058888193;6746.291639377893;6799.1161149051295;6885.896711549331;6897.655117244118;6426.35736426363;6443.742250309935;6467.644279564575;6514.348565143448;6539.607623542603;6430.967845160838;6563.835904102436;6650.733970641217;6655.900161497581;6704.765333213314;6434.935650643433;6460.3216662250725;6541.738330466728;6545.869082618321;6548.050532672736;5995.340512543617;6588.40704336612;6591.703373348211;6683;6715.429188518933;5198.4801519847715;5294.391145018372;5375.919361209585;5388.380336261302;5411.485908838654;4492.101579684077;4493.5281795411665;4509.639228861749;4519.638428925744;4525.275955847114;5680.829575112753;5689.345725241567;5703.62926409782;5708.457696518824;5721.342045664718;6555.082288479617;6561.507886908501;6569.638669873108;6569.704363303663;6581.440577550866;5638.85902852432;5650.943490565124;5717.285339332583;5718.1708652246025;5725.026745453283;5685.204071430003;5719.48524632785;5720.11338242573;5722.198892155102;5740.770369185186;5462.304161152364;6351.079093531412;6437.195350581083;6449.6130232186215;6500.4799616030605;6631.767888124085;6654;6706.966465167643;6722.764703235363;6748.19021717397;6419.6790160490855;6455.9677201613695;6506.479481641552;6509.707063182073;6517.608943463408;6352.872942541216;6463.515236357386;6464.8707025858275;6471.417572418505;6478.352164783484;5174.689518628894;6593.208814942046;6643.435307998681;6681.365270299314;6782.084418603426;6397.616143031433;6409.9679501602195;6497.252815926229;6500.154979852589;6503;6416.7754128605275;6448.226212854487;6493.772717954849;6502.479801615765;6541.672916354259;6244;6343.746250149942;6346.873062538631;6373.776917807854;6380.968095159495;6386.552941294065;6431.421172094347;6446.774362897276;6456.257530384066;6464.09502669636;5294.996615595616;6105.114758360101;6216.968915155395;6248.156498872594;6302.464290535172 05:09:18 INFO - PID 3575 | |1;ext.html;768.2356055724555;818.2676504528447;853.4793775796759;856.8329175810716;1148.4315263944338;29307.267318317052;39448;40250.39624405629;40339;40407.797961010154;40444.19111617766;40510.79744601273;40543.79728101363;40672.59327406725;40768.18463630733;7537.510061845976;7680.11678656956;7690.269424404701;7709.537427754324;7759.41804364672;7455.366293865028;7523.586202758846;7678.42411819113;7688.884666730003;7713.228677132298;7643;7679.7312094076715;7697.499662521918;7697.615119244043;7711.26742959418;7612.086549614054;7673.117591476996;7674.654640541189;7676.155622881479;7682.500637458547;7638.045244344457;7664.463487555873;7699.307062364414;7705.730299439549;7716.4212684048925;37750.62249377499;37792.43311350332;37951.62048379536;38134.618653813384;38254.234915301815;3592.1558433768046;3629.2922880038404;3629.4374371972385;3656.579493358271;3661.4507823826375;30802.845985769927;30902.381952360825;31012.844935775403;31048;31109.8444507776;4636.814527418899;4801.951980480186;4918.2376731606655;4974.502549745032;4976.42771081323;191884;191914;192354;194439;194727.99999999857;42088;47888.521114788404;48525.51474485281;48852.5114748848;48934.265986010236;49880.50119498831;50050;50210;50299;50339.49660503421;16307.347706091861;16443.67112657764;16451.341946322253;16466.75299870503;16480.17599120039;13627.318634068257;13806.102603330752;13818.239996800072;13848.792268115987;13857.445702172003;14001.579952601438;14128.576142715736;14191.361388737532;14219.85780142206;14501.709965800836;5805.158252053428;5807.506361959281;5813.418658134153;5917.704114794243;6036.3058248302;977.4086677560116;987.7086259553449;1001.3191030099457;1042.4110377636612;1051.663467690347;22075.187086157308;22406.439839004157;22887.427814304443;23182.1886233981;23240.18659346915;1094.698957786615;1119.7368618374676;1120.6021862238952;1128.802459569572;1144.9255798373079;11885;11972.401379930969;12072.939635301944;12155.756884862254;12228;231144;231657;231821;232108;233356;50842.49157508452;51294;51344.229836552484;51392.229116563285;51481.48518514767;1447.9131252124905;1460.0655580428534;1477.2392218007735;1498.6328349554428;1501.7597184450653;21943.451413714785;22361.329160125224;22558.77441225567;22794.886025569765;23110.191143309905;36308.09229769171;36616.816915916315;36908.44637330389;36970.630293697795;37081.62918370782;188718;190231;190841;191052;191669;32655.18362040968;33000.67997280082;33494.49758253579;34873.47689784604;34963.300733985685;42760.144797104505;44193.55806442023;44343.556564433944;44368.778156109016;44950.77524612487;29610.851945740134;31841;32009.519857202627;32512.18719531936;32737.50893736548;31650.841745791124;31962.6803731969;32225.35549289048;32652.183695407806;32872.671273286964;35290.647093528736;35345.29309413746;35419.937401877985;35432.291354173285;35497.46753798747;31827.20431989219;31999.68000319967;32092.67907320897;32689.836550818047;32716;23695.170669026502;24259.932128166613;24430.75569244356;24465.38836529101;24685.753142468344 05:09:18 INFO - PID 3575 | |2;jquery.html;564.39045830503;564.4806777764459;572.5905977226282;578.2078552383235;580.8780156167205;20977.895110524463;21862.453438664023;21949.67075493865;21964.341069767892;22004.339869803913;23242.651360229567;24545.877270613622;26388.472230555377;26615.201543953714;26715.06497272596;6201.441870231667;6350.714217860184;6363.140975968255;6369.299377068519;6383.0744542041375;6313.558050936436;6358.554901156921;6360.55476116672;6373.553851230416;6388.808335749912;5800.9129863052085;6123.663198524079;6327.905081423783;6341.334159913212;6347.746090156388;6305.653189074599;6329.968350158266;6353.745850165988;6365.236171659384;6367.522435817309;5857.297124345063;5868;5924.170616113747;5924.58527903047;5939.4357536034;27417.177484675492;27966.580501292498;28330.858345708344;28562.857185714147;28671.139865803852;1904.1145867171692;1946.7274581558593;1952.66804643211;1965.1746266568075;1974.7432833731523;17705.822941770548;18329.175187116478;18333.908330458395;18341.541461463436;18346.541336466562;2249.280230326296;2298.448372390631;2308.7344955330186;2310.202979971907;2322.8490148140318;121386;123325.38337308346;123439;123643;124140.37929810383;13620.727585448236;14306.924011337613;14482.782758258634;14916.477923272634;14994.100353978796;22985.310440686808;23039.193628222933;23119.88440057789;23121.768782311963;23136.4215894604;9856.310058295994;10086.29395942277;10320.948395257976;10355.17158627323;10802.783944321069;9480.525973701288;9628.374155679998;9633.470159141174;9647.517624118766;9734.464604446823;8647;8772.649094036295;8817.426867253607;8997.505137217386;9039.09609039104;2602.8568428736603;2647.8411295322344;2652.8540930248637;2684.3289177705574;2684.5302571218704;966.2994329111337;966.3525437956586;969.1616751509894;1001.7245257554085;1003.5132960514145;19112.713309300372;19371.51571210703;19836;23325.300240992798;24497.26508204757;1024.1243736605245;1085.4898197846999;1087.075985412409;1088.6135421925103;1089.4389389464432;10563.894361056446;11017.944910275397;11106.222564420576;11181.888181118247;11360.636723593221;495494;498734;508438;514715;520030;107588.4620576892;108390.45804770925;108740;109535;110239;1216.1669256559107;1274.1526884621624;1295.6177927511408;1306.5296493262417;1314.7501974624981;16626.833731663013;17577.648447030733;17606.119694015506;17793.199306031;17826.46520604384;48066.5193348062;50260.74869625628;51365.22952155646;51679.74160129175;52759.472405275454;60316.69841650939;63990.68004659947;64060;64322.35677643164;65073.67463162654;12721.93639031799;13017.21896686202;13028.674283142618;13052;13067.477300908238;14820.25898705082;15433.614159646098;15444.996075255072;18991.24035038583;19123.139458724112;14858.702825943637;14940.925295373454;15859.048457092611;16003.199840007721;16035.919820400823;14005.57983260463;14150.646233844236;14236.928815356272;14265.928670356581;14783.186924719244;15901.204939753197;15997.280122394288;16031.118288494245;16193.919030404773;16255.756163657317;12506.624801255977;12701.491940322654;12714.809277861024;12744.235345879277;12746.617601471971;15359.769603455734;16135.75796363032;16147.75778363302;16172.838271617133;16293.429729959395 05:09:18 INFO - PID 3575 | |3;mootools.html;1328.5350127455388;1370.7258548290338;1373.5673262922173;1386.2999185411365;1389.5483967710497;13127.474901003949;13782;13811.411687655922;13813.861861381383;13842;13461.057725959163;13862.792058119112;13864.4454221831;13922.164670119775;13948.163110213369;2587.2496975876975;2663.8268512546624;2672.7594516493514;2674.384891474962;2678.383971686513;2610.216934919526;2667.6265322854815;2681.410089780245;2688.1397952655157;2690.8654567271656;2589;2599.5580751272328;2626.1727555819953;2637.3142982824506;2637.5120602688467;2491.302435318114;2495.7629025242663;2503.8998440062373;2510.8493490390542;2511.6860392450944;2415.758424157588;2441.792447641935;2445.76765207305;2446.1193970170725;2454.361865914875;13253.933730331382;13618.455261789517;13630;13643.727125457435;13672.384742686603;7069.681864316118;7369.4841361104745;7370.631468426557;7375.778726638209;7378.631068446556;4785.138675038492;4942.0610084084265;5043.268726034705;5051.848444546669;5093.949060509384;1862.2923289150172;1875.2405275863161;1924.7594050743658;1942.0483962858239;1953.306576165455;21974.450638734;22512.774872251233;22734.54530909389;22799.54400911989;22819.97310121032;6128.754849806047;6175.62946223228;6461.515386345949;6471.320511346335;6474.482041436674;15524.689506209812;15541.844581554265;15543.766843497131;15547.766783498257;15584.376624934876;7291.270872912666;7337.669804858688;7348.2284360142485;7370.447216458787;7373.225811289844;6603.900941485882;6604.471642268607;6742.056112144303;6812.727490900308;6862.073620061228;4566.566176213254;4664.976675116603;4671.48613652498;4783.402074740658;4811.446683631427;1347.9663008424868;1348.373006551958;1353.8510763815973;1360.5238166641595;1373.8488766235705;852.2031900173358;881.9250363719027;908.0692290402259;920.4753290624413;922.3681777982104;7105.147382314052;7176.892346614805;7216.314450127229;7243.167035790846;7311.341979221896;719.0975325965879;743.1119811824925;973.9659111931048;1007.3099926550336;1011.3982180602529;4840.951590484121;5145.022445735298;5155.407128180233;5237.790488380499;5469.206964990134;18075;18532.351367702067;18821.81178188228;18975.051247437572;19145.52136196606;18656.720149197772;18681.81318186801;18689.439316820517;18698.43904682862;18710.906445467957;9598.136167744937;9814.41113533176;9987;10724.249302548902;10781.568737250422;6928.584284942718;7885.093214280431;8034.116247212685;8193.83612327762;8216.876746848682;14148.78776818369;14498.492552760603;14932.253387330808;15027.549173524812;15297.388104475696;15186.848131518544;15396.615084622974;15416.229188540752;15440.768388474407;15476;11141.16441266892;11320.716982075513;11379.260348077349;11436.885631143583;11450.770984580095;11960.940195298968;12526.248425094524;12653.746925061263;12764.680882978;12839.486420543448;9584.424934503952;9900.603975840886;10156.339837910513;10264.281500295207;10341.534630941474;9907.108360247612;10107.848382274125;10405.687829365132;10632.627858024933;10643.680689579325;8840.734777956672;8850.73447796567;8928;8944.329175311748;8957.193852553302;6784.491163162684;6972.442204623517;7091.64541772899;7146.535475194096;7247.311505406978;6686.765963191265;6931.6880740367815;6973.721051157897;6987.9301206987275;6995.755148569776 05:09:18 INFO - PID 3575 | |4;prototype.html;490.31600916721175;498.81793145501894;512.5566385076909;535.4137219744379;536.2010604199744;6107.877842443159;6133.20268365113;6147.508199344053;6153.600015998957;6189.907151392733;5905;6039.305479869805;6097.26832780067;6102.17620621216;6106.938930610692;4917.336584244743;4951.207806750921;4982.003599280159;4991.452649678611;5004.7747851346685;4845.588125009378;4870.878228044292;4905.779239934193;4933.087378834909;4945.455999840033;4842.152623290927;4856.664417285239;4867.878303042435;4884.7069175849565;4901.901961960759;4675.205215113422;4788.497207793202;4824.059308434857;4883.291922671228;4885.804567817283;4375.628071613916;4401.427814384142;4413.889652758707;4414.205443020255;4416.977915110404;5867.442592953663;5944;5961.5230781537375;5974.641521508724;5988.7604495820115;5604.691741954191;5609.411011843779;5625.5218306444;5651.18057881609;5688.11834165705;6460;6465.288818230038;6465.51293202566;6498.740050397979;6513.153290072308;4856;4873.926891096637;4884.633652476043;4886.169351210303;4888.266759985995;6758.594484330956;6836.915145520491;6863.588184708883;6879.449644028466;6915.89626155608;4990.476000019946;5011.4236862761245;5012.598992080625;5043.142665746832;5044.899102017939;5025.6482046256415;5033.219850923113;5042.991401719671;5054.393472783289;5074.797008119708;5580.832575022756;5588.888222235614;5616.438356164351;5621.578381621394;5634.5210657093785;6365.777197798055;6431.903521447182;6434.8391290218115;6445.742170313135;6460;1757.2619499809855;1758.9824101759075;1763.6208215233787;1765.7439671247598;1774.645070985808;1125.9662210133545;1218.7081693405019;1223.877612238769;1224.8530176378713;1233.7285797124619;5557.44425557441;5602.2717046783655;5612.512684138706;5675.602707810496;5790.681512516768;6554.246261679968;6558.737650494022;6586.27550969393;6612.0412540181405;6619.702113404908;5662.915056274159;5712.514436272881;5743.62666426681;5772.307323121252;5774.393688662714;3451.2579795344122;3491.2144767427635;3504.3867323218847;3520.7007404370916;3532.364174448624;6392.808215753535;6394.360563943662;6397.392247736458;6408.903866442007;6463.289038205794;6709.825780488395;6740.460763138937;6777.457803375718;6810.421114205249;6830.385265326145;6436.388543088399;6439.64581947988;6442.387973142638;6523.64119973406;6530.8040758777315;6554.508411869224;6567.799787071384;6579.342065793382;6585;6655.267920528835;6529.249136349381;6564.376384243489;6576.342365763577;6599.274079851309;6613.5370524062855;6388.776392826415;6398.168238129014;6452.903206452001;6461.773837915651;6483.222013358427;4922.286268491121;4942.678725882806;4954.711774938614;4969.428515720739;4971.477994810492;6592.538522303393;6639.966800165968;6649.138241292252;6678.532502724763;6678.799636010927;6357.745690172526;6415.358464153547;6424.550281480251;6467.708953097216;6490.188726409199;6405.775797847053;6447.548671593131;6455.677216139268;6456.515761317826;6514.804555863332;6311.621302721851;6314.684265786784;6333.8733225336155;6358.936410635834;6408.711607977559;6169.598976066542;6319.7992381447375;6384.585001974857;6391.201099862517;6442.226932768098;5886.381929897299;6055.455009049207;6079.939200607937;6099.634021958696;6118 05:09:18 INFO - PID 3575 | |5;yui.html;910.5356268303163;924.7595625137462;925.1950802801564;941.1764705882352;952.6332362040612;17470.825291747096;17530;17694.734578981326;18172.90913545432;18719.3448229312;18790.812091879077;20189.697154542693;20204.09081591328;20265.98670066498;20333.28833490828;1038.9636362727324;1053.2364036073823;1053.9987012338308;1054.3726482742793;1054.3937236089241;1054.984175237372;1055.4775386183849;1057.2070946789909;1062.2351906627216;1066.0352381095122;1126.7070561653948;1128.582424502935;1139.0716565998725;1140.236041851957;1143.0683992546049;1020.2857999400412;1069.5989004123453;1070.4701172919376;1075.8493810866485;1076.2143635146308;784.8704963680985;789.0373744032271;796.0129439494984;796.3867821777256;798.8522123407188;18479.630407391913;18767.812321876743;19044.71432928507;19098.427047188605;19234.519137021547;19693.9015304924;19902.900485497623;20250.594988100303;20419.489512762153;20551.280705175246;15535.922320388325;15889.841101588952;15937.601559960978;15961.760573591406;15962.201889905458;3541.3271478419274;3562.1806984393475;3590.35373632746;3591.4612808078737;3598.1364472526407;110425.44787276012;111853.44073279582;115005;115226.42386788012;118324.81675183224;15833.920830395775;15944.521664350088;16150.192490375433;16184.83815161857;16233.2695028724;27861.58207626887;28015.439691206062;29014.27464313409;29300.267493312836;29527;8229.423940324239;8514.191151840565;8594.957025214833;8607.053224145338;8663.913360866436;4038.2529232092156;4228.112096459778;4252.468441444819;4258.701890867672;4284.89287767802;5034.093863104603;5106.259592359162;5151.8196863109615;5159.432462429129;5159.613029022763;915.1717695485596;1046.7016900183564;1081.0486771640906;1081.6376513867942;1092.186321190718;664.3423011218858;675.6587923098804;678.521642242218;705.6013352455846;711.7331000874672;11530.59642912494;11812.291262524275;12035.39823008846;12297.56958506448;12333.62999110028;653.095462784038;704.8766465868555;712.6080655639378;714.6212507371101;724.1093455050318;5238.188080847474;5472;5522.5581953443625;5548.500634942875;5732.398098199712;91269;91611;93233;96425.51787241019;99601.50199248958;82561.28474218675;82720;83098.61883269034;84753.57623211844;90026;73337.63331183417;76823.61588192024;76883.61558192284;77343.61328193436;79220;11884.524619015143;12114.878851211728;12193.87806121963;12358.44387002605;12592.370381481072;34610;34952.475712864834;35117.64882351246;36122.45816312705;36436;41448.58551414447;60733;62509.68745156245;63720.362796371446;66429.66785166043;17644.64710705753;18328.450146495627;18661;19509.51226219356;19578.706319405504;20530.794692053485;20871.686924695838;21059.368218953456;21224.151033959086;21490;17390.30438782485;18417.26330946747;18428.17073231681;18477.81522184815;19143.13855876461;18205.18076686526;18905.149268283236;19161.90419047896;19300.8069919299;19710.40868773939;16751.581210469347;17256.827431726026;17359.56601084983;17450;17560.82439175592;12476;12881.291528965998;13044.608661740163;13389.598312050653;13548.712872277118;14452.855471445151;14577.708445831237;14880.62798430048;14901.105933644016;15150.848491515384 05:09:18 INFO - PID 3575 | __end_tp_report 05:09:18 INFO - PID 3575 | __start_cc_report 05:09:18 INFO - PID 3575 | _x_x_mozilla_cycle_collect,350 05:09:18 INFO - PID 3575 | __end_cc_report 05:09:18 INFO - PID 3575 | __startTimestamp1499256558776__endTimestamp 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | ------- Summary: start ------- 05:09:18 INFO - PID 3575 | Number of tests: 6 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#0] dojo.html Cycles:165 Average:6060.35 Median:6302.46 stddev:723.58 (11.5%) stddev-sans-first:687.77 05:09:18 INFO - PID 3575 | Values: 3109.3 3141.8 3149.7 3171.2 3176.1 6116.5 6151.9 6162.4 6168.0 6207.4 6148.0 6208.5 6210.3 6213.9 6221.2 5567.5 5641.1 5643.6 5673.3 5688.5 5667.8 5671.5 5674.9 5679.7 5703.7 5662.6 5708.9 5710.7 5726.0 5738.9 5677.3 5681.3 5690.1 5693.1 5704.8 5596.1 5630.0 5660.6 5684.1 5745.5 6169.2 6206.6 6251.6 6288.7 6309.5 6584.8 6587.0 6641.3 6675.5 6702.1 6547.4 6650.6 6670.6 6680.3 6687.3 6098.0 6131.2 6147.5 6162.8 6215.0 6721.2 6746.3 6799.1 6885.9 6897.7 6426.4 6443.7 6467.6 6514.3 6539.6 6431.0 6563.8 6650.7 6655.9 6704.8 6434.9 6460.3 6541.7 6545.9 6548.1 5995.3 6588.4 6591.7 6683.0 6715.4 5198.5 5294.4 5375.9 5388.4 5411.5 4492.1 4493.5 4509.6 4519.6 4525.3 5680.8 5689.3 5703.6 5708.5 5721.3 6555.1 6561.5 6569.6 6569.7 6581.4 5638.9 5650.9 5717.3 5718.2 5725.0 5685.2 5719.5 5720.1 5722.2 5740.8 5462.3 6351.1 6437.2 6449.6 6500.5 6631.8 6654.0 6707.0 6722.8 6748.2 6419.7 6456.0 6506.5 6509.7 6517.6 6352.9 6463.5 6464.9 6471.4 6478.4 5174.7 6593.2 6643.4 6681.4 6782.1 6397.6 6410.0 6497.3 6500.2 6503.0 6416.8 6448.2 6493.8 6502.5 6541.7 6244.0 6343.7 6346.9 6373.8 6381.0 6386.6 6431.4 6446.8 6456.3 6464.1 5295.0 6105.1 6217.0 6248.2 6302.5 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#1] ext.html Cycles:180 Average:37262.18 Median:35317.97 stddev:53349.12 (151.1%) stddev-sans-first:53428.40 05:09:18 INFO - PID 3575 | Values: 768.2 818.3 853.5 856.8 1148.4 29307.3 39448.0 40250.4 40339.0 40407.8 40444.2 40510.8 40543.8 40672.6 40768.2 7537.5 7680.1 7690.3 7709.5 7759.4 7455.4 7523.6 7678.4 7688.9 7713.2 7643.0 7679.7 7697.5 7697.6 7711.3 7612.1 7673.1 7674.7 7676.2 7682.5 7638.0 7664.5 7699.3 7705.7 7716.4 37750.6 37792.4 37951.6 38134.6 38254.2 3592.2 3629.3 3629.4 3656.6 3661.5 30802.8 30902.4 31012.8 31048.0 31109.8 4636.8 4802.0 4918.2 4974.5 4976.4 191884.0 191914.0 192354.0 194439.0 194728.0 42088.0 47888.5 48525.5 48852.5 48934.3 49880.5 50050.0 50210.0 50299.0 50339.5 16307.3 16443.7 16451.3 16466.8 16480.2 13627.3 13806.1 13818.2 13848.8 13857.4 14001.6 14128.6 14191.4 14219.9 14501.7 5805.2 5807.5 5813.4 5917.7 6036.3 977.4 987.7 1001.3 1042.4 1051.7 22075.2 22406.4 22887.4 23182.2 23240.2 1094.7 1119.7 1120.6 1128.8 1144.9 11885.0 11972.4 12072.9 12155.8 12228.0 231144.0 231657.0 231821.0 232108.0 233356.0 50842.5 51294.0 51344.2 51392.2 51481.5 1447.9 1460.1 1477.2 1498.6 1501.8 21943.5 22361.3 22558.8 22794.9 23110.2 36308.1 36616.8 36908.4 36970.6 37081.6 188718.0 190231.0 190841.0 191052.0 191669.0 32655.2 33000.7 33494.5 34873.5 34963.3 42760.1 44193.6 44343.6 44368.8 44950.8 29610.9 31841.0 32009.5 32512.2 32737.5 31650.8 31962.7 32225.4 32652.2 32872.7 35290.6 35345.3 35419.9 35432.3 35497.5 31827.2 31999.7 32092.7 32689.8 32716.0 23695.2 24259.9 24430.8 24465.4 24685.8 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#2] jquery.html Cycles:180 Average:33609.94 Median:21906.06 stddev:84655.91 (386.4%) stddev-sans-first:84857.03 05:09:18 INFO - PID 3575 | Values: 564.4 564.5 572.6 578.2 580.9 20977.9 21862.5 21949.7 21964.3 22004.3 23242.7 24545.9 26388.5 26615.2 26715.1 6201.4 6350.7 6363.1 6369.3 6383.1 6313.6 6358.6 6360.6 6373.6 6388.8 5800.9 6123.7 6327.9 6341.3 6347.7 6305.7 6330.0 6353.7 6365.2 6367.5 5857.3 5868.0 5924.2 5924.6 5939.4 27417.2 27966.6 28330.9 28562.9 28671.1 1904.1 1946.7 1952.7 1965.2 1974.7 17705.8 18329.2 18333.9 18341.5 18346.5 2249.3 2298.4 2308.7 2310.2 2322.8 121386.0 123325.4 123439.0 123643.0 124140.4 13620.7 14306.9 14482.8 14916.5 14994.1 22985.3 23039.2 23119.9 23121.8 23136.4 9856.3 10086.3 10320.9 10355.2 10802.8 9480.5 9628.4 9633.5 9647.5 9734.5 8647.0 8772.6 8817.4 8997.5 9039.1 2602.9 2647.8 2652.9 2684.3 2684.5 966.3 966.4 969.2 1001.7 1003.5 19112.7 19371.5 19836.0 23325.3 24497.3 1024.1 1085.5 1087.1 1088.6 1089.4 10563.9 11017.9 11106.2 11181.9 11360.6 495494.0 498734.0 508438.0 514715.0 520030.0 107588.5 108390.5 108740.0 109535.0 110239.0 1216.2 1274.2 1295.6 1306.5 1314.8 16626.8 17577.6 17606.1 17793.2 17826.5 48066.5 50260.7 51365.2 51679.7 52759.5 60316.7 63990.7 64060.0 64322.4 65073.7 12721.9 13017.2 13028.7 13052.0 13067.5 14820.3 15433.6 15445.0 18991.2 19123.1 14858.7 14940.9 15859.0 16003.2 16035.9 14005.6 14150.6 14236.9 14265.9 14783.2 15901.2 15997.3 16031.1 16193.9 16255.8 12506.6 12701.5 12714.8 12744.2 12746.6 15359.8 16135.8 16147.8 16172.8 16293.4 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#3] mootools.html Cycles:180 Average:8361.43 Median:2549.47 stddev:5664.55 (222.2%) stddev-sans-first:5655.79 05:09:18 INFO - PID 3575 | Values: 1328.5 1370.7 1373.6 1386.3 1389.5 13127.5 13782.0 13811.4 13813.9 13842.0 13461.1 13862.8 13864.4 13922.2 13948.2 2587.2 2663.8 2672.8 2674.4 2678.4 2610.2 2667.6 2681.4 2688.1 2690.9 2589.0 2599.6 2626.2 2637.3 2637.5 2491.3 2495.8 2503.9 2510.8 2511.7 2415.8 2441.8 2445.8 2446.1 2454.4 13253.9 13618.5 13630.0 13643.7 13672.4 7069.7 7369.5 7370.6 7375.8 7378.6 4785.1 4942.1 5043.3 5051.8 5093.9 1862.3 1875.2 1924.8 1942.0 1953.3 21974.5 22512.8 22734.5 22799.5 22820.0 6128.8 6175.6 6461.5 6471.3 6474.5 15524.7 15541.8 15543.8 15547.8 15584.4 7291.3 7337.7 7348.2 7370.4 7373.2 6603.9 6604.5 6742.1 6812.7 6862.1 4566.6 4665.0 4671.5 4783.4 4811.4 1348.0 1348.4 1353.9 1360.5 1373.8 852.2 881.9 908.1 920.5 922.4 7105.1 7176.9 7216.3 7243.2 7311.3 719.1 743.1 974.0 1007.3 1011.4 4841.0 5145.0 5155.4 5237.8 5469.2 18075.0 18532.4 18821.8 18975.1 19145.5 18656.7 18681.8 18689.4 18698.4 18710.9 9598.1 9814.4 9987.0 10724.2 10781.6 6928.6 7885.1 8034.1 8193.8 8216.9 14148.8 14498.5 14932.3 15027.5 15297.4 15186.8 15396.6 15416.2 15440.8 15476.0 11141.2 11320.7 11379.3 11436.9 11450.8 11960.9 12526.2 12653.7 12764.7 12839.5 9584.4 9900.6 10156.3 10264.3 10341.5 9907.1 10107.8 10405.7 10632.6 10643.7 8840.7 8850.7 8928.0 8944.3 8957.2 6784.5 6972.4 7091.6 7146.5 7247.3 6686.8 6931.7 6973.7 6987.9 6995.8 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#4] prototype.html Cycles:180 Average:5430.07 Median:5981.70 stddev:1516.01 (25.3%) stddev-sans-first:1474.23 05:09:18 INFO - PID 3575 | Values: 490.3 498.8 512.6 535.4 536.2 6107.9 6133.2 6147.5 6153.6 6189.9 5905.0 6039.3 6097.3 6102.2 6106.9 4917.3 4951.2 4982.0 4991.5 5004.8 4845.6 4870.9 4905.8 4933.1 4945.5 4842.2 4856.7 4867.9 4884.7 4901.9 4675.2 4788.5 4824.1 4883.3 4885.8 4375.6 4401.4 4413.9 4414.2 4417.0 5867.4 5944.0 5961.5 5974.6 5988.8 5604.7 5609.4 5625.5 5651.2 5688.1 6460.0 6465.3 6465.5 6498.7 6513.2 4856.0 4873.9 4884.6 4886.2 4888.3 6758.6 6836.9 6863.6 6879.4 6915.9 4990.5 5011.4 5012.6 5043.1 5044.9 5025.6 5033.2 5043.0 5054.4 5074.8 5580.8 5588.9 5616.4 5621.6 5634.5 6365.8 6431.9 6434.8 6445.7 6460.0 1757.3 1759.0 1763.6 1765.7 1774.6 1126.0 1218.7 1223.9 1224.9 1233.7 5557.4 5602.3 5612.5 5675.6 5790.7 6554.2 6558.7 6586.3 6612.0 6619.7 5662.9 5712.5 5743.6 5772.3 5774.4 3451.3 3491.2 3504.4 3520.7 3532.4 6392.8 6394.4 6397.4 6408.9 6463.3 6709.8 6740.5 6777.5 6810.4 6830.4 6436.4 6439.6 6442.4 6523.6 6530.8 6554.5 6567.8 6579.3 6585.0 6655.3 6529.2 6564.4 6576.3 6599.3 6613.5 6388.8 6398.2 6452.9 6461.8 6483.2 4922.3 4942.7 4954.7 4969.4 4971.5 6592.5 6640.0 6649.1 6678.5 6678.8 6357.7 6415.4 6424.6 6467.7 6490.2 6405.8 6447.5 6455.7 6456.5 6514.8 6311.6 6314.7 6333.9 6358.9 6408.7 6169.6 6319.8 6384.6 6391.2 6442.2 5886.4 6055.5 6079.9 6099.6 6118.0 05:09:18 INFO - PID 3575 | 05:09:18 INFO - PID 3575 | [#5] yui.html Cycles:180 Average:21777.04 Median:19806.65 stddev:28084.81 (141.8%) stddev-sans-first:28119.88 05:09:18 INFO - PID 3575 | Values: 910.5 924.8 925.2 941.2 952.6 17470.8 17530.0 17694.7 18172.9 18719.3 18790.8 20189.7 20204.1 20266.0 20333.3 1039.0 1053.2 1054.0 1054.4 1054.4 1055.0 1055.5 1057.2 1062.2 1066.0 1126.7 1128.6 1139.1 1140.2 1143.1 1020.3 1069.6 1070.5 1075.8 1076.2 784.9 789.0 796.0 796.4 798.9 18479.6 18767.8 19044.7 19098.4 19234.5 19693.9 19902.9 20250.6 20419.5 20551.3 15535.9 15889.8 15937.6 15961.8 15962.2 3541.3 3562.2 3590.4 3591.5 3598.1 110425.4 111853.4 115005.0 115226.4 118324.8 15833.9 15944.5 16150.2 16184.8 16233.3 27861.6 28015.4 29014.3 29300.3 29527.0 8229.4 8514.2 8595.0 8607.1 8663.9 4038.3 4228.1 4252.5 4258.7 4284.9 5034.1 5106.3 5151.8 5159.4 5159.6 915.2 1046.7 1081.0 1081.6 1092.2 664.3 675.7 678.5 705.6 711.7 11530.6 11812.3 12035.4 12297.6 12333.6 653.1 704.9 712.6 714.6 724.1 5238.2 5472.0 5522.6 5548.5 5732.4 91269.0 91611.0 93233.0 96425.5 99601.5 82561.3 82720.0 83098.6 84753.6 90026.0 73337.6 76823.6 76883.6 77343.6 79220.0 11884.5 12114.9 12193.9 12358.4 12592.4 34610.0 34952.5 35117.6 36122.5 36436.0 41448.6 60733.0 62509.7 63720.4 66429.7 17644.6 18328.5 18661.0 19509.5 19578.7 20530.8 20871.7 21059.4 21224.2 21490.0 17390.3 18417.3 18428.2 18477.8 19143.1 18205.2 18905.1 19161.9 19300.8 19710.4 16751.6 17256.8 17359.6 17450.0 17560.8 12476.0 12881.3 13044.6 13389.6 13548.7 14452.9 14577.7 14880.6 14901.1 15150.8 05:09:18 INFO - PID 3575 | -------- Summary: end -------- 05:09:18 INFO - PID 3575 | 05:09:19 INFO - TEST-INFO | 3575: exit 0 05:09:19 INFO - TEST-OK | dromaeo_css | took 1118105ms 05:09:19 INFO - TEST-START | kraken 05:09:19 INFO - Initialising browser for kraken test... 05:09:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36142/getInfo.html -profile /tmp/tmpaEpxhi/profile 05:09:19 INFO - TEST-INFO | started process 3991 (/builds/slave/test/build/application/firefox/firefox http://localhost:36142/getInfo.html) 05:09:25 INFO - TEST-INFO | 3991: exit 0 05:09:25 INFO - Browser initialized. 05:09:25 INFO - Running cycle 1/1 for kraken test... 05:09:25 INFO - TEST-INFO | started process 4213 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEpxhi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:37 INFO - PID 4213 | RSS: Main: 172400640 05:09:37 INFO - PID 4213 | 05:09:39 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36142/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:40 INFO - PID 4213 | RSS: Main: 176472064 05:09:40 INFO - PID 4213 | 05:09:43 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36142/tests/kraken/driver.html?testName=audio-dft) 05:09:43 INFO - PID 4213 | RSS: Main: 177078272 05:09:43 INFO - PID 4213 | 05:09:46 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36142/tests/kraken/driver.html?testName=audio-fft) 05:09:47 INFO - PID 4213 | RSS: Main: 172490752 05:09:47 INFO - PID 4213 | 05:09:49 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36142/tests/kraken/driver.html?testName=audio-oscillator) 05:09:50 INFO - PID 4213 | RSS: Main: 173236224 05:09:50 INFO - PID 4213 | 05:09:52 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36142/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:52 INFO - PID 4213 | RSS: Main: 174100480 05:09:52 INFO - PID 4213 | 05:09:55 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36142/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:56 INFO - PID 4213 | RSS: Main: 176881664 05:09:56 INFO - PID 4213 | 05:09:59 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36142/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:00 INFO - PID 4213 | RSS: Main: 178495488 05:10:00 INFO - PID 4213 | 05:10:03 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36142/tests/kraken/driver.html?testName=json-parse-financial) 05:10:03 INFO - PID 4213 | RSS: Main: 177127424 05:10:03 INFO - PID 4213 | 05:10:05 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36142/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:06 INFO - PID 4213 | RSS: Main: 177295360 05:10:06 INFO - PID 4213 | 05:10:07 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:08 INFO - PID 4213 | RSS: Main: 177508352 05:10:08 INFO - PID 4213 | 05:10:10 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:11 INFO - PID 4213 | RSS: Main: 177741824 05:10:11 INFO - PID 4213 | 05:10:13 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:14 INFO - PID 4213 | RSS: Main: 177463296 05:10:14 INFO - PID 4213 | 05:10:17 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:18 INFO - PID 4213 | RSS: Main: 177389568 05:10:18 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | Cycle 1(1): loaded http://localhost:36142/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36142/tests/kraken/driver.html?testName=ai-astar) 05:10:20 INFO - PID 4213 | RSS: Main: 179105792 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | __start_tp_report 05:10:20 INFO - PID 4213 | _x_x_mozilla_page_load 05:10:20 INFO - PID 4213 | _x_x_mozilla_page_load_details 05:10:20 INFO - PID 4213 | |i|pagename|runs| 05:10:20 INFO - PID 4213 | |0;ai-astar;101;107;109;109;111;111;110;114;108;109 05:10:20 INFO - PID 4213 | |1;audio-beat-detection;149;123;145;179;121;150;150;123;176;120 05:10:20 INFO - PID 4213 | |2;audio-dft;164;168;162;162;163;162;163;163;167;171 05:10:20 INFO - PID 4213 | |3;audio-fft;74;75;75;163;75;74;76;74;92;74 05:10:20 INFO - PID 4213 | |4;audio-oscillator;83;82;136;83;82;82;127;82;82;132 05:10:20 INFO - PID 4213 | |5;imaging-gaussian-blur;113;113;114;114;114;116;113;113;114;114 05:10:20 INFO - PID 4213 | |6;imaging-darkroom;150;151;150;151;151;151;150;149;150;152 05:10:20 INFO - PID 4213 | |7;imaging-desaturate;94;95;94;94;94;94;94;93;94;94 05:10:20 INFO - PID 4213 | |8;json-parse-financial;61;56;56;54;58;57;53;56;55;54 05:10:20 INFO - PID 4213 | |9;json-stringify-tinderbox;54;56;56;54;54;54;55;54;54;54 05:10:20 INFO - PID 4213 | |10;stanford-crypto-aes;78;79;80;77;77;79;77;79;87;78 05:10:20 INFO - PID 4213 | |11;stanford-crypto-ccm;130;144;145;130;138;132;132;137;128;162 05:10:20 INFO - PID 4213 | |12;stanford-crypto-pbkdf2;184;188;181;184;189;201;180;190;177;193 05:10:20 INFO - PID 4213 | |13;stanford-crypto-sha256-iterative;70;71;74;73;75;70;66;70;72;68 05:10:20 INFO - PID 4213 | __end_tp_report 05:10:20 INFO - PID 4213 | __start_cc_report 05:10:20 INFO - PID 4213 | _x_x_mozilla_cycle_collect,910 05:10:20 INFO - PID 4213 | __end_cc_report 05:10:20 INFO - PID 4213 | __startTimestamp1499256620339__endTimestamp 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | ------- Summary: start ------- 05:10:20 INFO - PID 4213 | Number of tests: 14 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:3.38 (3.1%) stddev-sans-first:2.05 05:10:20 INFO - PID 4213 | Values: 101.0 107.0 109.0 109.0 111.0 111.0 110.0 114.0 108.0 109.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:149.50 stddev:21.94 (14.7%) stddev-sans-first:23.18 05:10:20 INFO - PID 4213 | Values: 149.0 123.0 145.0 179.0 121.0 150.0 150.0 123.0 176.0 120.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:3.10 (1.9%) stddev-sans-first:3.28 05:10:20 INFO - PID 4213 | Values: 164.0 168.0 162.0 162.0 163.0 162.0 163.0 163.0 167.0 171.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#3] audio-fft Cycles:10 Average:85.20 Median:75.00 stddev:27.88 (37.2%) stddev-sans-first:29.28 05:10:20 INFO - PID 4213 | Values: 74.0 75.0 75.0 163.0 75.0 74.0 76.0 74.0 92.0 74.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:82.00 stddev:23.95 (29.2%) stddev-sans-first:24.85 05:10:20 INFO - PID 4213 | Values: 83.0 82.0 136.0 83.0 82.0 82.0 127.0 82.0 82.0 132.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 05:10:20 INFO - PID 4213 | Values: 113.0 113.0 114.0 114.0 114.0 116.0 113.0 113.0 114.0 114.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:10:20 INFO - PID 4213 | Values: 150.0 151.0 150.0 151.0 151.0 151.0 150.0 149.0 150.0 152.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:10:20 INFO - PID 4213 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:2.31 (4.1%) stddev-sans-first:1.59 05:10:20 INFO - PID 4213 | Values: 61.0 56.0 56.0 54.0 58.0 57.0 53.0 56.0 55.0 54.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:0.85 (1.6%) stddev-sans-first:0.88 05:10:20 INFO - PID 4213 | Values: 54.0 56.0 56.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.00 stddev:2.96 (3.7%) stddev-sans-first:3.11 05:10:20 INFO - PID 4213 | Values: 78.0 79.0 80.0 77.0 77.0 79.0 77.0 79.0 87.0 78.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:137.50 stddev:10.34 (7.5%) stddev-sans-first:10.57 05:10:20 INFO - PID 4213 | Values: 130.0 144.0 145.0 130.0 138.0 132.0 132.0 137.0 128.0 162.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:188.50 stddev:7.06 (3.7%) stddev-sans-first:7.42 05:10:20 INFO - PID 4213 | Values: 184.0 188.0 181.0 184.0 189.0 201.0 180.0 190.0 177.0 193.0 05:10:20 INFO - PID 4213 | 05:10:20 INFO - PID 4213 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.50 stddev:2.73 (3.8%) stddev-sans-first:2.87 05:10:20 INFO - PID 4213 | Values: 70.0 71.0 74.0 73.0 75.0 70.0 66.0 70.0 72.0 68.0 05:10:20 INFO - PID 4213 | -------- Summary: end -------- 05:10:20 INFO - PID 4213 | 05:10:21 INFO - TEST-INFO | 4213: exit 0 05:10:21 INFO - TEST-OK | kraken | took 61814ms 05:10:21 INFO - SUITE-END | took 1179s 05:10:21 INFO - Completed test suite (00:19:40) 05:10:21 INFO - javascript benchmark 05:10:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8269.506168147034, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.2693217093965, 3141.8271995040277, 3149.716525512704, 3171.175494371464, 3176.142441540784, 6116.510679145663, 6151.907721384172, 6162.445379915813, 6168.0, 6207.410296021871, 6147.969260153704, 6208.503319734422, 6210.31686514483, 6213.875722485559, 6221.222347206599, 5567.47109024642, 5641.069223578115, 5643.633163844337, 5673.290838645169, 5688.459596338362, 5667.801626943058, 5671.517920976722, 5674.914876276859, 5679.687617181074, 5703.657780533161, 5662.6036177467595, 5708.914366284509, 5710.714464276791, 5726.0, 5738.885222295552, 5677.318721753416, 5681.346645135821, 5690.089585666315, 5693.146028095819, 5704.828855134353, 5596.132599447093, 5630.042892708249, 5660.575456840754, 5684.090545512699, 5745.454181852759, 6169.167162433104, 6206.596571222901, 6251.593646412968, 6288.654124023177, 6309.526785491061, 6584.835379115512, 6587.0, 6641.302663220341, 6675.465962723019, 6702.128723265993, 6547.443467305285, 6650.634215118166, 6670.599764014126, 6680.265170831205, 6687.264400915944, 6098.024316109401, 6131.172291740647, 6147.538934579924, 6162.784302549389, 6214.968925155391, 6721.227058888193, 6746.291639377893, 6799.1161149051295, 6885.896711549331, 6897.655117244118, 6426.35736426363, 6443.742250309935, 6467.644279564575, 6514.348565143448, 6539.607623542603, 6430.967845160838, 6563.835904102436, 6650.733970641217, 6655.900161497581, 6704.765333213314, 6434.935650643433, 6460.3216662250725, 6541.738330466728, 6545.869082618321, 6548.050532672736, 5995.340512543617, 6588.40704336612, 6591.703373348211, 6683.0, 6715.429188518933, 5198.4801519847715, 5294.391145018372, 5375.919361209585, 5388.380336261302, 5411.485908838654, 4492.101579684077, 4493.5281795411665, 4509.639228861749, 4519.638428925744, 4525.275955847114, 5680.829575112753, 5689.345725241567, 5703.62926409782, 5708.457696518824, 5721.342045664718, 6555.082288479617, 6561.507886908501, 6569.638669873108, 6569.704363303663, 6581.440577550866, 5638.85902852432, 5650.943490565124, 5717.285339332583, 5718.1708652246025, 5725.026745453283, 5685.204071430003, 5719.48524632785, 5720.11338242573, 5722.198892155102, 5740.770369185186, 5462.304161152364, 6351.079093531412, 6437.195350581083, 6449.6130232186215, 6500.4799616030605, 6631.767888124085, 6654.0, 6706.966465167643, 6722.764703235363, 6748.19021717397, 6419.6790160490855, 6455.9677201613695, 6506.479481641552, 6509.707063182073, 6517.608943463408, 6352.872942541216, 6463.515236357386, 6464.8707025858275, 6471.417572418505, 6478.352164783484, 5174.689518628894, 6593.208814942046, 6643.435307998681, 6681.365270299314, 6782.084418603426, 6397.616143031433, 6409.9679501602195, 6497.252815926229, 6500.154979852589, 6503.0, 6416.7754128605275, 6448.226212854487, 6493.772717954849, 6502.479801615765, 6541.672916354259, 6244.0, 6343.746250149942, 6346.873062538631, 6373.776917807854, 6380.968095159495, 6386.552941294065, 6431.421172094347, 6446.774362897276, 6456.257530384066, 6464.09502669636, 5294.996615595616, 6105.114758360101, 6216.968915155395, 6248.156498872594, 6302.464290535172], "value": 6007.812634415387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.2356055724555, 818.2676504528447, 853.4793775796759, 856.8329175810716, 1148.4315263944338, 29307.267318317052, 39448.0, 40250.39624405629, 40339.0, 40407.797961010154, 40444.19111617766, 40510.79744601273, 40543.79728101363, 40672.59327406725, 40768.18463630733, 7537.510061845976, 7680.11678656956, 7690.269424404701, 7709.537427754324, 7759.41804364672, 7455.366293865028, 7523.586202758846, 7678.42411819113, 7688.884666730003, 7713.228677132298, 7643.0, 7679.7312094076715, 7697.499662521918, 7697.615119244043, 7711.26742959418, 7612.086549614054, 7673.117591476996, 7674.654640541189, 7676.155622881479, 7682.500637458547, 7638.045244344457, 7664.463487555873, 7699.307062364414, 7705.730299439549, 7716.4212684048925, 37750.62249377499, 37792.43311350332, 37951.62048379536, 38134.618653813384, 38254.234915301815, 3592.1558433768046, 3629.2922880038404, 3629.4374371972385, 3656.579493358271, 3661.4507823826375, 30802.845985769927, 30902.381952360825, 31012.844935775403, 31048.0, 31109.8444507776, 4636.814527418899, 4801.951980480186, 4918.2376731606655, 4974.502549745032, 4976.42771081323, 191884.0, 191914.0, 192354.0, 194439.0, 194727.99999999857, 42088.0, 47888.521114788404, 48525.51474485281, 48852.5114748848, 48934.265986010236, 49880.50119498831, 50050.0, 50210.0, 50299.0, 50339.49660503421, 16307.347706091861, 16443.67112657764, 16451.341946322253, 16466.75299870503, 16480.17599120039, 13627.318634068257, 13806.102603330752, 13818.239996800072, 13848.792268115987, 13857.445702172003, 14001.579952601438, 14128.576142715736, 14191.361388737532, 14219.85780142206, 14501.709965800836, 5805.158252053428, 5807.506361959281, 5813.418658134153, 5917.704114794243, 6036.3058248302, 977.4086677560116, 987.7086259553449, 1001.3191030099457, 1042.4110377636612, 1051.663467690347, 22075.187086157308, 22406.439839004157, 22887.427814304443, 23182.1886233981, 23240.18659346915, 1094.698957786615, 1119.7368618374676, 1120.6021862238952, 1128.802459569572, 1144.9255798373079, 11885.0, 11972.401379930969, 12072.939635301944, 12155.756884862254, 12228.0, 231144.0, 231657.0, 231821.0, 232108.0, 233356.0, 50842.49157508452, 51294.0, 51344.229836552484, 51392.229116563285, 51481.48518514767, 1447.9131252124905, 1460.0655580428534, 1477.2392218007735, 1498.6328349554428, 1501.7597184450653, 21943.451413714785, 22361.329160125224, 22558.77441225567, 22794.886025569765, 23110.191143309905, 36308.09229769171, 36616.816915916315, 36908.44637330389, 36970.630293697795, 37081.62918370782, 188718.0, 190231.0, 190841.0, 191052.0, 191669.0, 32655.18362040968, 33000.67997280082, 33494.49758253579, 34873.47689784604, 34963.300733985685, 42760.144797104505, 44193.55806442023, 44343.556564433944, 44368.778156109016, 44950.77524612487, 29610.851945740134, 31841.0, 32009.519857202627, 32512.18719531936, 32737.50893736548, 31650.841745791124, 31962.6803731969, 32225.35549289048, 32652.183695407806, 32872.671273286964, 35290.647093528736, 35345.29309413746, 35419.937401877985, 35432.291354173285, 35497.46753798747, 31827.20431989219, 31999.68000319967, 32092.67907320897, 32689.836550818047, 32716.0, 23695.170669026502, 24259.932128166613, 24430.75569244356, 24465.38836529101, 24685.753142468344], "value": 17091.64122917085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.39045830503, 564.4806777764459, 572.5905977226282, 578.2078552383235, 580.8780156167205, 20977.895110524463, 21862.453438664023, 21949.67075493865, 21964.341069767892, 22004.339869803913, 23242.651360229567, 24545.877270613622, 26388.472230555377, 26615.201543953714, 26715.06497272596, 6201.441870231667, 6350.714217860184, 6363.140975968255, 6369.299377068519, 6383.0744542041375, 6313.558050936436, 6358.554901156921, 6360.55476116672, 6373.553851230416, 6388.808335749912, 5800.9129863052085, 6123.663198524079, 6327.905081423783, 6341.334159913212, 6347.746090156388, 6305.653189074599, 6329.968350158266, 6353.745850165988, 6365.236171659384, 6367.522435817309, 5857.297124345063, 5868.0, 5924.170616113747, 5924.58527903047, 5939.4357536034, 27417.177484675492, 27966.580501292498, 28330.858345708344, 28562.857185714147, 28671.139865803852, 1904.1145867171692, 1946.7274581558593, 1952.66804643211, 1965.1746266568075, 1974.7432833731523, 17705.822941770548, 18329.175187116478, 18333.908330458395, 18341.541461463436, 18346.541336466562, 2249.280230326296, 2298.448372390631, 2308.7344955330186, 2310.202979971907, 2322.8490148140318, 121386.0, 123325.38337308346, 123439.0, 123643.0, 124140.37929810383, 13620.727585448236, 14306.924011337613, 14482.782758258634, 14916.477923272634, 14994.100353978796, 22985.310440686808, 23039.193628222933, 23119.88440057789, 23121.768782311963, 23136.4215894604, 9856.310058295994, 10086.29395942277, 10320.948395257976, 10355.17158627323, 10802.783944321069, 9480.525973701288, 9628.374155679998, 9633.470159141174, 9647.517624118766, 9734.464604446823, 8647.0, 8772.649094036295, 8817.426867253607, 8997.505137217386, 9039.09609039104, 2602.8568428736603, 2647.8411295322344, 2652.8540930248637, 2684.3289177705574, 2684.5302571218704, 966.2994329111337, 966.3525437956586, 969.1616751509894, 1001.7245257554085, 1003.5132960514145, 19112.713309300372, 19371.51571210703, 19836.0, 23325.300240992798, 24497.26508204757, 1024.1243736605245, 1085.4898197846999, 1087.075985412409, 1088.6135421925103, 1089.4389389464432, 10563.894361056446, 11017.944910275397, 11106.222564420576, 11181.888181118247, 11360.636723593221, 495494.0, 498734.0, 508438.0, 514715.0, 520030.0, 107588.4620576892, 108390.45804770925, 108740.0, 109535.0, 110239.0, 1216.1669256559107, 1274.1526884621624, 1295.6177927511408, 1306.5296493262417, 1314.7501974624981, 16626.833731663013, 17577.648447030733, 17606.119694015506, 17793.199306031, 17826.46520604384, 48066.5193348062, 50260.74869625628, 51365.22952155646, 51679.74160129175, 52759.472405275454, 60316.69841650939, 63990.68004659947, 64060.0, 64322.35677643164, 65073.67463162654, 12721.93639031799, 13017.21896686202, 13028.674283142618, 13052.0, 13067.477300908238, 14820.25898705082, 15433.614159646098, 15444.996075255072, 18991.24035038583, 19123.139458724112, 14858.702825943637, 14940.925295373454, 15859.048457092611, 16003.199840007721, 16035.919820400823, 14005.57983260463, 14150.646233844236, 14236.928815356272, 14265.928670356581, 14783.186924719244, 15901.204939753197, 15997.280122394288, 16031.118288494245, 16193.919030404773, 16255.756163657317, 12506.624801255977, 12701.491940322654, 12714.809277861024, 12744.235345879277, 12746.617601471971, 15359.769603455734, 16135.75796363032, 16147.75778363302, 16172.838271617133, 16293.429729959395], "value": 11371.528129566259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.5350127455388, 1370.7258548290338, 1373.5673262922173, 1386.2999185411365, 1389.5483967710497, 13127.474901003949, 13782.0, 13811.411687655922, 13813.861861381383, 13842.0, 13461.057725959163, 13862.792058119112, 13864.4454221831, 13922.164670119775, 13948.163110213369, 2587.2496975876975, 2663.8268512546624, 2672.7594516493514, 2674.384891474962, 2678.383971686513, 2610.216934919526, 2667.6265322854815, 2681.410089780245, 2688.1397952655157, 2690.8654567271656, 2589.0, 2599.5580751272328, 2626.1727555819953, 2637.3142982824506, 2637.5120602688467, 2491.302435318114, 2495.7629025242663, 2503.8998440062373, 2510.8493490390542, 2511.6860392450944, 2415.758424157588, 2441.792447641935, 2445.76765207305, 2446.1193970170725, 2454.361865914875, 13253.933730331382, 13618.455261789517, 13630.0, 13643.727125457435, 13672.384742686603, 7069.681864316118, 7369.4841361104745, 7370.631468426557, 7375.778726638209, 7378.631068446556, 4785.138675038492, 4942.0610084084265, 5043.268726034705, 5051.848444546669, 5093.949060509384, 1862.2923289150172, 1875.2405275863161, 1924.7594050743658, 1942.0483962858239, 1953.306576165455, 21974.450638734, 22512.774872251233, 22734.54530909389, 22799.54400911989, 22819.97310121032, 6128.754849806047, 6175.62946223228, 6461.515386345949, 6471.320511346335, 6474.482041436674, 15524.689506209812, 15541.844581554265, 15543.766843497131, 15547.766783498257, 15584.376624934876, 7291.270872912666, 7337.669804858688, 7348.2284360142485, 7370.447216458787, 7373.225811289844, 6603.900941485882, 6604.471642268607, 6742.056112144303, 6812.727490900308, 6862.073620061228, 4566.566176213254, 4664.976675116603, 4671.48613652498, 4783.402074740658, 4811.446683631427, 1347.9663008424868, 1348.373006551958, 1353.8510763815973, 1360.5238166641595, 1373.8488766235705, 852.2031900173358, 881.9250363719027, 908.0692290402259, 920.4753290624413, 922.3681777982104, 7105.147382314052, 7176.892346614805, 7216.314450127229, 7243.167035790846, 7311.341979221896, 719.0975325965879, 743.1119811824925, 973.9659111931048, 1007.3099926550336, 1011.3982180602529, 4840.951590484121, 5145.022445735298, 5155.407128180233, 5237.790488380499, 5469.206964990134, 18075.0, 18532.351367702067, 18821.81178188228, 18975.051247437572, 19145.52136196606, 18656.720149197772, 18681.81318186801, 18689.439316820517, 18698.43904682862, 18710.906445467957, 9598.136167744937, 9814.41113533176, 9987.0, 10724.249302548902, 10781.568737250422, 6928.584284942718, 7885.093214280431, 8034.116247212685, 8193.83612327762, 8216.876746848682, 14148.78776818369, 14498.492552760603, 14932.253387330808, 15027.549173524812, 15297.388104475696, 15186.848131518544, 15396.615084622974, 15416.229188540752, 15440.768388474407, 15476.0, 11141.16441266892, 11320.716982075513, 11379.260348077349, 11436.885631143583, 11450.770984580095, 11960.940195298968, 12526.248425094524, 12653.746925061263, 12764.680882978, 12839.486420543448, 9584.424934503952, 9900.603975840886, 10156.339837910513, 10264.281500295207, 10341.534630941474, 9907.108360247612, 10107.848382274125, 10405.687829365132, 10632.627858024933, 10643.680689579325, 8840.734777956672, 8850.73447796567, 8928.0, 8944.329175311748, 8957.193852553302, 6784.491163162684, 6972.442204623517, 7091.64541772899, 7146.535475194096, 7247.311505406978, 6686.765963191265, 6931.6880740367815, 6973.721051157897, 6987.9301206987275, 6995.755148569776], "value": 6140.048063371784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.31600916721175, 498.81793145501894, 512.5566385076909, 535.4137219744379, 536.2010604199744, 6107.877842443159, 6133.20268365113, 6147.508199344053, 6153.600015998957, 6189.907151392733, 5905.0, 6039.305479869805, 6097.26832780067, 6102.17620621216, 6106.938930610692, 4917.336584244743, 4951.207806750921, 4982.003599280159, 4991.452649678611, 5004.7747851346685, 4845.588125009378, 4870.878228044292, 4905.779239934193, 4933.087378834909, 4945.455999840033, 4842.152623290927, 4856.664417285239, 4867.878303042435, 4884.7069175849565, 4901.901961960759, 4675.205215113422, 4788.497207793202, 4824.059308434857, 4883.291922671228, 4885.804567817283, 4375.628071613916, 4401.427814384142, 4413.889652758707, 4414.205443020255, 4416.977915110404, 5867.442592953663, 5944.0, 5961.5230781537375, 5974.641521508724, 5988.7604495820115, 5604.691741954191, 5609.411011843779, 5625.5218306444, 5651.18057881609, 5688.11834165705, 6460.0, 6465.288818230038, 6465.51293202566, 6498.740050397979, 6513.153290072308, 4856.0, 4873.926891096637, 4884.633652476043, 4886.169351210303, 4888.266759985995, 6758.594484330956, 6836.915145520491, 6863.588184708883, 6879.449644028466, 6915.89626155608, 4990.476000019946, 5011.4236862761245, 5012.598992080625, 5043.142665746832, 5044.899102017939, 5025.6482046256415, 5033.219850923113, 5042.991401719671, 5054.393472783289, 5074.797008119708, 5580.832575022756, 5588.888222235614, 5616.438356164351, 5621.578381621394, 5634.5210657093785, 6365.777197798055, 6431.903521447182, 6434.8391290218115, 6445.742170313135, 6460.0, 1757.2619499809855, 1758.9824101759075, 1763.6208215233787, 1765.7439671247598, 1774.645070985808, 1125.9662210133545, 1218.7081693405019, 1223.877612238769, 1224.8530176378713, 1233.7285797124619, 5557.44425557441, 5602.2717046783655, 5612.512684138706, 5675.602707810496, 5790.681512516768, 6554.246261679968, 6558.737650494022, 6586.27550969393, 6612.0412540181405, 6619.702113404908, 5662.915056274159, 5712.514436272881, 5743.62666426681, 5772.307323121252, 5774.393688662714, 3451.2579795344122, 3491.2144767427635, 3504.3867323218847, 3520.7007404370916, 3532.364174448624, 6392.808215753535, 6394.360563943662, 6397.392247736458, 6408.903866442007, 6463.289038205794, 6709.825780488395, 6740.460763138937, 6777.457803375718, 6810.421114205249, 6830.385265326145, 6436.388543088399, 6439.64581947988, 6442.387973142638, 6523.64119973406, 6530.8040758777315, 6554.508411869224, 6567.799787071384, 6579.342065793382, 6585.0, 6655.267920528835, 6529.249136349381, 6564.376384243489, 6576.342365763577, 6599.274079851309, 6613.5370524062855, 6388.776392826415, 6398.168238129014, 6452.903206452001, 6461.773837915651, 6483.222013358427, 4922.286268491121, 4942.678725882806, 4954.711774938614, 4969.428515720739, 4971.477994810492, 6592.538522303393, 6639.966800165968, 6649.138241292252, 6678.532502724763, 6678.799636010927, 6357.745690172526, 6415.358464153547, 6424.550281480251, 6467.708953097216, 6490.188726409199, 6405.775797847053, 6447.548671593131, 6455.677216139268, 6456.515761317826, 6514.804555863332, 6311.621302721851, 6314.684265786784, 6333.8733225336155, 6358.936410635834, 6408.711607977559, 6169.598976066542, 6319.7992381447375, 6384.585001974857, 6391.201099862517, 6442.226932768098, 5886.381929897299, 6055.455009049207, 6079.939200607937, 6099.634021958696, 6118.0], "value": 4986.775691415591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.5356268303163, 924.7595625137462, 925.1950802801564, 941.1764705882352, 952.6332362040612, 17470.825291747096, 17530.0, 17694.734578981326, 18172.90913545432, 18719.3448229312, 18790.812091879077, 20189.697154542693, 20204.09081591328, 20265.98670066498, 20333.28833490828, 1038.9636362727324, 1053.2364036073823, 1053.9987012338308, 1054.3726482742793, 1054.3937236089241, 1054.984175237372, 1055.4775386183849, 1057.2070946789909, 1062.2351906627216, 1066.0352381095122, 1126.7070561653948, 1128.582424502935, 1139.0716565998725, 1140.236041851957, 1143.0683992546049, 1020.2857999400412, 1069.5989004123453, 1070.4701172919376, 1075.8493810866485, 1076.2143635146308, 784.8704963680985, 789.0373744032271, 796.0129439494984, 796.3867821777256, 798.8522123407188, 18479.630407391913, 18767.812321876743, 19044.71432928507, 19098.427047188605, 19234.519137021547, 19693.9015304924, 19902.900485497623, 20250.594988100303, 20419.489512762153, 20551.280705175246, 15535.922320388325, 15889.841101588952, 15937.601559960978, 15961.760573591406, 15962.201889905458, 3541.3271478419274, 3562.1806984393475, 3590.35373632746, 3591.4612808078737, 3598.1364472526407, 110425.44787276012, 111853.44073279582, 115005.0, 115226.42386788012, 118324.81675183224, 15833.920830395775, 15944.521664350088, 16150.192490375433, 16184.83815161857, 16233.2695028724, 27861.58207626887, 28015.439691206062, 29014.27464313409, 29300.267493312836, 29527.0, 8229.423940324239, 8514.191151840565, 8594.957025214833, 8607.053224145338, 8663.913360866436, 4038.2529232092156, 4228.112096459778, 4252.468441444819, 4258.701890867672, 4284.89287767802, 5034.093863104603, 5106.259592359162, 5151.8196863109615, 5159.432462429129, 5159.613029022763, 915.1717695485596, 1046.7016900183564, 1081.0486771640906, 1081.6376513867942, 1092.186321190718, 664.3423011218858, 675.6587923098804, 678.521642242218, 705.6013352455846, 711.7331000874672, 11530.59642912494, 11812.291262524275, 12035.39823008846, 12297.56958506448, 12333.62999110028, 653.095462784038, 704.8766465868555, 712.6080655639378, 714.6212507371101, 724.1093455050318, 5238.188080847474, 5472.0, 5522.5581953443625, 5548.500634942875, 5732.398098199712, 91269.0, 91611.0, 93233.0, 96425.51787241019, 99601.50199248958, 82561.28474218675, 82720.0, 83098.61883269034, 84753.57623211844, 90026.0, 73337.63331183417, 76823.61588192024, 76883.61558192284, 77343.61328193436, 79220.0, 11884.524619015143, 12114.878851211728, 12193.87806121963, 12358.44387002605, 12592.370381481072, 34610.0, 34952.475712864834, 35117.64882351246, 36122.45816312705, 36436.0, 41448.58551414447, 60733.0, 62509.68745156245, 63720.362796371446, 66429.66785166043, 17644.64710705753, 18328.450146495627, 18661.0, 19509.51226219356, 19578.706319405504, 20530.794692053485, 20871.686924695838, 21059.368218953456, 21224.151033959086, 21490.0, 17390.30438782485, 18417.26330946747, 18428.17073231681, 18477.81522184815, 19143.13855876461, 18205.18076686526, 18905.149268283236, 19161.90419047896, 19300.8069919299, 19710.40868773939, 16751.581210469347, 17256.827431726026, 17359.56601084983, 17450.0, 17560.82439175592, 12476.0, 12881.291528965998, 13044.608661740163, 13389.598312050653, 13548.712872277118, 14452.855471445151, 14577.708445831237, 14880.62798430048, 14901.105933644016, 15150.848491515384], "value": 8944.163225794542, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 109.0, 109.0, 111.0, 111.0, 110.0, 114.0, 108.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 123.0, 145.0, 179.0, 121.0, 150.0, 150.0, 123.0, 176.0, 120.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 167.0, 171.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 163.0, 75.0, 74.0, 76.0, 74.0, 92.0, 74.0], "value": 85.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 136.0, 83.0, 82.0, 82.0, 127.0, 82.0, 82.0, 132.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 114.0, 114.0, 116.0, 113.0, 113.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 151.0, 151.0, 150.0, 149.0, 150.0, 152.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 56.0, 54.0, 58.0, 57.0, 53.0, 56.0, 55.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 56.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 80.0, 77.0, 77.0, 79.0, 77.0, 79.0, 87.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 144.0, 145.0, 130.0, 138.0, 132.0, 132.0, 137.0, 128.0, 162.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 181.0, 184.0, 189.0, 201.0, 180.0, 190.0, 177.0, 193.0], "value": 186.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 74.0, 73.0, 75.0, 70.0, 66.0, 70.0, 72.0, 68.0], "value": 70.9, "unit": "score"}]}]} 05:10:21 INFO - Return code: 0 05:10:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:21 INFO - # TBPL SUCCESS # 05:10:21 INFO - Running post-action listener: _package_coverage_data 05:10:21 INFO - Running post-action listener: _resource_record_post_action 05:10:21 INFO - [mozharness: 2017-07-05 12:10:21.643887Z] Finished run-tests step (success) 05:10:21 INFO - Running post-run listener: _resource_record_post_run 05:10:21 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 5783552; Write bytes: 328810496; Read time: 2796; Write time: 348548 05:10:21 INFO - TinderboxPrint: CPU usage
13.1% 05:10:21 INFO - TinderboxPrint: I/O read bytes / time
5,783,552 / 2,796 05:10:21 INFO - TinderboxPrint: I/O write bytes / time
328,810,496 / 348,548 05:10:21 INFO - TinderboxPrint: CPU idle
8,304.3 (86.9%) 05:10:21 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 05:10:21 INFO - TinderboxPrint: Swap in / out
0 / 0 05:10:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 1564672; Read time: 0; Write time: 536 05:10:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:10:21 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 3416064; Write bytes: 327245824; Read time: 2096; Write time: 348012 05:10:22 INFO - Running post-run listener: _upload_blobber_files 05:10:22 INFO - Blob upload gear active. 05:10:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:22 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 05:10:22 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'] 05:10:22 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 05:10:22 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:10:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:10:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:23 INFO - (blobuploader) - INFO - Done attempting. 05:10:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:27 INFO - (blobuploader) - INFO - Done attempting. 05:10:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:10:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:28 INFO - (blobuploader) - INFO - Done attempting. 05:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:29 INFO - (blobuploader) - INFO - Done attempting. 05:10:29 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:29 INFO - Return code: 0 05:10:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2057e42b391daf90be7b011e1c8d35fe90255a0cc76cd8c84ad683b49c2bcc45c20c619c6d68806203388cae5238d6fbb59036ef2662871013cc78cef4735f0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/843886e54d709e3ec76c27cea4d07f1b5dfc245321051b525a3096acd1d3eeb5458aadd05eb761f9598698f2fb55408e522247b88d26810f3c8aade78077be5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a32b25e9a3b7534c3c3697a0ec7939b9d45ce456df61a65dc9b6699dad95223cea87f3f533915d35990610e6a26e24af6e2d5cc8807974231e020af6a697bdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35acbaa9b0f201e0e495f9e729a182304315174608e729c815adc20fc831ccb01ac9feabf854242dca2d80067d89c4cf3507111dc472ece1c20d0675aab717fb"} 05:10:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:29 INFO - Contents: 05:10:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2057e42b391daf90be7b011e1c8d35fe90255a0cc76cd8c84ad683b49c2bcc45c20c619c6d68806203388cae5238d6fbb59036ef2662871013cc78cef4735f0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/843886e54d709e3ec76c27cea4d07f1b5dfc245321051b525a3096acd1d3eeb5458aadd05eb761f9598698f2fb55408e522247b88d26810f3c8aade78077be5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a32b25e9a3b7534c3c3697a0ec7939b9d45ce456df61a65dc9b6699dad95223cea87f3f533915d35990610e6a26e24af6e2d5cc8807974231e020af6a697bdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35acbaa9b0f201e0e495f9e729a182304315174608e729c815adc20fc831ccb01ac9feabf854242dca2d80067d89c4cf3507111dc472ece1c20d0675aab717fb"} 05:10:29 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:29 INFO - Copying logs to upload dir... 05:10:29 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.767856 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-07-05 05:10:28.877421) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-05 05:10:28.882059) ========= 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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 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/2057e42b391daf90be7b011e1c8d35fe90255a0cc76cd8c84ad683b49c2bcc45c20c619c6d68806203388cae5238d6fbb59036ef2662871013cc78cef4735f0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/843886e54d709e3ec76c27cea4d07f1b5dfc245321051b525a3096acd1d3eeb5458aadd05eb761f9598698f2fb55408e522247b88d26810f3c8aade78077be5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a32b25e9a3b7534c3c3697a0ec7939b9d45ce456df61a65dc9b6699dad95223cea87f3f533915d35990610e6a26e24af6e2d5cc8807974231e020af6a697bdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35acbaa9b0f201e0e495f9e729a182304315174608e729c815adc20fc831ccb01ac9feabf854242dca2d80067d89c4cf3507111dc472ece1c20d0675aab717fb"} build_url:https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011014 build_url: 'https://queue.taskcluster.net/v1/task/LLj2jiK5RPiWxDTqXrBl0A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2057e42b391daf90be7b011e1c8d35fe90255a0cc76cd8c84ad683b49c2bcc45c20c619c6d68806203388cae5238d6fbb59036ef2662871013cc78cef4735f0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/843886e54d709e3ec76c27cea4d07f1b5dfc245321051b525a3096acd1d3eeb5458aadd05eb761f9598698f2fb55408e522247b88d26810f3c8aade78077be5e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a32b25e9a3b7534c3c3697a0ec7939b9d45ce456df61a65dc9b6699dad95223cea87f3f533915d35990610e6a26e24af6e2d5cc8807974231e020af6a697bdd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35acbaa9b0f201e0e495f9e729a182304315174608e729c815adc20fc831ccb01ac9feabf854242dca2d80067d89c4cf3507111dc472ece1c20d0675aab717fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-05 05:10:28.905997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:10:28.906348) ========= 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=17051fcd5208b27b50bedfeb000001dd-1499250427.705522-1707068439 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:10:28.961306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-05 05:10:28.961717) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-05 05:10:28.961992) ========= ========= Total master_lag: -0.08 =========