builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-084 starttime: 1503532916.86 results: success (0) revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:56.864083) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:56.864567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:56.864862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:56.881322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:56.881704) ========= 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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 17:01:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-08-23 17:01:57 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.013519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.013828) ========= 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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.063281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.063703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f0abd25e1f4acced652d180c34b7c9eda638deb1 --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 f0abd25e1f4acced652d180c34b7c9eda638deb1 --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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 17:01:57,151 truncating revision to first 12 chars 2017-08-23 17:01:57,152 Setting DEBUG logging. 2017-08-23 17:01:57,152 attempt 1/10 2017-08-23 17:01:57,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f0abd25e1f4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 17:01:57,651 unpacking tar archive at: mozilla-central-f0abd25e1f4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.981694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.982022) ========= script_repo_revision: f0abd25e1f4acced652d180c34b7c9eda638deb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.982422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.982687) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 17:01:57.994797) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-23 17:01:57.995143) ========= /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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:01:58 INFO - MultiFileLogger online at 20170823 17:01:58 in /builds/slave/test 17:01:58 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 17:01:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:01:58 INFO - {'append_to_log': False, 17:01:58 INFO - 'base_work_dir': '/builds/slave/test', 17:01:58 INFO - 'blob_upload_branch': 'Firefox', 17:01:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:01:58 INFO - 'branch': 'Firefox', 17:01:58 INFO - 'buildbot_json_path': 'buildprops.json', 17:01:58 INFO - 'code_coverage': False, 17:01:58 INFO - 'config_files': ('talos/linux_config.py',), 17:01:58 INFO - 'default_actions': ('clobber', 17:01:58 INFO - 'read-buildbot-config', 17:01:58 INFO - 'download-and-extract', 17:01:58 INFO - 'populate-webroot', 17:01:58 INFO - 'create-virtualenv', 17:01:58 INFO - 'install', 17:01:58 INFO - 'setup-mitmproxy', 17:01:58 INFO - 'run-tests'), 17:01:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:01:58 INFO - 'disable_ccov_upload': False, 17:01:58 INFO - 'download_minidump_stackwalk': True, 17:01:58 INFO - 'download_symbols': 'ondemand', 17:01:58 INFO - 'enable_stylo': False, 17:01:58 INFO - 'enable_webrender': False, 17:01:58 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:01:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:01:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:01:58 INFO - 'gecko_profile': False, 17:01:58 INFO - 'gecko_profile_interval': 0, 17:01:58 INFO - 'installer_path': 'installer.exe', 17:01:58 INFO - 'log_level': 'info', 17:01:58 INFO - 'log_name': 'talos', 17:01:58 INFO - 'log_to_console': True, 17:01:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:01:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:01:58 INFO - 'opt_config_files': (), 17:01:58 INFO - 'pip_index': False, 17:01:58 INFO - 'suite': 'dromaeojs-e10s', 17:01:58 INFO - 'system_bits': '32', 17:01:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:01:58 INFO - 'title': 'talos-linux64-ix-084', 17:01:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:01:58 INFO - 'use_talos_json': True, 17:01:58 INFO - 'verify': 'False', 17:01:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:01:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:01:58 INFO - 'work_dir': 'build'} 17:01:58 INFO - [mozharness: 2017-08-24 00:01:58.216226Z] Running clobber step. 17:01:58 INFO - Running pre-action listener: _resource_record_pre_action 17:01:58 INFO - Running main action method: clobber 17:01:58 INFO - rmtree: /builds/slave/test/build 17:01:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:01:59 INFO - Running post-action listener: _resource_record_post_action 17:01:59 INFO - [mozharness: 2017-08-24 00:01:59.356683Z] Finished clobber step (success) 17:01:59 INFO - [mozharness: 2017-08-24 00:01:59.356781Z] Running read-buildbot-config step. 17:01:59 INFO - Running pre-action listener: _resource_record_pre_action 17:01:59 INFO - Running main action method: read_buildbot_config 17:01:59 INFO - Using buildbot properties: 17:01:59 INFO - { 17:01:59 INFO - "project": "", 17:01:59 INFO - "product": "firefox", 17:01:59 INFO - "who": "kwierso@gmail.com", 17:01:59 INFO - "installer_path": "public/build/target.tar.bz2", 17:01:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:01:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:01:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:01:59 INFO - "stage_platform": "linux64-stylo", 17:01:59 INFO - "basedir": "/builds/slave/test", 17:01:59 INFO - "buildnumber": 280, 17:01:59 INFO - "platform": "ubuntu64_hw_stylo", 17:01:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:01:59 INFO - "slavebuilddir": "test", 17:01:59 INFO - "taskId": "JoUWYBPSR0O08ODUaHj68Q", 17:01:59 INFO - "branch": "mozilla-central", 17:01:59 INFO - "script_repo_revision": "production", 17:01:59 INFO - "revision": "f0abd25e1f4acced652d180c34b7c9eda638deb1", 17:01:59 INFO - "slavename": "talos-linux64-ix-084", 17:01:59 INFO - "repo_path": "mozilla-central" 17:01:59 INFO - } 17:01:59 INFO - Finding installer, test and symbols from parent task. 17:01:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoUWYBPSR0O08ODUaHj68Q'}, attempt #1 17:01:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoUWYBPSR0O08ODUaHj68Q'}, attempt #1 17:02:00 INFO - Task dependencies: OO07YykgQ7SfVQl5pfp5jg 17:02:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg'}, attempt #1 17:02:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 17:02:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 17:02:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip 17:02:00 INFO - Running post-action listener: _resource_record_post_action 17:02:00 INFO - [mozharness: 2017-08-24 00:02:00.710055Z] Finished read-buildbot-config step (success) 17:02:00 INFO - [mozharness: 2017-08-24 00:02:00.710272Z] Running download-and-extract step. 17:02:00 INFO - Running pre-action listener: _resource_record_pre_action 17:02:00 INFO - Running main action method: download_and_extract 17:02:00 INFO - mkdir: /builds/slave/test/build/tests 17:02: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')]} 17:02:00 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json 17:02:00 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:02:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:02:01 INFO - Downloaded 989 bytes. 17:02:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:02:01 INFO - Using the following test package requirements: 17:02:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:02:01 INFO - u'common': [u'target.common.tests.zip'], 17:02:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:02:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:02:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:02:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:02:01 INFO - u'mozbase': [u'target.common.tests.zip'], 17:02:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:02:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:02:01 INFO - u'web-platform': [u'target.common.tests.zip', 17:02:01 INFO - u'target.web-platform.tests.tar.gz'], 17:02:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:02:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:02:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 17:02:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:02:01 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 17:02:02 INFO - Content-Length response header: 54950441 17:02:02 INFO - Bytes received: 54950441 17:02:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:02:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip 17:02:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:02:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.common.tests.zip into memory 17:02:14 INFO - Content-Length response header: 54950441 17:02:14 INFO - Bytes received: 54950441 17:02:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip 17:02:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:02:26 INFO - Fetch https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.talos.tests.zip into memory 17:02:27 INFO - Content-Length response header: 14496384 17:02:27 INFO - Bytes received: 14496384 17:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:27 INFO - trying https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 17:02:27 INFO - Downloading https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:02:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:02:29 INFO - Downloaded 61087534 bytes. 17:02:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 17:02:29 INFO - mkdir: /builds/slave/test/properties 17:02:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:29 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:29 INFO - Contents: 17:02:29 INFO - build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 17:02:29 INFO - Running post-action listener: _resource_record_post_action 17:02:29 INFO - Running post-action listener: find_tests_for_verification 17:02:29 INFO - Running post-action listener: set_extra_try_arguments 17:02:29 INFO - [mozharness: 2017-08-24 00:02:29.034209Z] Finished download-and-extract step (success) 17:02:29 INFO - [mozharness: 2017-08-24 00:02:29.034305Z] Running populate-webroot step. 17:02:29 INFO - Running pre-action listener: _resource_record_pre_action 17:02:29 INFO - Running main action method: populate_webroot 17:02:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:29 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:29 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:29 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'tests': ['damp', 'tps']}, 17:02:29 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['damp', 'tps']}, 17:02:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:02:29 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:02:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:02:29 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:02:29 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:29 INFO - 'ts_paint', 17:02:29 INFO - 'tpaint', 17:02:29 INFO - 'sessionrestore', 17:02:29 INFO - 'sessionrestore_many_windows', 17:02:29 INFO - 'sessionrestore_no_auto_restore', 17:02:29 INFO - 'tabpaint']}, 17:02:29 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['a11yr', 17:02:29 INFO - 'ts_paint', 17:02:29 INFO - 'tpaint', 17:02:29 INFO - 'sessionrestore', 17:02:29 INFO - 'sessionrestore_many_windows', 17:02:29 INFO - 'sessionrestore_no_auto_restore', 17:02:29 INFO - 'tabpaint']}, 17:02:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:02:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:02:29 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['bloom_basic_singleton']}, 17:02:29 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['bloom_basic']}, 17:02:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:29 INFO - 'tsvgr_opacity', 17:02:29 INFO - 'tart', 17:02:29 INFO - 'tscrollx', 17:02:29 INFO - 'tsvg_static']}, 17:02:29 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['tsvgx', 17:02:29 INFO - 'tsvgr_opacity', 17:02:29 INFO - 'tart', 17:02:29 INFO - 'tscrollx', 17:02:29 INFO - 'tsvg_static']}, 17:02:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:02:29 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--stylo'], 17:02:29 INFO - 'tests': ['tp5o']}, 17:02:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:02:29 INFO - 'talos_options': ['--mitmproxy', 17:02:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:02:29 INFO - '--firstNonBlankPaint'], 17:02:29 INFO - 'tests': ['tp6_google', 17:02:29 INFO - 'tp6_youtube', 17:02:29 INFO - 'tp6_amazon', 17:02:29 INFO - 'tp6_facebook']}, 17:02:29 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:02:29 INFO - 'talos_options': ['--stylo', 17:02:29 INFO - '--mitmproxy', 17:02:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:02:29 INFO - '--firstNonBlankPaint'], 17:02:29 INFO - 'tests': ['tp6_google', 17:02:29 INFO - 'tp6_youtube', 17:02:29 INFO - 'tp6_amazon', 17:02:29 INFO - 'tp6_facebook']}, 17:02:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:02:29 INFO - 'talos_options': ['--stylo', 17:02:29 INFO - '--stylo-threads=1', 17:02:29 INFO - '--mitmproxy', 17:02:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:02:29 INFO - '--firstNonBlankPaint'], 17:02:29 INFO - 'tests': ['tp6_google', 17:02:29 INFO - 'tp6_youtube', 17:02:29 INFO - 'tp6_amazon', 17:02:29 INFO - 'tp6_facebook']}, 17:02:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--xperf_path', 17:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:29 INFO - 'tests': ['tp5n']}, 17:02:29 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:02:29 INFO - 'talos_options': ['--stylo', 17:02:29 INFO - '--xperf_path', 17:02:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:29 INFO - 'tests': ['tp5n']}}} 17:02:29 INFO - Running post-action listener: _resource_record_post_action 17:02:29 INFO - [mozharness: 2017-08-24 00:02:29.048539Z] Finished populate-webroot step (success) 17:02:29 INFO - [mozharness: 2017-08-24 00:02:29.048629Z] Running create-virtualenv step. 17:02:29 INFO - Running pre-action listener: _resource_record_pre_action 17:02:29 INFO - Running main action method: create_virtualenv 17:02:29 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:02:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:02:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:02:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:29 INFO - Installing pip...............done. 17:02:29 INFO - Return code: 0 17:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:02:30 INFO - Reading from file tmpfile_stdout 17:02:30 INFO - Output received: 17:02:30 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:02:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:02:30 INFO - Using env: {'DISPLAY': ':0', 17:02:30 INFO - 'HOME': '/home/cltbld', 17:02:30 INFO - 'LANG': 'en_US.UTF-8', 17:02:30 INFO - 'LANGUAGE': 'en_US:en', 17:02:30 INFO - 'LOGNAME': 'cltbld', 17:02:30 INFO - 'MAIL': '/var/mail/cltbld', 17:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:30 INFO - 'MOZ_NO_REMOTE': '1', 17:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:30 INFO - 'NO_EM_RESTART': '1', 17:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:30 INFO - 'PWD': '/builds/slave/test', 17:02:30 INFO - 'SHELL': '/bin/bash', 17:02:30 INFO - 'SHLVL': '1', 17:02:30 INFO - 'TERM': 'linux', 17:02:30 INFO - 'TMOUT': '86400', 17:02:30 INFO - 'USER': 'cltbld', 17:02:30 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:30 INFO - '_': '/tools/buildbot/bin/python'} 17:02:31 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:02:31 INFO - Downloading/unpacking pip>=1.5 17:02:31 INFO - Running setup.py egg_info for package pip 17:02:31 INFO - warning: no files found matching 'pip/cacert.pem' 17:02:31 INFO - warning: no files found matching '*.html' under directory 'docs' 17:02:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:02:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:02:31 INFO - Installing collected packages: pip 17:02:31 INFO - Found existing installation: pip 1.1 17:02:31 INFO - Uninstalling pip: 17:02:31 INFO - Successfully uninstalled pip 17:02:31 INFO - Running setup.py install for pip 17:02:31 INFO - warning: no files found matching 'pip/cacert.pem' 17:02:31 INFO - warning: no files found matching '*.html' under directory 'docs' 17:02:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:02:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:02:31 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:02:31 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:02:31 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:02:31 INFO - Successfully installed pip 17:02:31 INFO - Cleaning up... 17:02:31 INFO - Return code: 0 17:02:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02:31 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')]} 17:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:31 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')]} 17:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:31 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:31 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 17:02:31 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 17:02:31 INFO - Using env: {'DISPLAY': ':0', 17:02:31 INFO - 'HOME': '/home/cltbld', 17:02:31 INFO - 'LANG': 'en_US.UTF-8', 17:02:31 INFO - 'LANGUAGE': 'en_US:en', 17:02:31 INFO - 'LOGNAME': 'cltbld', 17:02:31 INFO - 'MAIL': '/var/mail/cltbld', 17:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:31 INFO - 'MOZ_NO_REMOTE': '1', 17:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:31 INFO - 'NO_EM_RESTART': '1', 17:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:31 INFO - 'PWD': '/builds/slave/test', 17:02:31 INFO - 'SHELL': '/bin/bash', 17:02:31 INFO - 'SHLVL': '1', 17:02:31 INFO - 'TERM': 'linux', 17:02:31 INFO - 'TMOUT': '86400', 17:02:31 INFO - 'USER': 'cltbld', 17:02:31 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:31 INFO - '_': '/tools/buildbot/bin/python'} 17:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:31 INFO - Downloading/unpacking psutil>=3.1.1 17:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:32 INFO - Installing collected packages: psutil 17:02:32 INFO - Running setup.py install for psutil 17:02:32 INFO - building 'psutil._psutil_linux' extension 17:02:32 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 17:02:32 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 17:02:32 INFO - building 'psutil._psutil_posix' extension 17:02:32 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 17:02:33 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 17:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:33 INFO - Successfully installed psutil 17:02:33 INFO - Cleaning up... 17:02:33 INFO - Return code: 0 17:02:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:33 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:33 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 17:02:33 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 17:02:33 INFO - Using env: {'DISPLAY': ':0', 17:02:33 INFO - 'HOME': '/home/cltbld', 17:02:33 INFO - 'LANG': 'en_US.UTF-8', 17:02:33 INFO - 'LANGUAGE': 'en_US:en', 17:02:33 INFO - 'LOGNAME': 'cltbld', 17:02:33 INFO - 'MAIL': '/var/mail/cltbld', 17:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:33 INFO - 'MOZ_NO_REMOTE': '1', 17:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:33 INFO - 'NO_EM_RESTART': '1', 17:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:33 INFO - 'PWD': '/builds/slave/test', 17:02:33 INFO - 'SHELL': '/bin/bash', 17:02:33 INFO - 'SHLVL': '1', 17:02:33 INFO - 'TERM': 'linux', 17:02:33 INFO - 'TMOUT': '86400', 17:02:33 INFO - 'USER': 'cltbld', 17:02:33 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:33 INFO - '_': '/tools/buildbot/bin/python'} 17:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:02:34 INFO - Installing collected packages: mozsystemmonitor 17:02:34 INFO - Running setup.py install for mozsystemmonitor 17:02:34 INFO - Successfully installed mozsystemmonitor 17:02:34 INFO - Cleaning up... 17:02:34 INFO - Return code: 0 17:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:02:34 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')]} 17:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:34 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')]} 17:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:34 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:34 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 17:02:34 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 17:02:34 INFO - Using env: {'DISPLAY': ':0', 17:02:34 INFO - 'HOME': '/home/cltbld', 17:02:34 INFO - 'LANG': 'en_US.UTF-8', 17:02:34 INFO - 'LANGUAGE': 'en_US:en', 17:02:34 INFO - 'LOGNAME': 'cltbld', 17:02:34 INFO - 'MAIL': '/var/mail/cltbld', 17:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:34 INFO - 'MOZ_NO_REMOTE': '1', 17:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:34 INFO - 'NO_EM_RESTART': '1', 17:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:34 INFO - 'PWD': '/builds/slave/test', 17:02:34 INFO - 'SHELL': '/bin/bash', 17:02:34 INFO - 'SHLVL': '1', 17:02:34 INFO - 'TERM': 'linux', 17:02:34 INFO - 'TMOUT': '86400', 17:02:34 INFO - 'USER': 'cltbld', 17:02:34 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:34 INFO - '_': '/tools/buildbot/bin/python'} 17:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:34 INFO - Downloading/unpacking jsonschema==2.5.1 17:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:36 INFO - warning: no files found matching '*.txt' 17:02:36 INFO - no previously-included directories found matching 'build' 17:02:36 INFO - no previously-included directories found matching 'dist' 17:02:36 INFO - no previously-included directories found matching '.git*' 17:02:36 INFO - Installing collected packages: jsonschema, functools32 17:02:36 INFO - Running setup.py install for functools32 17:02:36 INFO - warning: no files found matching '*.txt' 17:02:36 INFO - no previously-included directories found matching 'build' 17:02:36 INFO - no previously-included directories found matching 'dist' 17:02:36 INFO - no previously-included directories found matching '.git*' 17:02:36 INFO - Successfully installed jsonschema functools32 17:02:36 INFO - Cleaning up... 17:02:36 INFO - Return code: 0 17:02:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:36 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:36 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 17:02:36 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 17:02:36 INFO - Using env: {'DISPLAY': ':0', 17:02:36 INFO - 'HOME': '/home/cltbld', 17:02:36 INFO - 'LANG': 'en_US.UTF-8', 17:02:36 INFO - 'LANGUAGE': 'en_US:en', 17:02:36 INFO - 'LOGNAME': 'cltbld', 17:02:36 INFO - 'MAIL': '/var/mail/cltbld', 17:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:36 INFO - 'MOZ_NO_REMOTE': '1', 17:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:36 INFO - 'NO_EM_RESTART': '1', 17:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:36 INFO - 'PWD': '/builds/slave/test', 17:02:36 INFO - 'SHELL': '/bin/bash', 17:02:36 INFO - 'SHLVL': '1', 17:02:36 INFO - 'TERM': 'linux', 17:02:36 INFO - 'TMOUT': '86400', 17:02:36 INFO - 'USER': 'cltbld', 17:02:36 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:36 INFO - '_': '/tools/buildbot/bin/python'} 17:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:02:36 INFO - Cleaning up... 17:02:36 INFO - Return code: 0 17:02:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:36 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:36 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 17:02:36 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 17:02:36 INFO - Using env: {'DISPLAY': ':0', 17:02:36 INFO - 'HOME': '/home/cltbld', 17:02:36 INFO - 'LANG': 'en_US.UTF-8', 17:02:36 INFO - 'LANGUAGE': 'en_US:en', 17:02:36 INFO - 'LOGNAME': 'cltbld', 17:02:36 INFO - 'MAIL': '/var/mail/cltbld', 17:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:36 INFO - 'MOZ_NO_REMOTE': '1', 17:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:36 INFO - 'NO_EM_RESTART': '1', 17:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:36 INFO - 'PWD': '/builds/slave/test', 17:02:36 INFO - 'SHELL': '/bin/bash', 17:02:36 INFO - 'SHLVL': '1', 17:02:36 INFO - 'TERM': 'linux', 17:02:36 INFO - 'TMOUT': '86400', 17:02:36 INFO - 'USER': 'cltbld', 17:02:36 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:36 INFO - '_': '/tools/buildbot/bin/python'} 17:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:36 INFO - Downloading/unpacking blobuploader==1.2.4 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:02:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:38 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 17:02:38 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 17:02:38 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 17:02:38 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 17:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02:38 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 17:02:38 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 17:02:38 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 17:02:38 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 17:02:38 INFO - Downloading docopt-0.6.1.tar.gz 17:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:38 INFO - Running setup.py install for blobuploader 17:02:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:38 INFO - Running setup.py install for requests 17:02:39 INFO - Running setup.py install for docopt 17:02:39 INFO - Successfully installed blobuploader requests docopt 17:02:39 INFO - Cleaning up... 17:02:39 INFO - Return code: 0 17:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:39 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')]} 17:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:39 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')]} 17:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:39 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:39 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 17:02:39 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 17:02:39 INFO - Using env: {'DISPLAY': ':0', 17:02:39 INFO - 'HOME': '/home/cltbld', 17:02:39 INFO - 'LANG': 'en_US.UTF-8', 17:02:39 INFO - 'LANGUAGE': 'en_US:en', 17:02:39 INFO - 'LOGNAME': 'cltbld', 17:02:39 INFO - 'MAIL': '/var/mail/cltbld', 17:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:39 INFO - 'MOZ_NO_REMOTE': '1', 17:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:39 INFO - 'NO_EM_RESTART': '1', 17:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:39 INFO - 'PWD': '/builds/slave/test', 17:02:39 INFO - 'SHELL': '/bin/bash', 17:02:39 INFO - 'SHLVL': '1', 17:02:39 INFO - 'TERM': 'linux', 17:02:39 INFO - 'TMOUT': '86400', 17:02:39 INFO - 'USER': 'cltbld', 17:02:39 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:39 INFO - '_': '/tools/buildbot/bin/python'} 17:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:39 INFO - Running setup.py (path:/tmp/pip-yzONM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:39 INFO - Running setup.py (path:/tmp/pip-lovyAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:39 INFO - Running setup.py (path:/tmp/pip-Gp0S0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:39 INFO - Running setup.py (path:/tmp/pip-eHwHfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:39 INFO - Running setup.py (path:/tmp/pip-qPTM5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:39 INFO - Running setup.py (path:/tmp/pip-QrA8H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:39 INFO - Running setup.py (path:/tmp/pip-JohzIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:40 INFO - Running setup.py (path:/tmp/pip-r6UG5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:40 INFO - Running setup.py (path:/tmp/pip-HRPspi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:40 INFO - Running setup.py (path:/tmp/pip-0xxx_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:40 INFO - Running setup.py (path:/tmp/pip-WJJ9it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:40 INFO - Running setup.py (path:/tmp/pip-fEfNCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:40 INFO - Running setup.py (path:/tmp/pip-VAgzMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:40 INFO - Running setup.py (path:/tmp/pip-hugmkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:40 INFO - Running setup.py (path:/tmp/pip-lGijqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:40 INFO - Running setup.py (path:/tmp/pip-Phzb7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:40 INFO - Running setup.py (path:/tmp/pip-a89FD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:40 INFO - Running setup.py install for manifestparser 17:02:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:40 INFO - Running setup.py install for mozcrash 17:02:40 INFO - Running setup.py install for mozdebug 17:02:41 INFO - Running setup.py install for mozdevice 17:02:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for mozfile 17:02:41 INFO - Running setup.py install for mozhttpd 17:02:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for mozinfo 17:02:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for mozInstall 17:02:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for mozleak 17:02:41 INFO - Running setup.py install for mozlog 17:02:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for moznetwork 17:02:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:41 INFO - Running setup.py install for mozprocess 17:02:41 INFO - Running setup.py install for mozprofile 17:02:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:42 INFO - Running setup.py install for mozrunner 17:02:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:42 INFO - Running setup.py install for mozscreenshot 17:02:42 INFO - Running setup.py install for moztest 17:02:42 INFO - Running setup.py install for mozversion 17:02:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:42 INFO - Cleaning up... 17:02:42 INFO - Return code: 0 17:02:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02: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')]} 17:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02: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')]} 17:02:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:42 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:42 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 17:02:42 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 17:02:42 INFO - Using env: {'DISPLAY': ':0', 17:02:42 INFO - 'HOME': '/home/cltbld', 17:02:42 INFO - 'LANG': 'en_US.UTF-8', 17:02:42 INFO - 'LANGUAGE': 'en_US:en', 17:02:42 INFO - 'LOGNAME': 'cltbld', 17:02:42 INFO - 'MAIL': '/var/mail/cltbld', 17:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:42 INFO - 'MOZ_NO_REMOTE': '1', 17:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:42 INFO - 'NO_EM_RESTART': '1', 17:02:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:42 INFO - 'PWD': '/builds/slave/test', 17:02:42 INFO - 'SHELL': '/bin/bash', 17:02:42 INFO - 'SHLVL': '1', 17:02:42 INFO - 'TERM': 'linux', 17:02:42 INFO - 'TMOUT': '86400', 17:02:42 INFO - 'USER': 'cltbld', 17:02:42 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:42 INFO - '_': '/tools/buildbot/bin/python'} 17:02:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:42 INFO - Running setup.py (path:/tmp/pip-W_Jyfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:42 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)) 17:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:42 INFO - Running setup.py (path:/tmp/pip-eB5NLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:42 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)) 17:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:42 INFO - Running setup.py (path:/tmp/pip-gehG70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:42 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)) 17:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:42 INFO - Running setup.py (path:/tmp/pip-QfGyc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:42 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)) 17:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:42 INFO - Running setup.py (path:/tmp/pip-J_bHgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:43 INFO - Running setup.py (path:/tmp/pip-Smfab8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:43 INFO - Running setup.py (path:/tmp/pip-PSaXfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:43 INFO - Running setup.py (path:/tmp/pip-NE7P5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:43 INFO - Running setup.py (path:/tmp/pip-4IfSX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:43 INFO - Running setup.py (path:/tmp/pip-xTs7WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:43 INFO - Running setup.py (path:/tmp/pip-aBhePk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:43 INFO - Running setup.py (path:/tmp/pip-umPO9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:43 INFO - Running setup.py (path:/tmp/pip-gPF7_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:43 INFO - Running setup.py (path:/tmp/pip-Rm0tx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:43 INFO - Running setup.py (path:/tmp/pip-aPnJeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:43 INFO - Running setup.py (path:/tmp/pip-Y0d_3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:43 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)) 17:02:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:43 INFO - Running setup.py (path:/tmp/pip-pGNQbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:43 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 17:02:43 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 17:02:43 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 17:02:43 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 17:02:45 INFO - Downloading blessings-1.6.tar.gz 17:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:45 INFO - Installing collected packages: blessings 17:02:45 INFO - Running setup.py install for blessings 17:02:45 INFO - Successfully installed blessings 17:02:45 INFO - Cleaning up... 17:02:45 INFO - Return code: 0 17:02:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:45 INFO - Reading from file tmpfile_stdout 17:02:45 INFO - Current package versions: 17:02:45 INFO - argparse == 1.2.1 17:02:45 INFO - blessings == 1.6 17:02:45 INFO - blobuploader == 1.2.4 17:02:45 INFO - docopt == 0.6.1 17:02:45 INFO - functools32 == 3.2.3-2 17:02:45 INFO - jsonschema == 2.5.1 17:02:45 INFO - manifestparser == 1.1 17:02:45 INFO - mozInstall == 1.13 17:02:45 INFO - mozcrash == 1.0 17:02:45 INFO - mozdebug == 0.1 17:02:45 INFO - mozdevice == 0.51 17:02:45 INFO - mozfile == 1.2 17:02:45 INFO - mozhttpd == 0.7 17:02:45 INFO - mozinfo == 0.10 17:02:45 INFO - mozleak == 0.1 17:02:45 INFO - mozlog == 3.5 17:02:45 INFO - moznetwork == 0.27 17:02:45 INFO - mozprocess == 0.25 17:02:45 INFO - mozprofile == 0.28 17:02:45 INFO - mozrunner == 6.13 17:02:45 INFO - mozscreenshot == 0.1 17:02:45 INFO - mozsystemmonitor == 0.3 17:02:45 INFO - moztest == 0.8 17:02:45 INFO - mozversion == 1.4 17:02:45 INFO - psutil == 3.1.1 17:02:45 INFO - requests == 1.2.3 17:02:45 INFO - wsgiref == 0.1.2 17:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:45 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 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02:45 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 17:02:45 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 17:02:45 INFO - Using env: {'DISPLAY': ':0', 17:02:45 INFO - 'HOME': '/home/cltbld', 17:02:45 INFO - 'LANG': 'en_US.UTF-8', 17:02:45 INFO - 'LANGUAGE': 'en_US:en', 17:02:45 INFO - 'LOGNAME': 'cltbld', 17:02:45 INFO - 'MAIL': '/var/mail/cltbld', 17:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:45 INFO - 'MOZ_NO_REMOTE': '1', 17:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:45 INFO - 'NO_EM_RESTART': '1', 17:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:45 INFO - 'PWD': '/builds/slave/test', 17:02:45 INFO - 'SHELL': '/bin/bash', 17:02:45 INFO - 'SHLVL': '1', 17:02:45 INFO - 'TERM': 'linux', 17:02:45 INFO - 'TMOUT': '86400', 17:02:45 INFO - 'USER': 'cltbld', 17:02:45 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:45 INFO - '_': '/tools/buildbot/bin/python'} 17:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 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)) 17:02:45 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:02:45 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 17:02:45 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 17:02:45 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 17:02:45 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 17:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:02:46 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)) 17:02:46 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)) 17:02:46 INFO - Installing collected packages: simplejson 17:02:46 INFO - Running setup.py install for simplejson 17:02:46 INFO - building 'simplejson._speedups' extension 17:02:46 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 17:02:47 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 17:02:47 INFO - Successfully installed simplejson 17:02:47 INFO - Cleaning up... 17:02:47 INFO - Return code: 0 17:02:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02: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')]} 17:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02: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')]} 17:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, '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': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', '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 17:02: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', 'jsonschema'] in /builds/slave/test/build 17:02: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 jsonschema 17:02:47 INFO - Using env: {'DISPLAY': ':0', 17:02:47 INFO - 'HOME': '/home/cltbld', 17:02:47 INFO - 'LANG': 'en_US.UTF-8', 17:02:47 INFO - 'LANGUAGE': 'en_US:en', 17:02:47 INFO - 'LOGNAME': 'cltbld', 17:02:47 INFO - 'MAIL': '/var/mail/cltbld', 17:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:47 INFO - 'MOZ_NO_REMOTE': '1', 17:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:47 INFO - 'NO_EM_RESTART': '1', 17:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:47 INFO - 'PWD': '/builds/slave/test', 17:02:47 INFO - 'SHELL': '/bin/bash', 17:02:47 INFO - 'SHLVL': '1', 17:02:47 INFO - 'TERM': 'linux', 17:02:47 INFO - 'TMOUT': '86400', 17:02:47 INFO - 'USER': 'cltbld', 17:02:47 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:47 INFO - '_': '/tools/buildbot/bin/python'} 17:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:02:48 INFO - Cleaning up... 17:02:48 INFO - Return code: 0 17:02:48 INFO - Running post-action listener: _resource_record_post_action 17:02:48 INFO - Running post-action listener: _start_resource_monitoring 17:02:48 INFO - Starting resource monitoring. 17:02:48 INFO - [mozharness: 2017-08-24 00:02:48.173873Z] Finished create-virtualenv step (success) 17:02:48 INFO - [mozharness: 2017-08-24 00:02:48.174357Z] Running install step. 17:02:48 INFO - Running pre-action listener: _resource_record_pre_action 17:02:48 INFO - Running main action method: install 17:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:48 INFO - Reading from file tmpfile_stdout 17:02:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:48 INFO - Reading from file tmpfile_stdout 17:02:48 INFO - Output received: 17:02:48 INFO - Usage: mozinstall [options] installer 17:02:48 INFO - Options: 17:02:48 INFO - -h, --help show this help message and exit 17:02:48 INFO - -d DEST, --destination=DEST 17:02:48 INFO - Directory to install application into. [default: 17:02:48 INFO - "/builds/slave/test"] 17:02:48 INFO - --app=APP Application being installed. [default: firefox] 17:02:48 INFO - mkdir: /builds/slave/test/build/application 17:02:48 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'] 17:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:03:06 INFO - Reading from file tmpfile_stdout 17:03:06 INFO - Output received: 17:03:06 INFO - /builds/slave/test/build/application/firefox/firefox 17:03:06 INFO - Running post-action listener: _resource_record_post_action 17:03:06 INFO - [mozharness: 2017-08-24 00:03:06.208133Z] Finished install step (success) 17:03:06 INFO - [mozharness: 2017-08-24 00:03:06.208423Z] Running setup-mitmproxy step. 17:03:06 INFO - Running pre-action listener: _resource_record_pre_action 17:03:06 INFO - Running main action method: setup_mitmproxy 17:03:06 INFO - Skipping: mitmproxy is not required 17:03:06 INFO - Running post-action listener: _resource_record_post_action 17:03:06 INFO - [mozharness: 2017-08-24 00:03:06.209688Z] Finished setup-mitmproxy step (success) 17:03:06 INFO - [mozharness: 2017-08-24 00:03:06.209912Z] Running run-tests step. 17:03:06 INFO - Running pre-action listener: _resource_record_pre_action 17:03:06 INFO - Running pre-action listener: _set_gcov_prefix 17:03:06 INFO - Running main action method: run_tests 17:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:03:06 INFO - Python 2.7.3 17:03:06 INFO - Return code: 0 17:03:06 INFO - grabbing minidump binary from tooltool 17:03:06 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')]} 17:03:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0xf6c130>, '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 0xf6d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6d4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:03:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:03:06 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:03:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 17:03:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:03:06 INFO - Return code: 0 17:03:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:03:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:03:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:03:06 INFO - ENV: RUST_BACKTRACE is now full 17:03:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:03:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:03:06 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 17:03:06 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --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 17:03:06 INFO - Using env: {'DISPLAY': ':0', 17:03:06 INFO - 'HOME': '/home/cltbld', 17:03:06 INFO - 'LANG': 'en_US.UTF-8', 17:03:06 INFO - 'LANGUAGE': 'en_US:en', 17:03:06 INFO - 'LOGNAME': 'cltbld', 17:03:06 INFO - 'MAIL': '/var/mail/cltbld', 17:03:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:03:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:03:06 INFO - 'MOZ_NO_REMOTE': '1', 17:03:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:03:06 INFO - 'NO_EM_RESTART': '1', 17:03:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:03:06 INFO - 'PWD': '/builds/slave/test', 17:03:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:03:06 INFO - 'RUST_BACKTRACE': 'full', 17:03:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:03:06 INFO - 'SHELL': '/bin/bash', 17:03:06 INFO - 'SHLVL': '1', 17:03:06 INFO - 'STYLO_FORCE_ENABLED': '1', 17:03:06 INFO - 'TERM': 'linux', 17:03:06 INFO - 'TMOUT': '86400', 17:03:06 INFO - 'USER': 'cltbld', 17:03:06 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1503532916.51220-257334333', 17:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:03:06 INFO - '_': '/tools/buildbot/bin/python'} 17:03:06 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/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--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 17:03:06 INFO - mozversion application_buildid: 20170823230708 17:03:06 INFO - mozversion application_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 17:03:06 INFO - mozversion application_display_name: Nightly 17:03:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:06 INFO - mozversion application_name: Firefox 17:03:06 INFO - mozversion application_remotingname: firefox 17:03:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:03:06 INFO - mozversion application_vendor: Mozilla 17:03:06 INFO - mozversion application_version: 57.0a1 17:03:06 INFO - mozversion platform_buildid: 20170823230708 17:03:06 INFO - mozversion platform_changeset: f0abd25e1f4acced652d180c34b7c9eda638deb1 17:03:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:03:06 INFO - mozversion platform_version: 57.0a1 17:03:06 INFO - using testdate: 1503532986 17:03:06 INFO - actual date: 1503532986 17:03:06 INFO - starting webserver on 'localhost:56131' 17:03:06 INFO - SUITE-START | Running 2 tests 17:03:06 INFO - TEST-START | dromaeo_css 17:03:06 INFO - Initialising browser for dromaeo_css test... 17:03:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56131/getInfo.html -profile /tmp/tmpN7hCZt/profile 17:03:06 INFO - TEST-INFO | started process 25120 (/builds/slave/test/build/application/firefox/firefox http://localhost:56131/getInfo.html) 17:03:12 INFO - TEST-INFO | 25120: exit 0 17:03:13 INFO - Browser initialized. 17:03:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:13 INFO - TEST-INFO | started process 25305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN7hCZt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:14 INFO - PID 25305 | 17:03:14 INFO - PID 25305 | (/builds/slave/test/build/application/firefox/firefox:25354): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:03:14 INFO - PID 25305 | 17:03:14 INFO - PID 25305 | 17:03:14 INFO - PID 25305 | (/builds/slave/test/build/application/firefox/firefox:25414): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:03:14 INFO - PID 25305 | 17:03:14 INFO - PID 25305 | __metrics Screen width/height:1600/1200 17:03:14 INFO - PID 25305 | colorDepth:24 17:03:14 INFO - PID 25305 | Browser inner width/height: 1024/768 17:03:14 INFO - PID 25305 | __metrics 17:03:24 INFO - PID 25305 | RSS: Main: 174301184 17:03:24 INFO - PID 25305 | 17:06:23 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56131/tests/dromaeo/cssquery-ext.html) 17:06:24 INFO - PID 25305 | RSS: Main: 178372608 17:06:24 INFO - PID 25305 | 17:09:26 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-ext.html (next: http://localhost:56131/tests/dromaeo/cssquery-jquery.html) 17:09:26 INFO - PID 25305 | RSS: Main: 175022080 17:09:26 INFO - PID 25305 | 17:12:28 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56131/tests/dromaeo/cssquery-mootools.html) 17:12:29 INFO - PID 25305 | RSS: Main: 177070080 17:12:29 INFO - PID 25305 | 17:15:31 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56131/tests/dromaeo/cssquery-prototype.html) 17:15:31 INFO - PID 25305 | RSS: Main: 175460352 17:15:31 INFO - PID 25305 | 17:18:35 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56131/tests/dromaeo/cssquery-yui.html) 17:18:36 INFO - PID 25305 | RSS: Main: 178855936 17:18:36 INFO - PID 25305 | 17:21:37 INFO - PID 25305 | Cycle 1(1): loaded http://localhost:56131/tests/dromaeo/cssquery-yui.html (next: http://localhost:56131/tests/dromaeo/cssquery-dojo.html) 17:21:38 INFO - PID 25305 | RSS: Main: 177741824 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | __start_tp_report 17:21:38 INFO - PID 25305 | _x_x_mozilla_page_load 17:21:38 INFO - PID 25305 | _x_x_mozilla_page_load_details 17:21:38 INFO - PID 25305 | |i|pagename|runs| 17:21:38 INFO - PID 25305 | |0;dojo.html;3214.7428205743545;3234.5471633971247;3255.0723043932476;3274.0505253476495;3298.9670103298963;6130.386961303868;6308.463780578645;6323.20959880015;6329.272133704625;6331.081993111002;6036.818895433133;6163.476104531121;6164.352742961992;6164.568480206376;6172.7530898764;5654.208410822488;5699.772009119641;5731.914021289663;5737.196792449061;5738.282714660668;5755.309362876461;5785.27684039495;5806.506446952014;5814.09881468371;5830.242068531085;5649.604527683064;5729.770809167629;5733.140028995663;5734.913976290338;5753.597248192628;5537.58468114893;5761.193432919395;5784.566157538202;5824.854378640547;5834;5603.019471592495;5621.522170615503;5649.548036157139;5728.42715728428;5737.684427356494;6095.238095238095;6166.784162554334;6234.688265586702;6236.937630623726;6282.623042617412;6469.417752402306;6505;6521.47828173745;6665.400113989765;6692.096566963446;6741.662916854187;6791.626460544668;6796.35434633709;6798.04827324175;6805.48958828085;6197.659128747872;6285.59143655661;6295.842603934938;6302.842428939267;6305.148804911324;6855;6857.074294970215;6887.173539175231;6949.270326615733;6953.096097507291;6439.484841212692;6517.348265173539;6537.411632952962;6553.803385898431;6619.437347825393;6561.1470508833545;6640.933590664128;6647.700853461606;6680.164979377578;6689.531732778659;6562.639054851934;6643.634600096944;6658.500612454085;6659.633720145439;6663.700133494004;6579.276279609239;6600.438962688129;6602.636854972927;6670.299618540081;6686.4985126115735;5223.451537588575;5257.78968841242;5326.493983071602;5347.919781203285;5369.301990741257;4710.740909250024;4726.929096063562;4738.881527961828;4760.095581839509;4777.546133117348;5775.451332123442;5912.526997840162;5931.258592675916;5931.851703707442;5939.287285525678;6718.05947167397;6732.562383445061;6819.556728812611;6828;6828.078209441662;5733.942660573341;5820.970895145497;5828.737706803204;5830.329512106077;5912.083627037816;5845.123231515222;5846.649201047951;5860.853478663067;5872.207252021008;5874.970625146847;6265.404786545271;6456.483481321483;6458.418742313214;6482.870342593216;6490.188726409199;6638.701258443478;6649.2685804562425;6689.632070235989;6735.797926062226;6748.291429399842;6154.78458253959;6345.270293916259;6352.587081839665;6471.158749362741;6484.708188131451;6606.504512161703;6623.900641490478;6624.6025238485845;6628.867422651423;6629.966850165718;6703.4302084321425;6711.228208756055;6789.796306110825;6796.218434880052;6802.081718967876;6470.158879345843;6478.708458119301;6479.870402591828;6575.506836987341;6584.76953306632;6352.523560732871;6452.935470645233;6476.902846457401;6581.111549940697;6586.769463068769;6383.93616063852;6389.424951754364;6400.935990640221;6404.583702059351;6418.614883107029;6354.841128971812;6492.383223593751;6586.2755096940255;6591.242007169237;6607.867842643216;6208.4722798562625;6269.373062693694;6285.842853928505;6305.779297724557;6353.8729225416155 17:21:38 INFO - PID 25305 | |1;ext.html;785.1089013969147;836.7280633794016;862.9439086459383;865.5585651317828;1117.5082963496056;29317.827286908523;29773.106806795804;37990.240195196115;38716.80641596795;38831.41752873709;39144.412833807444;39437.40843887337;39577.60422395775;39752.80123599378;39868.60131398685;7544.660490277924;7545.84908301835;7758.418118641096;7759.262870027338;7759.844803103934;7572.469927105105;7618.123915749677;7699.230076992284;7699.538027718327;7701.306882380584;7639.618019099023;7643.503172293811;7665.1951545087795;7700.4609677322605;7723.922760772404;7657.655405506738;7664.65509052094;7700.191479894586;7709.460337776358;7711.691532338699;7577.052868391451;7640.197779233156;7644;7648.579328136951;7654.158042615308;35653.82173089118;36025.81987090048;36084.458733118765;36146.81926590377;36148.45777313316;3426.1434641339665;3456.6197718250974;3461.6019157796923;3464.8960531184107;3469.2541103662834;29246.853765731248;29339;29344;29471.115866523825;29615.25961850971;4818.951810481885;4953.628477864175;5021.297018417425;5067.974660126676;5160.122779127557;178450;178478.10760946243;178577;179241;179250;45454.09091818211;45553.77223113863;45664.5433545667;45676;45680;49683.503164967886;50810;50817.745911270205;50859.49140508621;50883.236751448756;12562;12802;15958.840411595967;16083.597910052109;16096.356145754038;12980.610581682564;13159.342032898317;13242.20546767197;13284.07011509185;13296.667583310495;13600.319984000958;13741;13782.93108534451;13812.309384530734;13854.445822167201;5537.612367134342;5618.4662457066515;5653.462921022497;5653.773849046074;5678.829635110953;976.8632391465201;993.9105480506789;997.680742162501;1002.2433063037506;1010.9090181883665;21741.456463588536;21831.781682182977;22093.226737064124;22149;22519.324420267418;1021.6883850425692;1049.3651340938775;1057.9894201057891;1060.5015642647943;1069.4492336446735;11171.050460710769;11566.65300041;11614.128940329509;11620.883791162149;11657.300561966309;220407;222047;222278;222763;222956;47839.282410763866;48097.519024809306;48134.27798583024;48225.27662085072;48305.27542086872;1347.063790665478;1389.5831250624772;1400.9719805603627;1403.0529392659914;1405.2341473896752;20941.58116837685;20993.160273588885;21275.68086478735;21646.24238151657;21682;33728.66271337353;33810.66189338174;33975.66024339725;34052.82973585116;34326.48510272298;190514;191059.0447047756;191154;191943;192348;31626.209344766565;34753.65246347504;35605.46591801177;35723.64276357203;35726.28547429089;42770.144597108505;43060;43064;43126.78436607797;43170.784146079066;31945.840270798497;32184;32535.349293013533;32539;32792.67207327896;31600.683993159775;31704.682953171097;31741.8412907934;31839.36321273608;32008.67991320057;34565.82717086399;34619.4807077889;34649.30701386009;34672.82663586666;34830.65169348274;30895;30901.69098309078;30907.84546077255;31121.8443907779;31161.688383115878;22787.544249115257;23448.880127047145;23451.41371465727;23722.406939826644;23741.64387534154 17:21:38 INFO - PID 25305 | |2;jquery.html;544.9482697643373;545.0760960172506;548.3995025447134;549.7898448238083;551.5119119579173;21433.249836255734;22088.447788805246;22103.889480552596;22170.88914555427;22286;24377.878110609465;24665.383365415873;24765.380865478328;24786.75213247867;24827.875860620672;6487;6603.042558828967;6603.14159159311;6609.93390066098;6635.635040072794;5980.43185897339;6469.93530064698;6473.579217350881;6497.935020649804;6505.4145126938565;6437.130987316699;6461.386168314003;6461.547691661585;6462.967685161591;6465.030245463171;6437.130987316746;6454.548181627288;6455.096286519891;6455.289918109004;6480.870382592346;6010.489108425789;6016.96991515044;6018.097285407181;6031.638101713867;6047.395260473962;27706.861465692542;28192.577111343347;30499.542506862414;31553.684463155532;31718.207044823834;2077.896105194734;2129.765725770164;2131.531063166101;2131.9467013324793;2137.9893100534555;20206.595868082703;20455.386338409873;20809.479763006046;21224.363269101952;21253.149874005023;2483.490884368718;2485.22957883055;2498.6127150291554;2498.962515562268;2571.6014017827265;136948;139853;140217.2989135058;140852;140983;20016.69974950377;20591.8970405147;20867.686984695243;20963.475913102295;21363.465913351978;42174.367384489255;42305.15389692189;42360;42391.7880410596;42438.78780606077;11237.943810280896;11328.32030078198;11406.574178227722;11473.885261147449;11588.47851846652;8150.75547733569;8567.357448191411;9245.583948722324;9422.952885235667;9584.0415958405;10953.616623418142;11558;11597.826032609517;11655.18413711032;11800;4224.260754367973;4302.182585308781;4314.317416207681;4317.956820431756;4345.956540434619;950.4629884115591;954.370115723619;955.7562821480478;968.3463662028103;972.1396564040733;19368.8063119367;19675.508112297306;19725.210991560463;19842.404727858186;20002.399808015325;1011.1405305490274;1026.8870424253325;1031.6079889641887;1042.3016578892161;1043.7651528406047;10659.786804263871;10814.405207713651;11072.557097716162;11145.052670522935;11173.664790056311;450144;456474;492828;498291.5085424622;502805;110066;115373;116779;117925.4103729493;118006;1213.969650758738;1218.1594699657207;1254.8243245945575;1255.1465003797323;1258.6790368455986;20526.486837829172;20786.27248046311;20964.790352096894;20999;21241.575168496853;56176.71911640416;56229.71885140548;56493.43506564882;57575;57932;71033.64483177551;72745;72829.27170728226;73199;73499.63250183714;11912.642620721392;12426;13664.316784160554;14180.723734863912;14670.706585868009;22643.88678056599;22897.65653515165;22983.88508057516;23054.308370748906;23069.769302306762;17921.820781792536;17937.37219197322;18193.272269109086;18210.36263730763;18315.450536483928;16318.510444686679;16981.575460613585;17409.303627854744;17573.03348315855;17629.20668569892;19211.807881921563;19793.703094453307;19884.403467895987;19896.801031989497;19941.302054428026;14403.927980360031;14568.417263309773;14583.92708036453;14600.342984565932;14600.780988285396;18301.176447059646;19514.60970780548;19528;19556.706649400556;19570.31503897414 17:21:38 INFO - PID 25305 | |3;mootools.html;1320.188084328138;1369.9383527741252;1371.6982263901943;1372.876441120299;1378.0698028830543;14513.709725805478;14629.195394253338;15117.697646047072;15123.92438037811;15146.394144234217;15158.772618410705;15427.074375537475;15441.227938603053;15456.459023934165;15496.380144794222;2740.5478096114116;2781.7496425321715;2782.3183320086605;2783.5685468752376;2785;2593.48130373925;2599.155274535774;2638.617400476939;2671.42564348665;2783.9304017399522;2732.2076597786618;2762.2265765585566;2762.4889395461905;2762.709915458868;2773.1680495851265;2633.7629613334702;2634.8023898207616;2642.669666291723;2664.320598247444;2687.48937701838;2485.2792690120023;2509.1970569417795;2509.6737424134926;2641.841489510616;2698.63568418263;14556.126632402089;14688.485902993343;14690.485832995793;14691.11853288806;14701.632459188499;7844.0979287382115;8086.757397278091;8105.797355066112;8109.797255068612;8112.148224436408;5210.635255532115;5298;5502.0921547944545;5514.200440936082;5528.612997090206;1863.850891928656;1917.9136938837785;1923.8749481283812;1972.5660354721938;1974.2892558678864;24876.626850597255;25034.624480632807;25044.874775626005;25112;25123.874380627978;6555.147830781968;7220.819479512949;7279.5996220207335;7510.248975102446;7517.17311095779;16600.83399166017;16759.664806703797;16767.748483772753;16771.832281677027;16780.748288775678;7852.960735196288;7922.128565857751;7955.24425179607;7972.202779721982;7984.441089123822;7075.575465472089;7228.927710722931;7284.70861165558;7288.781336559911;7339.229380915034;5087.949120508822;5236.554892834151;5287.576993840484;5315.787368505294;5352.545033672103;1354.0453979944116;1363.9522616708368;1501.5345242974495;1518.8101487314086;1528.740114180592;898.766320756608;922.6770630279349;927.865459508381;931.0549791961165;941.5198248892976;8061.959690201629;8396.538190399464;8447.113053129457;8454.915450845536;8512.404131710844;983.4836710726782;986.0927946289431;993.1260490768078;1018.7198520406947;1019.6380284998867;5030.949690503121;5157.277981082651;5160.303359046556;5192.480751924777;5309.814156504503;19767.703484447746;20284.188632454538;20501;20512.179512819617;20878.895605521877;20301.898490507454;20561.48596285105;20587.691184632244;20701;20784.27255046066;10858.837117443245;10977.506012229469;11095.667129986114;11099.112071034137;11151.944240278908;8401.915980840358;8442.282405995558;8489.533075680896;8529.402941794015;8535.146485351415;17845.821541784415;17854.839435436654;17875.28498860031;17934.5516362092;18149.81850181534;18206.544836379195;18377.632447351247;18377.816221838144;18473.53816154553;18562.814371856108;10813.837792433276;10833.566657333933;10917.508712107816;10983.286086404678;10991.175661825555;12066.396680166132;13448.26034568069;13532.864671353555;13571.321433928066;13641.795373069213;9842.21262299;10295.433751143759;10331.638392656221;10463.476826158509;10465.319754215952;10848.620298289521;10892.891071089505;10995.065419439437;11102.500387482422;11241.60654377093;9475.47884866339;9605.087516685904;9607.375520591138;9611.711648650551;9613.567389467631;7487.138979017265;7505;7518.849623007619;7541.321281084729;7610.429217808576;6861.313868613099;6996.195437524546;7133.714651413885;7178.133685241979;7226.421886248982 17:21:38 INFO - PID 25305 | |4;prototype.html;496.30517275813855;497.21191910821346;512.5566385076909;522.4175044825021;523.3719536556133;6059.878802423949;6166.876662466748;6238.4385405313515;6256.655883926388;6280.748770049198;6118.571699980992;6139.81580552583;6172;6208.192934918466;6249.843753906154;4874.415070191582;4973.154563724175;5091.338126043609;5121.436641969381;5145.485451454862;4965.677230979974;4973.950260497385;4980.630326660179;4981.427135879384;5005.373253692546;4886.193778026622;4947.233178857283;4953.306537084811;4995.825146119886;4998.225275082368;4984.457926457497;5001.599552125411;5041.865580244453;5045.738565358661;5069.974650126763;4473.194824931511;4497.842575509874;4519.457665080178;4526.140033393677;4528.75091869947;6055;6111.358307377705;6127.6017058891475;6154.169187159766;6171.814845554641;5636.126400407943;5646.830595082154;5661.943380566183;5691.288588926384;5703.572232082569;6486.189226346707;6509.4466970307585;6549.312322206148;6587.341265873374;6618;4792.856214313576;4813.470518242991;4836.347093142451;4841.564259216688;4854.538818812207;6652.168478940132;6653.401193892573;6744.460443164584;6931.757388491378;7029.472789540754;5387.4073851876265;5407.729613519308;5409;5439.48324909141;5461.836144915659;5489.478499542537;5501.367342755634;5504.4495550444635;5525.972370138124;5584.385717571064;5927.4665280125;5977.731002104916;5982.1325907744;6016.849578760566;6026.367231440723;6568.507361947873;6623.311055680771;6629.337066293332;6637.971114477264;6723.361280678328;1917.36726880132;1928.23834585338;1928.9228430862888;1936.7772706138974;1943;1322.3388305847077;1401.7056418152301;1411.4918629293445;1421.2254321394657;1443.1196969848384;5656.660600363909;5703.971480142655;5738.799142030009;5766.625169364062;5787.334456537468;6625.86748265032;6627.602343859384;6651.833704157435;6726.899096513556;6736.93263067363;5659.462351076641;5821.18503409523;5872.442117998783;5879.559033072536;5920.822375328747;3573.0174202094113;3584.318979393907;3594.964050359515;3605.116746397097;3630.0561853917643;6428.0357946307495;6460.353964603502;6499.252585952581;6501.642409667514;6513.73945042193;6792;6900.89585666291;6921.688524016431;6924.861502769916;6988.336108069725;6401.9039714404325;6423.389777971085;6466.644334561644;6476.676166191672;6521.739130434729;6695.163104611924;6716.865662686817;6721.966390168018;6750.696218670073;6766.763163289262;6603.7688680895935;6630.966845165936;6644.534882558174;6706.66466676674;6719.764808231884;6298.527610429328;6313.09597585116;6370.522210834299;6403.8867173831595;6472.093906852951;5414.945850541444;5416.783328666967;5446.183072539151;5450.618456707993;5461.15352120422;6529.347065293623;6567.507436942153;6624.503162262946;6630.336966303331;6654.5341826073645;6483.351664833479;6506.577072490462;6509.902351464637;6524.249711283073;6588.538802283986;6449.4840412765925;6474.708638111202;6546.672666366568;6558.737650493927;6571.605703657796;6410.391012853772;6434.131392262172;6447.807745366598;6451.225852897494;6470.838229044311;6537.771178008747;6583.670816459254;6592.494851956226;6641.634710090992;6650.168728908887;6310.179676642191;6367.90448143269;6409.615423074631;6468.741250349934;6481.837954050998 17:21:38 INFO - PID 25305 | |5;yui.html;864.1660797330575;873.2969959182859;898.2409863665209;899.6401439424227;902.0438335364514;17240.56898577536;18032.18855151518;18136.99999999998;18175.363862264825;20901.581968360624;19832.305869294578;20558.0748866301;20582.794172058275;20608;20646.587068258625;883.5273128876037;906.8141031088611;910.9863352049691;911.0388540090203;911.2026976395621;909.9590518426687;942.1191186240852;953.213598781005;959.1655259923841;961.1733908838394;995.3331268050424;1008.9495525223746;1009.1573536097368;1009.2682804966414;1009.581023875091;1002.8245057115012;1006.8036732837099;1007.5566750629773;1008.2538921198334;1009.1876039787932;738.5900825042099;740.7222291640635;741.929516695913;742.3838214282133;743.9070116235471;18097.004664743436;18598;19154;19349.322773702854;19385.4184374469;18689.62620747591;18765.437036888914;19168.233270669156;19234.615307693766;19774.901125494423;15066.171360575165;15526.301316440788;15772.369105235777;15780.842191578167;15802.762958555631;3557.146284891633;3611.94582081269;3618.095476130967;3618.7285953553587;3619.7285203609836;123179;125512.37243813723;127606;128147;129118.3544082283;12939.870601294055;13034.80447793284;13233.53682621123;13237.933810330887;13264.73470530584;26054.869725651628;26556.60165097525;26626.467470650477;26664.73335266661;26792;7043.929560704328;7465.664045117983;7578.09062912454;8353.498790072494;8516.574171291411;3972.5431575368625;4064.349704047338;4068.7762173080764;4069.959300407017;4070.75575465473;4692.155412025868;4801.975990120027;4822.156122678587;5418.783248670009;5593.636413633101;982.4203719805349;995.124290624246;1009.8333774927202;1012.2559918459926;1015.2487159501916;617.4319625944053;635.1203583037526;638.4286063972811;647.6923461355818;650.6616559389091;11319.264247823865;13487.527936522174;13560.389782459813;13604.523841665494;13659.248741319323;677.8847595908609;685.044363113454;685.7325642999234;694.4895501806168;706.6396137969673;5430.891382172414;5479.780808767684;5542;5570.275864137717;5590.972045139748;106578;107236.46381768041;108154.45922770335;108521;111602.44198778954;87278.56360718155;90053;91193;93498;94228.05771942192;79209.72158375445;80292.59853700694;82136.58931705423;83105;85404.57297713471;10519.94740026295;10600.4699765013;10707.965486557528;10823.512941917475;10871.891281087088;36781;38455;38569.42145867758;39315.60684393119;40224.798876005436;50126.74936625439;50522;51233.743831280604;51427.228591571904;52170.47829521808;15036.774448383065;15303.923480382527;15329.693406132037;15445.459408920633;15549.067055976677;17278.395256165975;17425.302987880343;17451.214695338487;17534;17580.73628895593;15972.12153331578;16035.358585656442;16290.3483860649;16324.918375408522;16466.341346346013;15781.684366312838;15827.129507877178;15875.444359447363;15947.282372293042;15991.280392382603;15739.921300393426;15764.132972686612;15872.682546349239;15887.602809929382;16045.197740112713;11956.58151964677;11960.58137965167;12097.637070887888;12360.196587221802;12400.937995309965;12172.513099476277;12297.815532766837;12327.137100402886;12489.687757805765;12611.43248553799 17:21:38 INFO - PID 25305 | __end_tp_report 17:21:38 INFO - PID 25305 | __start_cc_report 17:21:38 INFO - PID 25305 | _x_x_mozilla_cycle_collect,388 17:21:38 INFO - PID 25305 | __end_cc_report 17:21:38 INFO - PID 25305 | __startTimestamp1503534098185__endTimestamp 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | ------- Summary: start ------- 17:21:38 INFO - PID 25305 | Number of tests: 6 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#0] dojo.html Cycles:165 Average:6151.87 Median:6352.52 stddev:704.12 (11.1%) stddev-sans-first:667.51 17:21:38 INFO - PID 25305 | Values: 3214.7 3234.5 3255.1 3274.1 3299.0 6130.4 6308.5 6323.2 6329.3 6331.1 6036.8 6163.5 6164.4 6164.6 6172.8 5654.2 5699.8 5731.9 5737.2 5738.3 5755.3 5785.3 5806.5 5814.1 5830.2 5649.6 5729.8 5733.1 5734.9 5753.6 5537.6 5761.2 5784.6 5824.9 5834.0 5603.0 5621.5 5649.5 5728.4 5737.7 6095.2 6166.8 6234.7 6236.9 6282.6 6469.4 6505.0 6521.5 6665.4 6692.1 6741.7 6791.6 6796.4 6798.0 6805.5 6197.7 6285.6 6295.8 6302.8 6305.1 6855.0 6857.1 6887.2 6949.3 6953.1 6439.5 6517.3 6537.4 6553.8 6619.4 6561.1 6640.9 6647.7 6680.2 6689.5 6562.6 6643.6 6658.5 6659.6 6663.7 6579.3 6600.4 6602.6 6670.3 6686.5 5223.5 5257.8 5326.5 5347.9 5369.3 4710.7 4726.9 4738.9 4760.1 4777.5 5775.5 5912.5 5931.3 5931.9 5939.3 6718.1 6732.6 6819.6 6828.0 6828.1 5733.9 5821.0 5828.7 5830.3 5912.1 5845.1 5846.6 5860.9 5872.2 5875.0 6265.4 6456.5 6458.4 6482.9 6490.2 6638.7 6649.3 6689.6 6735.8 6748.3 6154.8 6345.3 6352.6 6471.2 6484.7 6606.5 6623.9 6624.6 6628.9 6630.0 6703.4 6711.2 6789.8 6796.2 6802.1 6470.2 6478.7 6479.9 6575.5 6584.8 6352.5 6452.9 6476.9 6581.1 6586.8 6383.9 6389.4 6400.9 6404.6 6418.6 6354.8 6492.4 6586.3 6591.2 6607.9 6208.5 6269.4 6285.8 6305.8 6353.9 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#1] ext.html Cycles:180 Average:35966.79 Median:18876.31 stddev:51320.62 (271.9%) stddev-sans-first:51396.60 17:21:38 INFO - PID 25305 | Values: 785.1 836.7 862.9 865.6 1117.5 29317.8 29773.1 37990.2 38716.8 38831.4 39144.4 39437.4 39577.6 39752.8 39868.6 7544.7 7545.8 7758.4 7759.3 7759.8 7572.5 7618.1 7699.2 7699.5 7701.3 7639.6 7643.5 7665.2 7700.5 7723.9 7657.7 7664.7 7700.2 7709.5 7711.7 7577.1 7640.2 7644.0 7648.6 7654.2 35653.8 36025.8 36084.5 36146.8 36148.5 3426.1 3456.6 3461.6 3464.9 3469.3 29246.9 29339.0 29344.0 29471.1 29615.3 4819.0 4953.6 5021.3 5068.0 5160.1 178450.0 178478.1 178577.0 179241.0 179250.0 45454.1 45553.8 45664.5 45676.0 45680.0 49683.5 50810.0 50817.7 50859.5 50883.2 12562.0 12802.0 15958.8 16083.6 16096.4 12980.6 13159.3 13242.2 13284.1 13296.7 13600.3 13741.0 13782.9 13812.3 13854.4 5537.6 5618.5 5653.5 5653.8 5678.8 976.9 993.9 997.7 1002.2 1010.9 21741.5 21831.8 22093.2 22149.0 22519.3 1021.7 1049.4 1058.0 1060.5 1069.4 11171.1 11566.7 11614.1 11620.9 11657.3 220407.0 222047.0 222278.0 222763.0 222956.0 47839.3 48097.5 48134.3 48225.3 48305.3 1347.1 1389.6 1401.0 1403.1 1405.2 20941.6 20993.2 21275.7 21646.2 21682.0 33728.7 33810.7 33975.7 34052.8 34326.5 190514.0 191059.0 191154.0 191943.0 192348.0 31626.2 34753.7 35605.5 35723.6 35726.3 42770.1 43060.0 43064.0 43126.8 43170.8 31945.8 32184.0 32535.3 32539.0 32792.7 31600.7 31704.7 31741.8 31839.4 32008.7 34565.8 34619.5 34649.3 34672.8 34830.7 30895.0 30901.7 30907.8 31121.8 31161.7 22787.5 23448.9 23451.4 23722.4 23741.6 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#2] jquery.html Cycles:180 Average:35524.93 Median:21760.85 stddev:81102.30 (372.7%) stddev-sans-first:81287.29 17:21:38 INFO - PID 25305 | Values: 544.9 545.1 548.4 549.8 551.5 21433.2 22088.4 22103.9 22170.9 22286.0 24377.9 24665.4 24765.4 24786.8 24827.9 6487.0 6603.0 6603.1 6609.9 6635.6 5980.4 6469.9 6473.6 6497.9 6505.4 6437.1 6461.4 6461.5 6463.0 6465.0 6437.1 6454.5 6455.1 6455.3 6480.9 6010.5 6017.0 6018.1 6031.6 6047.4 27706.9 28192.6 30499.5 31553.7 31718.2 2077.9 2129.8 2131.5 2131.9 2138.0 20206.6 20455.4 20809.5 21224.4 21253.1 2483.5 2485.2 2498.6 2499.0 2571.6 136948.0 139853.0 140217.3 140852.0 140983.0 20016.7 20591.9 20867.7 20963.5 21363.5 42174.4 42305.2 42360.0 42391.8 42438.8 11237.9 11328.3 11406.6 11473.9 11588.5 8150.8 8567.4 9245.6 9423.0 9584.0 10953.6 11558.0 11597.8 11655.2 11800.0 4224.3 4302.2 4314.3 4318.0 4346.0 950.5 954.4 955.8 968.3 972.1 19368.8 19675.5 19725.2 19842.4 20002.4 1011.1 1026.9 1031.6 1042.3 1043.8 10659.8 10814.4 11072.6 11145.1 11173.7 450144.0 456474.0 492828.0 498291.5 502805.0 110066.0 115373.0 116779.0 117925.4 118006.0 1214.0 1218.2 1254.8 1255.1 1258.7 20526.5 20786.3 20964.8 20999.0 21241.6 56176.7 56229.7 56493.4 57575.0 57932.0 71033.6 72745.0 72829.3 73199.0 73499.6 11912.6 12426.0 13664.3 14180.7 14670.7 22643.9 22897.7 22983.9 23054.3 23069.8 17921.8 17937.4 18193.3 18210.4 18315.5 16318.5 16981.6 17409.3 17573.0 17629.2 19211.8 19793.7 19884.4 19896.8 19941.3 14403.9 14568.4 14583.9 14600.3 14600.8 18301.2 19514.6 19528.0 19556.7 19570.3 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#3] mootools.html Cycles:180 Average:9110.01 Median:2616.46 stddev:6342.12 (242.4%) stddev-sans-first:6332.90 17:21:38 INFO - PID 25305 | Values: 1320.2 1369.9 1371.7 1372.9 1378.1 14513.7 14629.2 15117.7 15123.9 15146.4 15158.8 15427.1 15441.2 15456.5 15496.4 2740.5 2781.7 2782.3 2783.6 2785.0 2593.5 2599.2 2638.6 2671.4 2783.9 2732.2 2762.2 2762.5 2762.7 2773.2 2633.8 2634.8 2642.7 2664.3 2687.5 2485.3 2509.2 2509.7 2641.8 2698.6 14556.1 14688.5 14690.5 14691.1 14701.6 7844.1 8086.8 8105.8 8109.8 8112.1 5210.6 5298.0 5502.1 5514.2 5528.6 1863.9 1917.9 1923.9 1972.6 1974.3 24876.6 25034.6 25044.9 25112.0 25123.9 6555.1 7220.8 7279.6 7510.2 7517.2 16600.8 16759.7 16767.7 16771.8 16780.7 7853.0 7922.1 7955.2 7972.2 7984.4 7075.6 7228.9 7284.7 7288.8 7339.2 5087.9 5236.6 5287.6 5315.8 5352.5 1354.0 1364.0 1501.5 1518.8 1528.7 898.8 922.7 927.9 931.1 941.5 8062.0 8396.5 8447.1 8454.9 8512.4 983.5 986.1 993.1 1018.7 1019.6 5030.9 5157.3 5160.3 5192.5 5309.8 19767.7 20284.2 20501.0 20512.2 20878.9 20301.9 20561.5 20587.7 20701.0 20784.3 10858.8 10977.5 11095.7 11099.1 11151.9 8401.9 8442.3 8489.5 8529.4 8535.1 17845.8 17854.8 17875.3 17934.6 18149.8 18206.5 18377.6 18377.8 18473.5 18562.8 10813.8 10833.6 10917.5 10983.3 10991.2 12066.4 13448.3 13532.9 13571.3 13641.8 9842.2 10295.4 10331.6 10463.5 10465.3 10848.6 10892.9 10995.1 11102.5 11241.6 9475.5 9605.1 9607.4 9611.7 9613.6 7487.1 7505.0 7518.8 7541.3 7610.4 6861.3 6996.2 7133.7 7178.1 7226.4 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#4] prototype.html Cycles:180 Average:5562.40 Median:6146.99 stddev:1507.89 (24.5%) stddev-sans-first:1463.39 17:21:38 INFO - PID 25305 | Values: 496.3 497.2 512.6 522.4 523.4 6059.9 6166.9 6238.4 6256.7 6280.7 6118.6 6139.8 6172.0 6208.2 6249.8 4874.4 4973.2 5091.3 5121.4 5145.5 4965.7 4974.0 4980.6 4981.4 5005.4 4886.2 4947.2 4953.3 4995.8 4998.2 4984.5 5001.6 5041.9 5045.7 5070.0 4473.2 4497.8 4519.5 4526.1 4528.8 6055.0 6111.4 6127.6 6154.2 6171.8 5636.1 5646.8 5661.9 5691.3 5703.6 6486.2 6509.4 6549.3 6587.3 6618.0 4792.9 4813.5 4836.3 4841.6 4854.5 6652.2 6653.4 6744.5 6931.8 7029.5 5387.4 5407.7 5409.0 5439.5 5461.8 5489.5 5501.4 5504.4 5526.0 5584.4 5927.5 5977.7 5982.1 6016.8 6026.4 6568.5 6623.3 6629.3 6638.0 6723.4 1917.4 1928.2 1928.9 1936.8 1943.0 1322.3 1401.7 1411.5 1421.2 1443.1 5656.7 5704.0 5738.8 5766.6 5787.3 6625.9 6627.6 6651.8 6726.9 6736.9 5659.5 5821.2 5872.4 5879.6 5920.8 3573.0 3584.3 3595.0 3605.1 3630.1 6428.0 6460.4 6499.3 6501.6 6513.7 6792.0 6900.9 6921.7 6924.9 6988.3 6401.9 6423.4 6466.6 6476.7 6521.7 6695.2 6716.9 6722.0 6750.7 6766.8 6603.8 6631.0 6644.5 6706.7 6719.8 6298.5 6313.1 6370.5 6403.9 6472.1 5414.9 5416.8 5446.2 5450.6 5461.2 6529.3 6567.5 6624.5 6630.3 6654.5 6483.4 6506.6 6509.9 6524.2 6588.5 6449.5 6474.7 6546.7 6558.7 6571.6 6410.4 6434.1 6447.8 6451.2 6470.8 6537.8 6583.7 6592.5 6641.6 6650.2 6310.2 6367.9 6409.6 6468.7 6481.8 17:21:38 INFO - PID 25305 | 17:21:38 INFO - PID 25305 | [#5] yui.html Cycles:180 Average:22039.10 Median:19803.60 stddev:30890.79 (156.0%) stddev-sans-first:30936.53 17:21:38 INFO - PID 25305 | Values: 864.2 873.3 898.2 899.6 902.0 17240.6 18032.2 18137.0 18175.4 20901.6 19832.3 20558.1 20582.8 20608.0 20646.6 883.5 906.8 911.0 911.0 911.2 910.0 942.1 953.2 959.2 961.2 995.3 1008.9 1009.2 1009.3 1009.6 1002.8 1006.8 1007.6 1008.3 1009.2 738.6 740.7 741.9 742.4 743.9 18097.0 18598.0 19154.0 19349.3 19385.4 18689.6 18765.4 19168.2 19234.6 19774.9 15066.2 15526.3 15772.4 15780.8 15802.8 3557.1 3611.9 3618.1 3618.7 3619.7 123179.0 125512.4 127606.0 128147.0 129118.4 12939.9 13034.8 13233.5 13237.9 13264.7 26054.9 26556.6 26626.5 26664.7 26792.0 7043.9 7465.7 7578.1 8353.5 8516.6 3972.5 4064.3 4068.8 4070.0 4070.8 4692.2 4802.0 4822.2 5418.8 5593.6 982.4 995.1 1009.8 1012.3 1015.2 617.4 635.1 638.4 647.7 650.7 11319.3 13487.5 13560.4 13604.5 13659.2 677.9 685.0 685.7 694.5 706.6 5430.9 5479.8 5542.0 5570.3 5591.0 106578.0 107236.5 108154.5 108521.0 111602.4 87278.6 90053.0 91193.0 93498.0 94228.1 79209.7 80292.6 82136.6 83105.0 85404.6 10519.9 10600.5 10708.0 10823.5 10871.9 36781.0 38455.0 38569.4 39315.6 40224.8 50126.7 50522.0 51233.7 51427.2 52170.5 15036.8 15303.9 15329.7 15445.5 15549.1 17278.4 17425.3 17451.2 17534.0 17580.7 15972.1 16035.4 16290.3 16324.9 16466.3 15781.7 15827.1 15875.4 15947.3 15991.3 15739.9 15764.1 15872.7 15887.6 16045.2 11956.6 11960.6 12097.6 12360.2 12400.9 12172.5 12297.8 12327.1 12489.7 12611.4 17:21:38 INFO - PID 25305 | -------- Summary: end -------- 17:21:38 INFO - PID 25305 | 17:21:38 INFO - TEST-INFO | 25305: exit 0 17:21:38 INFO - TEST-OK | dromaeo_css | took 1112353ms 17:21:38 INFO - TEST-START | kraken 17:21:38 INFO - Initialising browser for kraken test... 17:21:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56131/getInfo.html -profile /tmp/tmpDenovk/profile 17:21:38 INFO - TEST-INFO | started process 25727 (/builds/slave/test/build/application/firefox/firefox http://localhost:56131/getInfo.html) 17:21:44 INFO - TEST-INFO | 25727: exit 0 17:21:45 INFO - Browser initialized. 17:21:45 INFO - Running cycle 1/1 for kraken test... 17:21:45 INFO - TEST-INFO | started process 25914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDenovk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:45 INFO - PID 25914 | 17:21:45 INFO - PID 25914 | (/builds/slave/test/build/application/firefox/firefox:25964): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:21:45 INFO - PID 25914 | 17:21:46 INFO - PID 25914 | 17:21:46 INFO - PID 25914 | (/builds/slave/test/build/application/firefox/firefox:26023): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:21:46 INFO - PID 25914 | 17:21:46 INFO - PID 25914 | __metrics Screen width/height:1600/1200 17:21:46 INFO - PID 25914 | colorDepth:24 17:21:46 INFO - PID 25914 | Browser inner width/height: 1024/768 17:21:46 INFO - PID 25914 | __metrics 17:21:56 INFO - PID 25914 | RSS: Main: 174555136 17:21:56 INFO - PID 25914 | 17:21:58 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56131/tests/kraken/driver.html?testName=audio-beat-detection) 17:21:59 INFO - PID 25914 | RSS: Main: 178880512 17:21:59 INFO - PID 25914 | 17:22:02 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56131/tests/kraken/driver.html?testName=audio-dft) 17:22:03 INFO - PID 25914 | RSS: Main: 180801536 17:22:03 INFO - PID 25914 | 17:22:06 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56131/tests/kraken/driver.html?testName=audio-fft) 17:22:06 INFO - PID 25914 | RSS: Main: 174133248 17:22:06 INFO - PID 25914 | 17:22:09 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56131/tests/kraken/driver.html?testName=audio-oscillator) 17:22:09 INFO - PID 25914 | RSS: Main: 175058944 17:22:09 INFO - PID 25914 | 17:22:12 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56131/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:12 INFO - PID 25914 | RSS: Main: 175423488 17:22:12 INFO - PID 25914 | 17:22:15 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56131/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:16 INFO - PID 25914 | RSS: Main: 176590848 17:22:16 INFO - PID 25914 | 17:22:20 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56131/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:20 INFO - PID 25914 | RSS: Main: 176279552 17:22:20 INFO - PID 25914 | 17:22:23 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56131/tests/kraken/driver.html?testName=json-parse-financial) 17:22:24 INFO - PID 25914 | RSS: Main: 176295936 17:22:24 INFO - PID 25914 | 17:22:25 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56131/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:26 INFO - PID 25914 | RSS: Main: 177090560 17:22:26 INFO - PID 25914 | 17:22:28 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:29 INFO - PID 25914 | RSS: Main: 177012736 17:22:29 INFO - PID 25914 | 17:22:31 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:31 INFO - PID 25914 | RSS: Main: 176549888 17:22:31 INFO - PID 25914 | 17:22:34 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:35 INFO - PID 25914 | RSS: Main: 177442816 17:22:35 INFO - PID 25914 | 17:22:38 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:38 INFO - PID 25914 | RSS: Main: 177348608 17:22:38 INFO - PID 25914 | 17:22:40 INFO - PID 25914 | Cycle 1(1): loaded http://localhost:56131/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56131/tests/kraken/driver.html?testName=ai-astar) 17:22:41 INFO - PID 25914 | RSS: Main: 178823168 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | __start_tp_report 17:22:41 INFO - PID 25914 | _x_x_mozilla_page_load 17:22:41 INFO - PID 25914 | _x_x_mozilla_page_load_details 17:22:41 INFO - PID 25914 | |i|pagename|runs| 17:22:41 INFO - PID 25914 | |0;ai-astar;99;109;101;107;105;111;116;99;109;107 17:22:41 INFO - PID 25914 | |1;audio-beat-detection;145;123;146;173;119;143;150;128;172;119 17:22:41 INFO - PID 25914 | |2;audio-dft;165;163;163;172;162;162;166;167;173;168 17:22:41 INFO - PID 25914 | |3;audio-fft;76;76;81;184;81;74;74;76;155;75 17:22:41 INFO - PID 25914 | |4;audio-oscillator;79;78;132;82;81;78;132;79;79;127 17:22:41 INFO - PID 25914 | |5;imaging-gaussian-blur;114;114;115;113;117;114;114;113;114;115 17:22:41 INFO - PID 25914 | |6;imaging-darkroom;149;148;153;147;147;147;149;153;153;147 17:22:41 INFO - PID 25914 | |7;imaging-desaturate;100;100;95;94;94;95;95;94;95;94 17:22:41 INFO - PID 25914 | |8;json-parse-financial;61;53;52;62;54;54;52;65;53;54 17:22:41 INFO - PID 25914 | |9;json-stringify-tinderbox;56;54;55;55;56;55;55;56;56;55 17:22:41 INFO - PID 25914 | |10;stanford-crypto-aes;73;79;74;77;76;74;77;75;77;75 17:22:41 INFO - PID 25914 | |11;stanford-crypto-ccm;123;121;121;124;131;124;119;118;115;169 17:22:41 INFO - PID 25914 | |12;stanford-crypto-pbkdf2;169;182;171;172;172;170;186;176;168;176 17:22:41 INFO - PID 25914 | |13;stanford-crypto-sha256-iterative;71;66;64;63;70;68;65;64;68;66 17:22:41 INFO - PID 25914 | __end_tp_report 17:22:41 INFO - PID 25914 | __start_cc_report 17:22:41 INFO - PID 25914 | _x_x_mozilla_cycle_collect,947 17:22:41 INFO - PID 25914 | __end_cc_report 17:22:41 INFO - PID 25914 | __startTimestamp1503534161018__endTimestamp 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | ------- Summary: start ------- 17:22:41 INFO - PID 25914 | Number of tests: 14 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#0] ai-astar Cycles:10 Average:106.30 Median:110.00 stddev:5.46 (5.0%) stddev-sans-first:5.11 17:22:41 INFO - PID 25914 | Values: 99.0 109.0 101.0 107.0 105.0 111.0 116.0 99.0 109.0 107.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:145.50 stddev:19.90 (13.7%) stddev-sans-first:21.08 17:22:41 INFO - PID 25914 | Values: 145.0 123.0 146.0 173.0 119.0 143.0 150.0 128.0 172.0 119.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.50 stddev:3.96 (2.4%) stddev-sans-first:4.18 17:22:41 INFO - PID 25914 | Values: 165.0 163.0 163.0 172.0 162.0 162.0 166.0 167.0 173.0 168.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:39.83 (52.4%) stddev-sans-first:41.64 17:22:41 INFO - PID 25914 | Values: 76.0 76.0 81.0 184.0 81.0 74.0 74.0 76.0 155.0 75.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:24.66 (31.2%) stddev-sans-first:25.49 17:22:41 INFO - PID 25914 | Values: 79.0 78.0 132.0 82.0 81.0 78.0 132.0 79.0 79.0 127.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 17:22:41 INFO - PID 25914 | Values: 114.0 114.0 115.0 113.0 117.0 114.0 114.0 113.0 114.0 115.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:2.67 (1.8%) stddev-sans-first:2.83 17:22:41 INFO - PID 25914 | Values: 149.0 148.0 153.0 147.0 147.0 147.0 149.0 153.0 153.0 147.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.50 stddev:2.37 (2.5%) stddev-sans-first:1.90 17:22:41 INFO - PID 25914 | Values: 100.0 100.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:4.76 (8.8%) stddev-sans-first:4.69 17:22:41 INFO - PID 25914 | Values: 61.0 53.0 52.0 62.0 54.0 54.0 52.0 65.0 53.0 54.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 17:22:41 INFO - PID 25914 | Values: 56.0 54.0 55.0 55.0 56.0 55.0 55.0 56.0 56.0 55.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:76.50 stddev:1.83 (2.4%) stddev-sans-first:1.66 17:22:41 INFO - PID 25914 | Values: 73.0 79.0 74.0 77.0 76.0 74.0 77.0 75.0 77.0 75.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:123.50 stddev:15.54 (12.6%) stddev-sans-first:16.43 17:22:41 INFO - PID 25914 | Values: 123.0 121.0 121.0 124.0 131.0 124.0 119.0 118.0 115.0 169.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:5.87 (3.4%) stddev-sans-first:5.91 17:22:41 INFO - PID 25914 | Values: 169.0 182.0 171.0 172.0 172.0 170.0 186.0 176.0 168.0 176.0 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.68 (4.0%) stddev-sans-first:2.29 17:22:41 INFO - PID 25914 | Values: 71.0 66.0 64.0 63.0 70.0 68.0 65.0 64.0 68.0 66.0 17:22:41 INFO - PID 25914 | -------- Summary: end -------- 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 17:22:41 INFO - PID 25914 | 17:22:41 INFO - PID 25914 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:22:41 INFO - TEST-INFO | 25914: exit 0 17:22:41 INFO - TEST-OK | kraken | took 62814ms 17:22:41 INFO - SUITE-END | took 1175s 17:22:42 INFO - Completed test suite (00:19:35) 17:22:42 INFO - javascript benchmark 17:22:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8460.889891723604, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3214.7428205743545, 3234.5471633971247, 3255.0723043932476, 3274.0505253476495, 3298.9670103298963, 6130.386961303868, 6308.463780578645, 6323.20959880015, 6329.272133704625, 6331.081993111002, 6036.818895433133, 6163.476104531121, 6164.352742961992, 6164.568480206376, 6172.7530898764, 5654.208410822488, 5699.772009119641, 5731.914021289663, 5737.196792449061, 5738.282714660668, 5755.309362876461, 5785.27684039495, 5806.506446952014, 5814.09881468371, 5830.242068531085, 5649.604527683064, 5729.770809167629, 5733.140028995663, 5734.913976290338, 5753.597248192628, 5537.58468114893, 5761.193432919395, 5784.566157538202, 5824.854378640547, 5834.0, 5603.019471592495, 5621.522170615503, 5649.548036157139, 5728.42715728428, 5737.684427356494, 6095.238095238095, 6166.784162554334, 6234.688265586702, 6236.937630623726, 6282.623042617412, 6469.417752402306, 6505.0, 6521.47828173745, 6665.400113989765, 6692.096566963446, 6741.662916854187, 6791.626460544668, 6796.35434633709, 6798.04827324175, 6805.48958828085, 6197.659128747872, 6285.59143655661, 6295.842603934938, 6302.842428939267, 6305.148804911324, 6855.0, 6857.074294970215, 6887.173539175231, 6949.270326615733, 6953.096097507291, 6439.484841212692, 6517.348265173539, 6537.411632952962, 6553.803385898431, 6619.437347825393, 6561.1470508833545, 6640.933590664128, 6647.700853461606, 6680.164979377578, 6689.531732778659, 6562.639054851934, 6643.634600096944, 6658.500612454085, 6659.633720145439, 6663.700133494004, 6579.276279609239, 6600.438962688129, 6602.636854972927, 6670.299618540081, 6686.4985126115735, 5223.451537588575, 5257.78968841242, 5326.493983071602, 5347.919781203285, 5369.301990741257, 4710.740909250024, 4726.929096063562, 4738.881527961828, 4760.095581839509, 4777.546133117348, 5775.451332123442, 5912.526997840162, 5931.258592675916, 5931.851703707442, 5939.287285525678, 6718.05947167397, 6732.562383445061, 6819.556728812611, 6828.0, 6828.078209441662, 5733.942660573341, 5820.970895145497, 5828.737706803204, 5830.329512106077, 5912.083627037816, 5845.123231515222, 5846.649201047951, 5860.853478663067, 5872.207252021008, 5874.970625146847, 6265.404786545271, 6456.483481321483, 6458.418742313214, 6482.870342593216, 6490.188726409199, 6638.701258443478, 6649.2685804562425, 6689.632070235989, 6735.797926062226, 6748.291429399842, 6154.78458253959, 6345.270293916259, 6352.587081839665, 6471.158749362741, 6484.708188131451, 6606.504512161703, 6623.900641490478, 6624.6025238485845, 6628.867422651423, 6629.966850165718, 6703.4302084321425, 6711.228208756055, 6789.796306110825, 6796.218434880052, 6802.081718967876, 6470.158879345843, 6478.708458119301, 6479.870402591828, 6575.506836987341, 6584.76953306632, 6352.523560732871, 6452.935470645233, 6476.902846457401, 6581.111549940697, 6586.769463068769, 6383.93616063852, 6389.424951754364, 6400.935990640221, 6404.583702059351, 6418.614883107029, 6354.841128971812, 6492.383223593751, 6586.2755096940255, 6591.242007169237, 6607.867842643216, 6208.4722798562625, 6269.373062693694, 6285.842853928505, 6305.779297724557, 6353.8729225416155], "value": 6101.407366075326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.1089013969147, 836.7280633794016, 862.9439086459383, 865.5585651317828, 1117.5082963496056, 29317.827286908523, 29773.106806795804, 37990.240195196115, 38716.80641596795, 38831.41752873709, 39144.412833807444, 39437.40843887337, 39577.60422395775, 39752.80123599378, 39868.60131398685, 7544.660490277924, 7545.84908301835, 7758.418118641096, 7759.262870027338, 7759.844803103934, 7572.469927105105, 7618.123915749677, 7699.230076992284, 7699.538027718327, 7701.306882380584, 7639.618019099023, 7643.503172293811, 7665.1951545087795, 7700.4609677322605, 7723.922760772404, 7657.655405506738, 7664.65509052094, 7700.191479894586, 7709.460337776358, 7711.691532338699, 7577.052868391451, 7640.197779233156, 7644.0, 7648.579328136951, 7654.158042615308, 35653.82173089118, 36025.81987090048, 36084.458733118765, 36146.81926590377, 36148.45777313316, 3426.1434641339665, 3456.6197718250974, 3461.6019157796923, 3464.8960531184107, 3469.2541103662834, 29246.853765731248, 29339.0, 29344.0, 29471.115866523825, 29615.25961850971, 4818.951810481885, 4953.628477864175, 5021.297018417425, 5067.974660126676, 5160.122779127557, 178450.0, 178478.10760946243, 178577.0, 179241.0, 179250.0, 45454.09091818211, 45553.77223113863, 45664.5433545667, 45676.0, 45680.0, 49683.503164967886, 50810.0, 50817.745911270205, 50859.49140508621, 50883.236751448756, 12562.0, 12802.0, 15958.840411595967, 16083.597910052109, 16096.356145754038, 12980.610581682564, 13159.342032898317, 13242.20546767197, 13284.07011509185, 13296.667583310495, 13600.319984000958, 13741.0, 13782.93108534451, 13812.309384530734, 13854.445822167201, 5537.612367134342, 5618.4662457066515, 5653.462921022497, 5653.773849046074, 5678.829635110953, 976.8632391465201, 993.9105480506789, 997.680742162501, 1002.2433063037506, 1010.9090181883665, 21741.456463588536, 21831.781682182977, 22093.226737064124, 22149.0, 22519.324420267418, 1021.6883850425692, 1049.3651340938775, 1057.9894201057891, 1060.5015642647943, 1069.4492336446735, 11171.050460710769, 11566.65300041, 11614.128940329509, 11620.883791162149, 11657.300561966309, 220407.0, 222047.0, 222278.0, 222763.0, 222956.0, 47839.282410763866, 48097.519024809306, 48134.27798583024, 48225.27662085072, 48305.27542086872, 1347.063790665478, 1389.5831250624772, 1400.9719805603627, 1403.0529392659914, 1405.2341473896752, 20941.58116837685, 20993.160273588885, 21275.68086478735, 21646.24238151657, 21682.0, 33728.66271337353, 33810.66189338174, 33975.66024339725, 34052.82973585116, 34326.48510272298, 190514.0, 191059.0447047756, 191154.0, 191943.0, 192348.0, 31626.209344766565, 34753.65246347504, 35605.46591801177, 35723.64276357203, 35726.28547429089, 42770.144597108505, 43060.0, 43064.0, 43126.78436607797, 43170.784146079066, 31945.840270798497, 32184.0, 32535.349293013533, 32539.0, 32792.67207327896, 31600.683993159775, 31704.682953171097, 31741.8412907934, 31839.36321273608, 32008.67991320057, 34565.82717086399, 34619.4807077889, 34649.30701386009, 34672.82663586666, 34830.65169348274, 30895.0, 30901.69098309078, 30907.84546077255, 31121.8443907779, 31161.688383115878, 22787.544249115257, 23448.880127047145, 23451.41371465727, 23722.406939826644, 23741.64387534154], "value": 16572.119531767774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.9482697643373, 545.0760960172506, 548.3995025447134, 549.7898448238083, 551.5119119579173, 21433.249836255734, 22088.447788805246, 22103.889480552596, 22170.88914555427, 22286.0, 24377.878110609465, 24665.383365415873, 24765.380865478328, 24786.75213247867, 24827.875860620672, 6487.0, 6603.042558828967, 6603.14159159311, 6609.93390066098, 6635.635040072794, 5980.43185897339, 6469.93530064698, 6473.579217350881, 6497.935020649804, 6505.4145126938565, 6437.130987316699, 6461.386168314003, 6461.547691661585, 6462.967685161591, 6465.030245463171, 6437.130987316746, 6454.548181627288, 6455.096286519891, 6455.289918109004, 6480.870382592346, 6010.489108425789, 6016.96991515044, 6018.097285407181, 6031.638101713867, 6047.395260473962, 27706.861465692542, 28192.577111343347, 30499.542506862414, 31553.684463155532, 31718.207044823834, 2077.896105194734, 2129.765725770164, 2131.531063166101, 2131.9467013324793, 2137.9893100534555, 20206.595868082703, 20455.386338409873, 20809.479763006046, 21224.363269101952, 21253.149874005023, 2483.490884368718, 2485.22957883055, 2498.6127150291554, 2498.962515562268, 2571.6014017827265, 136948.0, 139853.0, 140217.2989135058, 140852.0, 140983.0, 20016.69974950377, 20591.8970405147, 20867.686984695243, 20963.475913102295, 21363.465913351978, 42174.367384489255, 42305.15389692189, 42360.0, 42391.7880410596, 42438.78780606077, 11237.943810280896, 11328.32030078198, 11406.574178227722, 11473.885261147449, 11588.47851846652, 8150.75547733569, 8567.357448191411, 9245.583948722324, 9422.952885235667, 9584.0415958405, 10953.616623418142, 11558.0, 11597.826032609517, 11655.18413711032, 11800.0, 4224.260754367973, 4302.182585308781, 4314.317416207681, 4317.956820431756, 4345.956540434619, 950.4629884115591, 954.370115723619, 955.7562821480478, 968.3463662028103, 972.1396564040733, 19368.8063119367, 19675.508112297306, 19725.210991560463, 19842.404727858186, 20002.399808015325, 1011.1405305490274, 1026.8870424253325, 1031.6079889641887, 1042.3016578892161, 1043.7651528406047, 10659.786804263871, 10814.405207713651, 11072.557097716162, 11145.052670522935, 11173.664790056311, 450144.0, 456474.0, 492828.0, 498291.5085424622, 502805.0, 110066.0, 115373.0, 116779.0, 117925.4103729493, 118006.0, 1213.969650758738, 1218.1594699657207, 1254.8243245945575, 1255.1465003797323, 1258.6790368455986, 20526.486837829172, 20786.27248046311, 20964.790352096894, 20999.0, 21241.575168496853, 56176.71911640416, 56229.71885140548, 56493.43506564882, 57575.0, 57932.0, 71033.64483177551, 72745.0, 72829.27170728226, 73199.0, 73499.63250183714, 11912.642620721392, 12426.0, 13664.316784160554, 14180.723734863912, 14670.706585868009, 22643.88678056599, 22897.65653515165, 22983.88508057516, 23054.308370748906, 23069.769302306762, 17921.820781792536, 17937.37219197322, 18193.272269109086, 18210.36263730763, 18315.450536483928, 16318.510444686679, 16981.575460613585, 17409.303627854744, 17573.03348315855, 17629.20668569892, 19211.807881921563, 19793.703094453307, 19884.403467895987, 19896.801031989497, 19941.302054428026, 14403.927980360031, 14568.417263309773, 14583.92708036453, 14600.342984565932, 14600.780988285396, 18301.176447059646, 19514.60970780548, 19528.0, 19556.706649400556, 19570.31503897414], "value": 12624.771823169756, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.188084328138, 1369.9383527741252, 1371.6982263901943, 1372.876441120299, 1378.0698028830543, 14513.709725805478, 14629.195394253338, 15117.697646047072, 15123.92438037811, 15146.394144234217, 15158.772618410705, 15427.074375537475, 15441.227938603053, 15456.459023934165, 15496.380144794222, 2740.5478096114116, 2781.7496425321715, 2782.3183320086605, 2783.5685468752376, 2785.0, 2593.48130373925, 2599.155274535774, 2638.617400476939, 2671.42564348665, 2783.9304017399522, 2732.2076597786618, 2762.2265765585566, 2762.4889395461905, 2762.709915458868, 2773.1680495851265, 2633.7629613334702, 2634.8023898207616, 2642.669666291723, 2664.320598247444, 2687.48937701838, 2485.2792690120023, 2509.1970569417795, 2509.6737424134926, 2641.841489510616, 2698.63568418263, 14556.126632402089, 14688.485902993343, 14690.485832995793, 14691.11853288806, 14701.632459188499, 7844.0979287382115, 8086.757397278091, 8105.797355066112, 8109.797255068612, 8112.148224436408, 5210.635255532115, 5298.0, 5502.0921547944545, 5514.200440936082, 5528.612997090206, 1863.850891928656, 1917.9136938837785, 1923.8749481283812, 1972.5660354721938, 1974.2892558678864, 24876.626850597255, 25034.624480632807, 25044.874775626005, 25112.0, 25123.874380627978, 6555.147830781968, 7220.819479512949, 7279.5996220207335, 7510.248975102446, 7517.17311095779, 16600.83399166017, 16759.664806703797, 16767.748483772753, 16771.832281677027, 16780.748288775678, 7852.960735196288, 7922.128565857751, 7955.24425179607, 7972.202779721982, 7984.441089123822, 7075.575465472089, 7228.927710722931, 7284.70861165558, 7288.781336559911, 7339.229380915034, 5087.949120508822, 5236.554892834151, 5287.576993840484, 5315.787368505294, 5352.545033672103, 1354.0453979944116, 1363.9522616708368, 1501.5345242974495, 1518.8101487314086, 1528.740114180592, 898.766320756608, 922.6770630279349, 927.865459508381, 931.0549791961165, 941.5198248892976, 8061.959690201629, 8396.538190399464, 8447.113053129457, 8454.915450845536, 8512.404131710844, 983.4836710726782, 986.0927946289431, 993.1260490768078, 1018.7198520406947, 1019.6380284998867, 5030.949690503121, 5157.277981082651, 5160.303359046556, 5192.480751924777, 5309.814156504503, 19767.703484447746, 20284.188632454538, 20501.0, 20512.179512819617, 20878.895605521877, 20301.898490507454, 20561.48596285105, 20587.691184632244, 20701.0, 20784.27255046066, 10858.837117443245, 10977.506012229469, 11095.667129986114, 11099.112071034137, 11151.944240278908, 8401.915980840358, 8442.282405995558, 8489.533075680896, 8529.402941794015, 8535.146485351415, 17845.821541784415, 17854.839435436654, 17875.28498860031, 17934.5516362092, 18149.81850181534, 18206.544836379195, 18377.632447351247, 18377.816221838144, 18473.53816154553, 18562.814371856108, 10813.837792433276, 10833.566657333933, 10917.508712107816, 10983.286086404678, 10991.175661825555, 12066.396680166132, 13448.26034568069, 13532.864671353555, 13571.321433928066, 13641.795373069213, 9842.21262299, 10295.433751143759, 10331.638392656221, 10463.476826158509, 10465.319754215952, 10848.620298289521, 10892.891071089505, 10995.065419439437, 11102.500387482422, 11241.60654377093, 9475.47884866339, 9605.087516685904, 9607.375520591138, 9611.711648650551, 9613.567389467631, 7487.138979017265, 7505.0, 7518.849623007619, 7541.321281084729, 7610.429217808576, 6861.313868613099, 6996.195437524546, 7133.714651413885, 7178.133685241979, 7226.421886248982], "value": 6594.312698996591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.30517275813855, 497.21191910821346, 512.5566385076909, 522.4175044825021, 523.3719536556133, 6059.878802423949, 6166.876662466748, 6238.4385405313515, 6256.655883926388, 6280.748770049198, 6118.571699980992, 6139.81580552583, 6172.0, 6208.192934918466, 6249.843753906154, 4874.415070191582, 4973.154563724175, 5091.338126043609, 5121.436641969381, 5145.485451454862, 4965.677230979974, 4973.950260497385, 4980.630326660179, 4981.427135879384, 5005.373253692546, 4886.193778026622, 4947.233178857283, 4953.306537084811, 4995.825146119886, 4998.225275082368, 4984.457926457497, 5001.599552125411, 5041.865580244453, 5045.738565358661, 5069.974650126763, 4473.194824931511, 4497.842575509874, 4519.457665080178, 4526.140033393677, 4528.75091869947, 6055.0, 6111.358307377705, 6127.6017058891475, 6154.169187159766, 6171.814845554641, 5636.126400407943, 5646.830595082154, 5661.943380566183, 5691.288588926384, 5703.572232082569, 6486.189226346707, 6509.4466970307585, 6549.312322206148, 6587.341265873374, 6618.0, 4792.856214313576, 4813.470518242991, 4836.347093142451, 4841.564259216688, 4854.538818812207, 6652.168478940132, 6653.401193892573, 6744.460443164584, 6931.757388491378, 7029.472789540754, 5387.4073851876265, 5407.729613519308, 5409.0, 5439.48324909141, 5461.836144915659, 5489.478499542537, 5501.367342755634, 5504.4495550444635, 5525.972370138124, 5584.385717571064, 5927.4665280125, 5977.731002104916, 5982.1325907744, 6016.849578760566, 6026.367231440723, 6568.507361947873, 6623.311055680771, 6629.337066293332, 6637.971114477264, 6723.361280678328, 1917.36726880132, 1928.23834585338, 1928.9228430862888, 1936.7772706138974, 1943.0, 1322.3388305847077, 1401.7056418152301, 1411.4918629293445, 1421.2254321394657, 1443.1196969848384, 5656.660600363909, 5703.971480142655, 5738.799142030009, 5766.625169364062, 5787.334456537468, 6625.86748265032, 6627.602343859384, 6651.833704157435, 6726.899096513556, 6736.93263067363, 5659.462351076641, 5821.18503409523, 5872.442117998783, 5879.559033072536, 5920.822375328747, 3573.0174202094113, 3584.318979393907, 3594.964050359515, 3605.116746397097, 3630.0561853917643, 6428.0357946307495, 6460.353964603502, 6499.252585952581, 6501.642409667514, 6513.73945042193, 6792.0, 6900.89585666291, 6921.688524016431, 6924.861502769916, 6988.336108069725, 6401.9039714404325, 6423.389777971085, 6466.644334561644, 6476.676166191672, 6521.739130434729, 6695.163104611924, 6716.865662686817, 6721.966390168018, 6750.696218670073, 6766.763163289262, 6603.7688680895935, 6630.966845165936, 6644.534882558174, 6706.66466676674, 6719.764808231884, 6298.527610429328, 6313.09597585116, 6370.522210834299, 6403.8867173831595, 6472.093906852951, 5414.945850541444, 5416.783328666967, 5446.183072539151, 5450.618456707993, 5461.15352120422, 6529.347065293623, 6567.507436942153, 6624.503162262946, 6630.336966303331, 6654.5341826073645, 6483.351664833479, 6506.577072490462, 6509.902351464637, 6524.249711283073, 6588.538802283986, 6449.4840412765925, 6474.708638111202, 6546.672666366568, 6558.737650493927, 6571.605703657796, 6410.391012853772, 6434.131392262172, 6447.807745366598, 6451.225852897494, 6470.838229044311, 6537.771178008747, 6583.670816459254, 6592.494851956226, 6641.634710090992, 6650.168728908887, 6310.179676642191, 6367.90448143269, 6409.615423074631, 6468.741250349934, 6481.837954050998], "value": 5129.556943682271, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.1660797330575, 873.2969959182859, 898.2409863665209, 899.6401439424227, 902.0438335364514, 17240.56898577536, 18032.18855151518, 18136.99999999998, 18175.363862264825, 20901.581968360624, 19832.305869294578, 20558.0748866301, 20582.794172058275, 20608.0, 20646.587068258625, 883.5273128876037, 906.8141031088611, 910.9863352049691, 911.0388540090203, 911.2026976395621, 909.9590518426687, 942.1191186240852, 953.213598781005, 959.1655259923841, 961.1733908838394, 995.3331268050424, 1008.9495525223746, 1009.1573536097368, 1009.2682804966414, 1009.581023875091, 1002.8245057115012, 1006.8036732837099, 1007.5566750629773, 1008.2538921198334, 1009.1876039787932, 738.5900825042099, 740.7222291640635, 741.929516695913, 742.3838214282133, 743.9070116235471, 18097.004664743436, 18598.0, 19154.0, 19349.322773702854, 19385.4184374469, 18689.62620747591, 18765.437036888914, 19168.233270669156, 19234.615307693766, 19774.901125494423, 15066.171360575165, 15526.301316440788, 15772.369105235777, 15780.842191578167, 15802.762958555631, 3557.146284891633, 3611.94582081269, 3618.095476130967, 3618.7285953553587, 3619.7285203609836, 123179.0, 125512.37243813723, 127606.0, 128147.0, 129118.3544082283, 12939.870601294055, 13034.80447793284, 13233.53682621123, 13237.933810330887, 13264.73470530584, 26054.869725651628, 26556.60165097525, 26626.467470650477, 26664.73335266661, 26792.0, 7043.929560704328, 7465.664045117983, 7578.09062912454, 8353.498790072494, 8516.574171291411, 3972.5431575368625, 4064.349704047338, 4068.7762173080764, 4069.959300407017, 4070.75575465473, 4692.155412025868, 4801.975990120027, 4822.156122678587, 5418.783248670009, 5593.636413633101, 982.4203719805349, 995.124290624246, 1009.8333774927202, 1012.2559918459926, 1015.2487159501916, 617.4319625944053, 635.1203583037526, 638.4286063972811, 647.6923461355818, 650.6616559389091, 11319.264247823865, 13487.527936522174, 13560.389782459813, 13604.523841665494, 13659.248741319323, 677.8847595908609, 685.044363113454, 685.7325642999234, 694.4895501806168, 706.6396137969673, 5430.891382172414, 5479.780808767684, 5542.0, 5570.275864137717, 5590.972045139748, 106578.0, 107236.46381768041, 108154.45922770335, 108521.0, 111602.44198778954, 87278.56360718155, 90053.0, 91193.0, 93498.0, 94228.05771942192, 79209.72158375445, 80292.59853700694, 82136.58931705423, 83105.0, 85404.57297713471, 10519.94740026295, 10600.4699765013, 10707.965486557528, 10823.512941917475, 10871.891281087088, 36781.0, 38455.0, 38569.42145867758, 39315.60684393119, 40224.798876005436, 50126.74936625439, 50522.0, 51233.743831280604, 51427.228591571904, 52170.47829521808, 15036.774448383065, 15303.923480382527, 15329.693406132037, 15445.459408920633, 15549.067055976677, 17278.395256165975, 17425.302987880343, 17451.214695338487, 17534.0, 17580.73628895593, 15972.12153331578, 16035.358585656442, 16290.3483860649, 16324.918375408522, 16466.341346346013, 15781.684366312838, 15827.129507877178, 15875.444359447363, 15947.282372293042, 15991.280392382603, 15739.921300393426, 15764.132972686612, 15872.682546349239, 15887.602809929382, 16045.197740112713, 11956.58151964677, 11960.58137965167, 12097.637070887888, 12360.196587221802, 12400.937995309965, 12172.513099476277, 12297.815532766837, 12327.137100402886, 12489.687757805765, 12611.43248553799], "value": 8495.516814579125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 101.0, 107.0, 105.0, 111.0, 116.0, 99.0, 109.0, 107.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 123.0, 146.0, 173.0, 119.0, 143.0, 150.0, 128.0, 172.0, 119.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 172.0, 162.0, 162.0, 166.0, 167.0, 173.0, 168.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 81.0, 184.0, 81.0, 74.0, 74.0, 76.0, 155.0, 75.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 132.0, 82.0, 81.0, 78.0, 132.0, 79.0, 79.0, 127.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 117.0, 114.0, 114.0, 113.0, 114.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 153.0, 147.0, 147.0, 147.0, 149.0, 153.0, 153.0, 147.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 53.0, 52.0, 62.0, 54.0, 54.0, 52.0, 65.0, 53.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 74.0, 77.0, 76.0, 74.0, 77.0, 75.0, 77.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 121.0, 124.0, 131.0, 124.0, 119.0, 118.0, 115.0, 169.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 182.0, 171.0, 172.0, 172.0, 170.0, 186.0, 176.0, 168.0, 176.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 64.0, 63.0, 70.0, 68.0, 65.0, 64.0, 68.0, 66.0], "value": 66.5, "unit": "score"}]}]} 17:22:42 INFO - Return code: 0 17:22:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:22:42 INFO - # TBPL SUCCESS # 17:22:42 INFO - Running post-action listener: _package_coverage_data 17:22:42 INFO - Running post-action listener: _resource_record_post_action 17:22:42 INFO - [mozharness: 2017-08-24 00:22:42.291901Z] Finished run-tests step (success) 17:22:42 INFO - Running post-run listener: _resource_record_post_run 17:22:42 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 428781568; Read time: 240; Write time: 303844 17:22:42 INFO - TinderboxPrint: CPU usage
13.1% 17:22:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 17:22:42 INFO - TinderboxPrint: I/O write bytes / time
428,781,568 / 303,844 17:22:42 INFO - TinderboxPrint: CPU idle
8,267.6 (86.8%) 17:22:42 INFO - TinderboxPrint: CPU user
1,197.9 (12.6%) 17:22:42 INFO - TinderboxPrint: Swap in / out
0 / 0 17:22:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 105836544; Read time: 72; Write time: 72052 17:22:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:22:42 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322351104; Read time: 168; Write time: 231740 17:22:42 INFO - Running post-run listener: _upload_blobber_files 17:22:42 INFO - Blob upload gear active. 17:22:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:42 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 17:22:42 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'] 17:22:42 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 17:22:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:22:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:22:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:44 INFO - (blobuploader) - INFO - Done attempting. 17:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:48 INFO - (blobuploader) - INFO - Done attempting. 17:22:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:22:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:49 INFO - (blobuploader) - INFO - Done attempting. 17:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:22:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:50 INFO - (blobuploader) - INFO - Done attempting. 17:22:50 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:50 INFO - Return code: 0 17:22:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:50 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0332f5daf9df2c8d348775efd8bacc57443af15b8e9b51ceb45db8ac94ccd48b8285da86b9d165b3529abc2bbe5b31596650ae04cf4c03f3222efc3fc01efc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba8c72831e406fbb2bfa48c35ba41f43bb92f5826d0c3d8d4e2615de3a64dc740bae37c07ff354ae80dc8c9a63448ff9971c536d35953c01f0c63aaa59b1d35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976114bddc563b26992124e026f0a0d8400a14b07d5cc795e542acf34f03dd6da79ed7d6c99eeb45dd908afda516b97073ffc84273f5843b62a1a500089680ac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589538734711ce52ab4053d6d6226872bcf802be0c61b61ccb98e50e5eb1af95c95236c68346d593c51323c26974d7e574088c838f5243728ee39bf47d22c975"} 17:22:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:50 INFO - Contents: 17:22:50 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0332f5daf9df2c8d348775efd8bacc57443af15b8e9b51ceb45db8ac94ccd48b8285da86b9d165b3529abc2bbe5b31596650ae04cf4c03f3222efc3fc01efc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba8c72831e406fbb2bfa48c35ba41f43bb92f5826d0c3d8d4e2615de3a64dc740bae37c07ff354ae80dc8c9a63448ff9971c536d35953c01f0c63aaa59b1d35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976114bddc563b26992124e026f0a0d8400a14b07d5cc795e542acf34f03dd6da79ed7d6c99eeb45dd908afda516b97073ffc84273f5843b62a1a500089680ac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589538734711ce52ab4053d6d6226872bcf802be0c61b61ccb98e50e5eb1af95c95236c68346d593c51323c26974d7e574088c838f5243728ee39bf47d22c975"} 17:22:50 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:50 INFO - Copying logs to upload dir... 17:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.516383 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-23 17:22:50.515244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:22:50.518546) ========= 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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0332f5daf9df2c8d348775efd8bacc57443af15b8e9b51ceb45db8ac94ccd48b8285da86b9d165b3529abc2bbe5b31596650ae04cf4c03f3222efc3fc01efc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba8c72831e406fbb2bfa48c35ba41f43bb92f5826d0c3d8d4e2615de3a64dc740bae37c07ff354ae80dc8c9a63448ff9971c536d35953c01f0c63aaa59b1d35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976114bddc563b26992124e026f0a0d8400a14b07d5cc795e542acf34f03dd6da79ed7d6c99eeb45dd908afda516b97073ffc84273f5843b62a1a500089680ac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589538734711ce52ab4053d6d6226872bcf802be0c61b61ccb98e50e5eb1af95c95236c68346d593c51323c26974d7e574088c838f5243728ee39bf47d22c975"} build_url:https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/OO07YykgQ7SfVQl5pfp5jg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0332f5daf9df2c8d348775efd8bacc57443af15b8e9b51ceb45db8ac94ccd48b8285da86b9d165b3529abc2bbe5b31596650ae04cf4c03f3222efc3fc01efc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dba8c72831e406fbb2bfa48c35ba41f43bb92f5826d0c3d8d4e2615de3a64dc740bae37c07ff354ae80dc8c9a63448ff9971c536d35953c01f0c63aaa59b1d35", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/976114bddc563b26992124e026f0a0d8400a14b07d5cc795e542acf34f03dd6da79ed7d6c99eeb45dd908afda516b97073ffc84273f5843b62a1a500089680ac", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/589538734711ce52ab4053d6d6226872bcf802be0c61b61ccb98e50e5eb1af95c95236c68346d593c51323c26974d7e574088c838f5243728ee39bf47d22c975"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 17:22:50.544986) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:22:50.545293) ========= 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=ea65d483da93c827905c2090000001f5-1503532916.51220-257334333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 17:22:50.628220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:22:50.628526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 17:22:50.628825) ========= ========= Total master_lag: 0.16 =========