builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1499726361.04 results: success (0) revision: 5d794bf4c4653153e602631f1b8818acd559d8f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.044099) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.044647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.044991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.073930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.074638) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-10 15:39:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 143M=0s 2017-07-10 15:39:21 (143 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172483 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.282726) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.283106) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:21.333011) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 15:39:21.333384) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5d794bf4c4653153e602631f1b8818acd559d8f5 --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 5d794bf4c4653153e602631f1b8818acd559d8f5 --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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-10 15:39:21,408 truncating revision to first 12 chars 2017-07-10 15:39:21,408 Setting DEBUG logging. 2017-07-10 15:39:21,409 attempt 1/10 2017-07-10 15:39:21,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d794bf4c465?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-10 15:39:22,164 unpacking tar archive at: mozilla-central-5d794bf4c465/testing/mozharness/ program finished with exit code 0 elapsedTime=1.094836 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-10 15:39:22.440854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:22.441226) ========= script_repo_revision: 5d794bf4c4653153e602631f1b8818acd559d8f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:22.441642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:22.441973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-10 15:39:22.449485) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-10 15:39:22.449796) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:39:22 INFO - MultiFileLogger online at 20170710 15:39:22 in /builds/slave/test 15:39:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:39:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:22 INFO - {'append_to_log': False, 15:39:22 INFO - 'base_work_dir': '/builds/slave/test', 15:39:22 INFO - 'blob_upload_branch': 'Firefox', 15:39:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:22 INFO - 'branch': 'Firefox', 15:39:22 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:22 INFO - 'code_coverage': False, 15:39:22 INFO - 'config_files': ('talos/linux_config.py',), 15:39:22 INFO - 'default_actions': ('clobber', 15:39:22 INFO - 'read-buildbot-config', 15:39:22 INFO - 'download-and-extract', 15:39:22 INFO - 'populate-webroot', 15:39:22 INFO - 'create-virtualenv', 15:39:22 INFO - 'install', 15:39:22 INFO - 'setup-mitmproxy', 15:39:22 INFO - 'run-tests'), 15:39:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:22 INFO - 'disable_ccov_upload': False, 15:39:22 INFO - 'download_minidump_stackwalk': True, 15:39:22 INFO - 'download_symbols': 'ondemand', 15:39:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:22 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:22 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:22 INFO - 'gecko_profile': False, 15:39:22 INFO - 'gecko_profile_interval': 0, 15:39:22 INFO - 'installer_path': 'installer.exe', 15:39:22 INFO - 'log_level': 'info', 15:39:22 INFO - 'log_name': 'talos', 15:39:22 INFO - 'log_to_console': True, 15:39:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:39:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:39:22 INFO - 'opt_config_files': (), 15:39:22 INFO - 'pip_index': False, 15:39:22 INFO - 'suite': 'dromaeojs-e10s', 15:39:22 INFO - 'system_bits': '32', 15:39:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:22 INFO - 'title': 'talos-linux64-ix-087', 15:39:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:22 INFO - 'use_talos_json': True, 15:39:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:22 INFO - 'work_dir': 'build'} 15:39:22 INFO - [mozharness: 2017-07-10 22:39:22.780300Z] Running clobber step. 15:39:22 INFO - Running pre-action listener: _resource_record_pre_action 15:39:22 INFO - Running main action method: clobber 15:39:22 INFO - rmtree: /builds/slave/test/build 15:39:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - [mozharness: 2017-07-10 22:39:24.289424Z] Finished clobber step (success) 15:39:24 INFO - [mozharness: 2017-07-10 22:39:24.289525Z] Running read-buildbot-config step. 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: read_buildbot_config 15:39:24 INFO - Using buildbot properties: 15:39:24 INFO - { 15:39:24 INFO - "project": "", 15:39:24 INFO - "product": "firefox", 15:39:24 INFO - "who": "kwierso@gmail.com", 15:39:24 INFO - "installer_path": "public/build/target.tar.bz2", 15:39:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 15:39:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 15:39:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 15:39:24 INFO - "stage_platform": "linux64-stylosequential", 15:39:24 INFO - "basedir": "/builds/slave/test", 15:39:24 INFO - "buildnumber": 111, 15:39:24 INFO - "platform": "ubuntu64_hw_styloseq", 15:39:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:39:24 INFO - "slavebuilddir": "test", 15:39:24 INFO - "taskId": "d2O2f5ZyRyC0sPdWTXZg0Q", 15:39:24 INFO - "branch": "mozilla-central", 15:39:24 INFO - "script_repo_revision": "production", 15:39:24 INFO - "revision": "5d794bf4c4653153e602631f1b8818acd559d8f5", 15:39:24 INFO - "slavename": "talos-linux64-ix-087", 15:39:24 INFO - "repo_path": "mozilla-central" 15:39:24 INFO - } 15:39:24 INFO - Finding installer, test and symbols from parent task. 15:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d2O2f5ZyRyC0sPdWTXZg0Q'}, attempt #1 15:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d2O2f5ZyRyC0sPdWTXZg0Q'}, attempt #1 15:39:25 INFO - Task dependencies: YF5n3AFNTOGq2PqVxNQIJg 15:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg'}, attempt #1 15:39:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 15:39:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/test_packages.json 15:39:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.crashreporter-symbols.zip 15:39:25 INFO - Running post-action listener: _resource_record_post_action 15:39:25 INFO - [mozharness: 2017-07-10 22:39:25.778192Z] Finished read-buildbot-config step (success) 15:39:25 INFO - [mozharness: 2017-07-10 22:39:25.778506Z] Running download-and-extract step. 15:39:25 INFO - Running pre-action listener: _resource_record_pre_action 15:39:25 INFO - Running main action method: download_and_extract 15:39:25 INFO - mkdir: /builds/slave/test/build/tests 15:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:25 INFO - trying https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.test_packages.json 15:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:39:26 INFO - Downloaded 989 bytes. 15:39:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:39:26 INFO - Using the following test package requirements: 15:39:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:39:26 INFO - u'common': [u'target.common.tests.zip'], 15:39:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:39:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:39:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:39:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:39:26 INFO - u'mozbase': [u'target.common.tests.zip'], 15:39:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:39:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:39:26 INFO - u'web-platform': [u'target.common.tests.zip', 15:39:26 INFO - u'target.web-platform.tests.tar.gz'], 15:39:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:39:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip 15:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip into memory 15:39:27 INFO - Content-Length response header: 67424284 15:39:27 INFO - Bytes received: 67424284 15:39:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:39:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip 15:39:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:39:38 INFO - Fetch https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.common.tests.zip into memory 15:39:40 INFO - Content-Length response header: 67424284 15:39:40 INFO - Bytes received: 67424284 15:39:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.talos.tests.zip 15:39:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:39:52 INFO - Fetch https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.talos.tests.zip into memory 15:39:52 INFO - Content-Length response header: 14474423 15:39:52 INFO - Bytes received: 14474423 15:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:53 INFO - trying https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 15:39:53 INFO - Downloading https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:39:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:39:54 INFO - Downloaded 61927390 bytes. 15:39:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 15:39:54 INFO - mkdir: /builds/slave/test/properties 15:39:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:54 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:54 INFO - Contents: 15:39:54 INFO - build_url:https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 15:39:54 INFO - Running post-action listener: _resource_record_post_action 15:39:54 INFO - Running post-action listener: set_extra_try_arguments 15:39:54 INFO - [mozharness: 2017-07-10 22:39:54.222550Z] Finished download-and-extract step (success) 15:39:54 INFO - [mozharness: 2017-07-10 22:39:54.222647Z] Running populate-webroot step. 15:39:54 INFO - Running pre-action listener: _resource_record_pre_action 15:39:54 INFO - Running main action method: populate_webroot 15:39:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:54 INFO - '--tppagecycles', 15:39:54 INFO - '7'], 15:39:54 INFO - 'tests': ['tsvgm']}}, 15:39:54 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['damp', 'tps']}, 15:39:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'tests': ['damp', 'tps']}, 15:39:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['dromaeo_dom']}, 15:39:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 15:39:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:39:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:39:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_many_windows', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_many_windows', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_many_windows', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['a11yr', 15:39:54 INFO - 'ts_paint', 15:39:54 INFO - 'tpaint', 15:39:54 INFO - 'sessionrestore', 15:39:54 INFO - 'sessionrestore_no_auto_restore', 15:39:54 INFO - 'tabpaint']}, 15:39:54 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 15:39:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:39:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:39:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:39:54 INFO - 'talos_options': ['--mitmproxy', 15:39:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:39:54 INFO - '--firstNonBlankPaint'], 15:39:54 INFO - 'tests': ['quantum_pageload_google', 15:39:54 INFO - 'quantum_pageload_youtube', 15:39:54 INFO - 'quantum_pageload_amazon', 15:39:54 INFO - 'quantum_pageload_facebook']}, 15:39:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['tsvgx', 15:39:54 INFO - 'tsvgr_opacity', 15:39:54 INFO - 'tart', 15:39:54 INFO - 'tscrollx', 15:39:54 INFO - 'cart', 15:39:54 INFO - 'tsvg_static']}, 15:39:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:54 INFO - 'tsvgr_opacity', 15:39:54 INFO - 'tart', 15:39:54 INFO - 'tscrollx', 15:39:54 INFO - 'cart', 15:39:54 INFO - 'tsvg_static']}, 15:39:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'talos_options': ['--disable-e10s'], 15:39:54 INFO - 'tests': ['tp5o']}, 15:39:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:39:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'talos_options': ['--disable-e10s', 15:39:54 INFO - '--xperf_path', 15:39:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:54 INFO - 'tests': ['tp5n']}, 15:39:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:39:54 INFO - 'talos_options': ['--xperf_path', 15:39:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:54 INFO - 'tests': ['tp5n']}}, 15:39:54 INFO - 'talos.zip': {'path': '', 15:39:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:54 INFO - Running post-action listener: _resource_record_post_action 15:39:54 INFO - [mozharness: 2017-07-10 22:39:54.239907Z] Finished populate-webroot step (success) 15:39:54 INFO - [mozharness: 2017-07-10 22:39:54.240010Z] Running create-virtualenv step. 15:39:54 INFO - Running pre-action listener: _resource_record_pre_action 15:39:54 INFO - Running main action method: create_virtualenv 15:39:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:39:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:39:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:54 INFO - Using real prefix '/usr' 15:39:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:54 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:57 INFO - Installing pip.................done. 15:39:57 INFO - Return code: 0 15:39:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:39:57 INFO - Reading from file tmpfile_stdout 15:39:57 INFO - Output received: 15:39:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:39:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:57 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:39:57 INFO - Using env: {'DISPLAY': ':0', 15:39:57 INFO - 'HOME': '/home/cltbld', 15:39:57 INFO - 'LANG': 'en_US.UTF-8', 15:39:57 INFO - 'LANGUAGE': 'en_US:en', 15:39:57 INFO - 'LOGNAME': 'cltbld', 15:39:57 INFO - 'MAIL': '/var/mail/cltbld', 15:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:57 INFO - 'MOZ_NO_REMOTE': '1', 15:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:57 INFO - 'NO_EM_RESTART': '1', 15:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:57 INFO - 'PWD': '/builds/slave/test', 15:39:57 INFO - 'SHELL': '/bin/bash', 15:39:57 INFO - 'SHLVL': '1', 15:39:57 INFO - 'TERM': 'linux', 15:39:57 INFO - 'TMOUT': '86400', 15:39:57 INFO - 'USER': 'cltbld', 15:39:57 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:57 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:39:58 INFO - Cleaning up... 15:39:58 INFO - Return code: 0 15:39:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:58 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:39:58 INFO - Using env: {'DISPLAY': ':0', 15:39:58 INFO - 'HOME': '/home/cltbld', 15:39:58 INFO - 'LANG': 'en_US.UTF-8', 15:39:58 INFO - 'LANGUAGE': 'en_US:en', 15:39:58 INFO - 'LOGNAME': 'cltbld', 15:39:58 INFO - 'MAIL': '/var/mail/cltbld', 15:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:58 INFO - 'MOZ_NO_REMOTE': '1', 15:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:39:58 INFO - 'NO_EM_RESTART': '1', 15:39:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:58 INFO - 'PWD': '/builds/slave/test', 15:39:58 INFO - 'SHELL': '/bin/bash', 15:39:58 INFO - 'SHLVL': '1', 15:39:58 INFO - 'TERM': 'linux', 15:39:58 INFO - 'TMOUT': '86400', 15:39:58 INFO - 'USER': 'cltbld', 15:39:58 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:58 INFO - '_': '/tools/buildbot/bin/python'} 15:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:58 INFO - Downloading/unpacking psutil>=3.1.1 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:59 INFO - Installing collected packages: psutil 15:39:59 INFO - Running setup.py install for psutil 15:39:59 INFO - building 'psutil._psutil_linux' extension 15:39:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:40:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:40:00 INFO - building 'psutil._psutil_posix' extension 15:40:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:40:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:40:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:40:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:40:00 INFO - Successfully installed psutil 15:40:00 INFO - Cleaning up... 15:40:00 INFO - Return code: 0 15:40:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:00 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:40:00 INFO - Using env: {'DISPLAY': ':0', 15:40:00 INFO - 'HOME': '/home/cltbld', 15:40:00 INFO - 'LANG': 'en_US.UTF-8', 15:40:00 INFO - 'LANGUAGE': 'en_US:en', 15:40:00 INFO - 'LOGNAME': 'cltbld', 15:40:00 INFO - 'MAIL': '/var/mail/cltbld', 15:40:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:00 INFO - 'MOZ_NO_REMOTE': '1', 15:40:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:00 INFO - 'NO_EM_RESTART': '1', 15:40:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:00 INFO - 'PWD': '/builds/slave/test', 15:40:00 INFO - 'SHELL': '/bin/bash', 15:40:00 INFO - 'SHLVL': '1', 15:40:00 INFO - 'TERM': 'linux', 15:40:00 INFO - 'TMOUT': '86400', 15:40:00 INFO - 'USER': 'cltbld', 15:40:00 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:00 INFO - '_': '/tools/buildbot/bin/python'} 15:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:40:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:40:02 INFO - Installing collected packages: mozsystemmonitor 15:40:02 INFO - Running setup.py install for mozsystemmonitor 15:40:02 INFO - Successfully installed mozsystemmonitor 15:40:02 INFO - Cleaning up... 15:40:02 INFO - Return code: 0 15:40:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:02 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:40:02 INFO - Using env: {'DISPLAY': ':0', 15:40:02 INFO - 'HOME': '/home/cltbld', 15:40:02 INFO - 'LANG': 'en_US.UTF-8', 15:40:02 INFO - 'LANGUAGE': 'en_US:en', 15:40:02 INFO - 'LOGNAME': 'cltbld', 15:40:02 INFO - 'MAIL': '/var/mail/cltbld', 15:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:02 INFO - 'MOZ_NO_REMOTE': '1', 15:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:02 INFO - 'NO_EM_RESTART': '1', 15:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:02 INFO - 'PWD': '/builds/slave/test', 15:40:02 INFO - 'SHELL': '/bin/bash', 15:40:02 INFO - 'SHLVL': '1', 15:40:02 INFO - 'TERM': 'linux', 15:40:02 INFO - 'TMOUT': '86400', 15:40:02 INFO - 'USER': 'cltbld', 15:40:02 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:02 INFO - '_': '/tools/buildbot/bin/python'} 15:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:02 INFO - Downloading/unpacking jsonschema==2.5.1 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:40:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:40:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:40:03 INFO - warning: no files found matching '*.txt' 15:40:03 INFO - no previously-included directories found matching 'build' 15:40:03 INFO - no previously-included directories found matching 'dist' 15:40:03 INFO - no previously-included directories found matching '.git*' 15:40:03 INFO - Installing collected packages: jsonschema, functools32 15:40:03 INFO - Running setup.py install for functools32 15:40:03 INFO - warning: no files found matching '*.txt' 15:40:03 INFO - no previously-included directories found matching 'build' 15:40:03 INFO - no previously-included directories found matching 'dist' 15:40:03 INFO - no previously-included directories found matching '.git*' 15:40:03 INFO - Successfully installed jsonschema functools32 15:40:03 INFO - Cleaning up... 15:40:03 INFO - Return code: 0 15:40:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:03 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:40:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:40:03 INFO - Using env: {'DISPLAY': ':0', 15:40:03 INFO - 'HOME': '/home/cltbld', 15:40:03 INFO - 'LANG': 'en_US.UTF-8', 15:40:03 INFO - 'LANGUAGE': 'en_US:en', 15:40:03 INFO - 'LOGNAME': 'cltbld', 15:40:03 INFO - 'MAIL': '/var/mail/cltbld', 15:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:03 INFO - 'MOZ_NO_REMOTE': '1', 15:40:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:03 INFO - 'NO_EM_RESTART': '1', 15:40:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:03 INFO - 'PWD': '/builds/slave/test', 15:40:03 INFO - 'SHELL': '/bin/bash', 15:40:03 INFO - 'SHLVL': '1', 15:40:03 INFO - 'TERM': 'linux', 15:40:03 INFO - 'TMOUT': '86400', 15:40:03 INFO - 'USER': 'cltbld', 15:40:03 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:03 INFO - '_': '/tools/buildbot/bin/python'} 15:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:40:04 INFO - Cleaning up... 15:40:04 INFO - Return code: 0 15:40:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:04 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:40:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:40:04 INFO - Using env: {'DISPLAY': ':0', 15:40:04 INFO - 'HOME': '/home/cltbld', 15:40:04 INFO - 'LANG': 'en_US.UTF-8', 15:40:04 INFO - 'LANGUAGE': 'en_US:en', 15:40:04 INFO - 'LOGNAME': 'cltbld', 15:40:04 INFO - 'MAIL': '/var/mail/cltbld', 15:40:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:04 INFO - 'MOZ_NO_REMOTE': '1', 15:40:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:04 INFO - 'NO_EM_RESTART': '1', 15:40:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:04 INFO - 'PWD': '/builds/slave/test', 15:40:04 INFO - 'SHELL': '/bin/bash', 15:40:04 INFO - 'SHLVL': '1', 15:40:04 INFO - 'TERM': 'linux', 15:40:04 INFO - 'TMOUT': '86400', 15:40:04 INFO - 'USER': 'cltbld', 15:40:04 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:04 INFO - '_': '/tools/buildbot/bin/python'} 15:40:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:05 INFO - Downloading blobuploader-1.2.4.tar.gz 15:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:40:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:40:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:05 INFO - Downloading docopt-0.6.1.tar.gz 15:40:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:40:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:40:06 INFO - Running setup.py install for blobuploader 15:40:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:40:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:40:06 INFO - Running setup.py install for requests 15:40:06 INFO - Running setup.py install for docopt 15:40:06 INFO - Successfully installed blobuploader requests docopt 15:40:06 INFO - Cleaning up... 15:40:06 INFO - Return code: 0 15:40:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40: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')]} 15:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40: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')]} 15:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:06 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:06 INFO - Using env: {'DISPLAY': ':0', 15:40:06 INFO - 'HOME': '/home/cltbld', 15:40:06 INFO - 'LANG': 'en_US.UTF-8', 15:40:06 INFO - 'LANGUAGE': 'en_US:en', 15:40:06 INFO - 'LOGNAME': 'cltbld', 15:40:06 INFO - 'MAIL': '/var/mail/cltbld', 15:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:06 INFO - 'MOZ_NO_REMOTE': '1', 15:40:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:06 INFO - 'NO_EM_RESTART': '1', 15:40:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:06 INFO - 'PWD': '/builds/slave/test', 15:40:06 INFO - 'SHELL': '/bin/bash', 15:40:06 INFO - 'SHLVL': '1', 15:40:06 INFO - 'TERM': 'linux', 15:40:06 INFO - 'TMOUT': '86400', 15:40:06 INFO - 'USER': 'cltbld', 15:40:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:06 INFO - '_': '/tools/buildbot/bin/python'} 15:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:06 INFO - Running setup.py (path:/tmp/pip-DESjUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:06 INFO - Running setup.py (path:/tmp/pip-YDJ_os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:07 INFO - Running setup.py (path:/tmp/pip-MDyKx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:07 INFO - Running setup.py (path:/tmp/pip-xnHHJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:07 INFO - Running setup.py (path:/tmp/pip-ayJAO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:07 INFO - Running setup.py (path:/tmp/pip-af1Eky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:07 INFO - Running setup.py (path:/tmp/pip-cnOlt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:07 INFO - Running setup.py (path:/tmp/pip-EuMr46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:07 INFO - Running setup.py (path:/tmp/pip-PZqA8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:07 INFO - Running setup.py (path:/tmp/pip-QdzC9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:07 INFO - Running setup.py (path:/tmp/pip-65GaCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:07 INFO - Running setup.py (path:/tmp/pip-9fRzGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:07 INFO - Running setup.py (path:/tmp/pip-NJSx9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:07 INFO - Running setup.py (path:/tmp/pip-qpINSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:07 INFO - Running setup.py (path:/tmp/pip-pBdoFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:07 INFO - Running setup.py (path:/tmp/pip-62NTs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:08 INFO - Running setup.py (path:/tmp/pip-CAUTUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:40:08 INFO - Running setup.py install for manifestparser 15:40:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozcrash 15:40:08 INFO - Running setup.py install for mozdebug 15:40:08 INFO - Running setup.py install for mozdevice 15:40:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozfile 15:40:08 INFO - Running setup.py install for mozhttpd 15:40:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozinfo 15:40:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozInstall 15:40:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:40:08 INFO - Running setup.py install for mozleak 15:40:08 INFO - Running setup.py install for mozlog 15:40:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Running setup.py install for moznetwork 15:40:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Running setup.py install for mozprocess 15:40:09 INFO - Running setup.py install for mozprofile 15:40:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Running setup.py install for mozrunner 15:40:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Running setup.py install for mozscreenshot 15:40:09 INFO - Running setup.py install for moztest 15:40:09 INFO - Running setup.py install for mozversion 15:40:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:40:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:40:09 INFO - Cleaning up... 15:40:09 INFO - Return code: 0 15:40:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:09 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:09 INFO - Using env: {'DISPLAY': ':0', 15:40:09 INFO - 'HOME': '/home/cltbld', 15:40:09 INFO - 'LANG': 'en_US.UTF-8', 15:40:09 INFO - 'LANGUAGE': 'en_US:en', 15:40:09 INFO - 'LOGNAME': 'cltbld', 15:40:09 INFO - 'MAIL': '/var/mail/cltbld', 15:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:09 INFO - 'MOZ_NO_REMOTE': '1', 15:40:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:09 INFO - 'NO_EM_RESTART': '1', 15:40:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:09 INFO - 'PWD': '/builds/slave/test', 15:40:09 INFO - 'SHELL': '/bin/bash', 15:40:09 INFO - 'SHLVL': '1', 15:40:09 INFO - 'TERM': 'linux', 15:40:09 INFO - 'TMOUT': '86400', 15:40:09 INFO - 'USER': 'cltbld', 15:40:09 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:09 INFO - '_': '/tools/buildbot/bin/python'} 15:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:40:10 INFO - Running setup.py (path:/tmp/pip-8SH93e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:40:10 INFO - Running setup.py (path:/tmp/pip-bS3gdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:40:10 INFO - Running setup.py (path:/tmp/pip-nbY1xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:40:10 INFO - Running setup.py (path:/tmp/pip-JDLNxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:40:10 INFO - Running setup.py (path:/tmp/pip-IUDv9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:40:10 INFO - Running setup.py (path:/tmp/pip-UBuC8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:40:10 INFO - Running setup.py (path:/tmp/pip-eUA0Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:40:10 INFO - Running setup.py (path:/tmp/pip-ufC5ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:40:10 INFO - Running setup.py (path:/tmp/pip-DxGJwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:40:10 INFO - Running setup.py (path:/tmp/pip-0koCci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:40:10 INFO - Running setup.py (path:/tmp/pip-Gnc3VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:40:10 INFO - Running setup.py (path:/tmp/pip-AYAvS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:40:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:40:11 INFO - Running setup.py (path:/tmp/pip-fUIkPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:40:11 INFO - Running setup.py (path:/tmp/pip-jjxddo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:11 INFO - Running setup.py (path:/tmp/pip-5toNXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:40:11 INFO - Running setup.py (path:/tmp/pip-D6dSRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:40:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:40:11 INFO - Running setup.py (path:/tmp/pip-go9Cmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:40:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:40:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:12 INFO - Downloading blessings-1.6.tar.gz 15:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:40:12 INFO - Installing collected packages: blessings 15:40:12 INFO - Running setup.py install for blessings 15:40:12 INFO - Successfully installed blessings 15:40:12 INFO - Cleaning up... 15:40:12 INFO - Return code: 0 15:40:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:40:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:12 INFO - Reading from file tmpfile_stdout 15:40:12 INFO - Current package versions: 15:40:12 INFO - argparse == 1.2.1 15:40:12 INFO - blessings == 1.6 15:40:12 INFO - blobuploader == 1.2.4 15:40:12 INFO - docopt == 0.6.1 15:40:12 INFO - functools32 == 3.2.3-2 15:40:12 INFO - jsonschema == 2.5.1 15:40:12 INFO - manifestparser == 1.1 15:40:12 INFO - mozInstall == 1.13 15:40:12 INFO - mozcrash == 1.0 15:40:12 INFO - mozdebug == 0.1 15:40:12 INFO - mozdevice == 0.51 15:40:12 INFO - mozfile == 1.2 15:40:12 INFO - mozhttpd == 0.7 15:40:12 INFO - mozinfo == 0.10 15:40:12 INFO - mozleak == 0.1 15:40:12 INFO - mozlog == 3.5 15:40:12 INFO - moznetwork == 0.27 15:40:12 INFO - mozprocess == 0.25 15:40:12 INFO - mozprofile == 0.28 15:40:12 INFO - mozrunner == 6.13 15:40:12 INFO - mozscreenshot == 0.1 15:40:12 INFO - mozsystemmonitor == 0.3 15:40:12 INFO - moztest == 0.8 15:40:12 INFO - mozversion == 1.4 15:40:12 INFO - psutil == 3.1.1 15:40:12 INFO - requests == 1.2.3 15:40:12 INFO - wsgiref == 0.1.2 15:40:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:12 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:40:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:40:12 INFO - Using env: {'DISPLAY': ':0', 15:40:12 INFO - 'HOME': '/home/cltbld', 15:40:12 INFO - 'LANG': 'en_US.UTF-8', 15:40:12 INFO - 'LANGUAGE': 'en_US:en', 15:40:12 INFO - 'LOGNAME': 'cltbld', 15:40:12 INFO - 'MAIL': '/var/mail/cltbld', 15:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:12 INFO - 'MOZ_NO_REMOTE': '1', 15:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:12 INFO - 'NO_EM_RESTART': '1', 15:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:12 INFO - 'PWD': '/builds/slave/test', 15:40:12 INFO - 'SHELL': '/bin/bash', 15:40:12 INFO - 'SHLVL': '1', 15:40:12 INFO - 'TERM': 'linux', 15:40:12 INFO - 'TMOUT': '86400', 15:40:12 INFO - 'USER': 'cltbld', 15:40:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:12 INFO - '_': '/tools/buildbot/bin/python'} 15:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:40:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:40:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 15:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 15:40:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 15:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:40:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:40:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:40:14 INFO - Installing collected packages: marionette-driver, simplejson 15:40:14 INFO - Running setup.py install for marionette-driver 15:40:14 INFO - Running setup.py install for simplejson 15:40:14 INFO - building 'simplejson._speedups' extension 15:40:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:40:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:40:15 INFO - Successfully installed marionette-driver simplejson 15:40:15 INFO - Cleaning up... 15:40:15 INFO - Return code: 0 15:40:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:40:15 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 0x19fd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d6cfa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:40:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:40:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:40:15 INFO - Using env: {'DISPLAY': ':0', 15:40:15 INFO - 'HOME': '/home/cltbld', 15:40:15 INFO - 'LANG': 'en_US.UTF-8', 15:40:15 INFO - 'LANGUAGE': 'en_US:en', 15:40:15 INFO - 'LOGNAME': 'cltbld', 15:40:15 INFO - 'MAIL': '/var/mail/cltbld', 15:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:15 INFO - 'MOZ_NO_REMOTE': '1', 15:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:15 INFO - 'NO_EM_RESTART': '1', 15:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:15 INFO - 'PWD': '/builds/slave/test', 15:40:15 INFO - 'SHELL': '/bin/bash', 15:40:15 INFO - 'SHLVL': '1', 15:40:15 INFO - 'TERM': 'linux', 15:40:15 INFO - 'TMOUT': '86400', 15:40:15 INFO - 'USER': 'cltbld', 15:40:15 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:15 INFO - '_': '/tools/buildbot/bin/python'} 15:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:40:16 INFO - Cleaning up... 15:40:16 INFO - Return code: 0 15:40:16 INFO - Running post-action listener: _resource_record_post_action 15:40:16 INFO - Running post-action listener: _start_resource_monitoring 15:40:16 INFO - Starting resource monitoring. 15:40:16 INFO - [mozharness: 2017-07-10 22:40:16.105503Z] Finished create-virtualenv step (success) 15:40:16 INFO - [mozharness: 2017-07-10 22:40:16.106501Z] Running install step. 15:40:16 INFO - Running pre-action listener: _resource_record_pre_action 15:40:16 INFO - Running main action method: install 15:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:40:16 INFO - Reading from file tmpfile_stdout 15:40:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:40:16 INFO - Reading from file tmpfile_stdout 15:40:16 INFO - Output received: 15:40:16 INFO - Usage: mozinstall [options] installer 15:40:16 INFO - Options: 15:40:16 INFO - -h, --help show this help message and exit 15:40:16 INFO - -d DEST, --destination=DEST 15:40:16 INFO - Directory to install application into. [default: 15:40:16 INFO - "/builds/slave/test"] 15:40:16 INFO - --app=APP Application being installed. [default: firefox] 15:40:16 INFO - mkdir: /builds/slave/test/build/application 15:40:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:40:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:40:34 INFO - Reading from file tmpfile_stdout 15:40:34 INFO - Output received: 15:40:34 INFO - /builds/slave/test/build/application/firefox/firefox 15:40:34 INFO - Running post-action listener: _resource_record_post_action 15:40:34 INFO - [mozharness: 2017-07-10 22:40:34.396171Z] Finished install step (success) 15:40:34 INFO - [mozharness: 2017-07-10 22:40:34.396437Z] Running setup-mitmproxy step. 15:40:34 INFO - Running pre-action listener: _resource_record_pre_action 15:40:34 INFO - Running main action method: setup_mitmproxy 15:40:34 INFO - Skipping: mitmproxy is not required 15:40:34 INFO - Running post-action listener: _resource_record_post_action 15:40:34 INFO - [mozharness: 2017-07-10 22:40:34.397582Z] Finished setup-mitmproxy step (success) 15:40:34 INFO - [mozharness: 2017-07-10 22:40:34.397805Z] Running run-tests step. 15:40:34 INFO - Running pre-action listener: _resource_record_pre_action 15:40:34 INFO - Running pre-action listener: _set_gcov_prefix 15:40:34 INFO - Running main action method: run_tests 15:40:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:34 INFO - Python 2.7.3 15:40:34 INFO - Return code: 0 15:40:34 INFO - grabbing minidump binary from tooltool 15:40: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')]} 15:40:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d702a0>, '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 0x1d712b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6b4d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:40:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:40:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:40:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:34 INFO - Return code: 0 15:40:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:40:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:34 INFO - ENV: RUST_BACKTRACE is now 1 15:40:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:40:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:34 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/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:40:34 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/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:40:34 INFO - Using env: {'DISPLAY': ':0', 15:40:34 INFO - 'HOME': '/home/cltbld', 15:40:34 INFO - 'LANG': 'en_US.UTF-8', 15:40:34 INFO - 'LANGUAGE': 'en_US:en', 15:40:34 INFO - 'LOGNAME': 'cltbld', 15:40:34 INFO - 'MAIL': '/var/mail/cltbld', 15:40:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:40:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:34 INFO - 'MOZ_NO_REMOTE': '1', 15:40:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:40:34 INFO - 'NO_EM_RESTART': '1', 15:40:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:40:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:34 INFO - 'PWD': '/builds/slave/test', 15:40:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:34 INFO - 'RUST_BACKTRACE': '1', 15:40:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:40:34 INFO - 'SHELL': '/bin/bash', 15:40:34 INFO - 'SHLVL': '1', 15:40:34 INFO - 'TERM': 'linux', 15:40:34 INFO - 'TMOUT': '86400', 15:40:34 INFO - 'USER': 'cltbld', 15:40:34 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679', 15:40:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:34 INFO - '_': '/tools/buildbot/bin/python'} 15:40:34 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/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:40:34 INFO - mozversion application_buildid: 20170710215417 15:40:34 INFO - mozversion application_changeset: 5d794bf4c4653153e602631f1b8818acd559d8f5 15:40:34 INFO - mozversion application_display_name: Nightly 15:40:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:34 INFO - mozversion application_name: Firefox 15:40:34 INFO - mozversion application_remotingname: firefox 15:40:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:40:34 INFO - mozversion application_vendor: Mozilla 15:40:34 INFO - mozversion application_version: 56.0a1 15:40:34 INFO - mozversion platform_buildid: 20170710215417 15:40:34 INFO - mozversion platform_changeset: 5d794bf4c4653153e602631f1b8818acd559d8f5 15:40:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:40:34 INFO - mozversion platform_version: 56.0a1 15:40:34 INFO - using testdate: 1499726434 15:40:34 INFO - actual date: 1499726434 15:40:34 INFO - starting webserver on 'localhost:49802' 15:40:34 INFO - SUITE-START | Running 2 tests 15:40:34 INFO - TEST-START | dromaeo_css 15:40:34 INFO - Initialising browser for dromaeo_css test... 15:40:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49802/getInfo.html -profile /tmp/tmpjMtTQR/profile 15:40:34 INFO - TEST-INFO | started process 3341 (/builds/slave/test/build/application/firefox/firefox http://localhost:49802/getInfo.html) 15:40:43 INFO - TEST-INFO | 3341: exit 0 15:40:43 INFO - Browser initialized. 15:40:43 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:43 INFO - TEST-INFO | started process 3564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjMtTQR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:54 INFO - PID 3564 | RSS: Main: 172453888 15:40:54 INFO - PID 3564 | 15:43:54 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49802/tests/dromaeo/cssquery-ext.html) 15:43:56 INFO - PID 3564 | RSS: Main: 177639424 15:43:56 INFO - PID 3564 | 15:46:58 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-ext.html (next: http://localhost:49802/tests/dromaeo/cssquery-jquery.html) 15:46:58 INFO - PID 3564 | RSS: Main: 178716672 15:46:58 INFO - PID 3564 | 15:50:00 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49802/tests/dromaeo/cssquery-mootools.html) 15:50:01 INFO - PID 3564 | RSS: Main: 179945472 15:50:01 INFO - PID 3564 | 15:53:03 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49802/tests/dromaeo/cssquery-prototype.html) 15:53:03 INFO - PID 3564 | RSS: Main: 179326976 15:53:03 INFO - PID 3564 | 15:56:07 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49802/tests/dromaeo/cssquery-yui.html) 15:56:07 INFO - PID 3564 | RSS: Main: 177631232 15:56:07 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | Cycle 1(1): loaded http://localhost:49802/tests/dromaeo/cssquery-yui.html (next: http://localhost:49802/tests/dromaeo/cssquery-dojo.html) 15:59:09 INFO - PID 3564 | RSS: Main: 182468608 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | __start_tp_report 15:59:09 INFO - PID 3564 | _x_x_mozilla_page_load 15:59:09 INFO - PID 3564 | _x_x_mozilla_page_load_details 15:59:09 INFO - PID 3564 | |i|pagename|runs| 15:59:09 INFO - PID 3564 | |0;dojo.html;3049.6035515382996;3122.1258047746624;3138.827364494953;3153.731932785714;3168.017914446522;5781.913271300934;5850.79522216723;5851.707414629267;5875.618084824494;5923.229980102581;5878.52971762259;5938.495227905622;5944.4352786485215;5965.313988891279;5970.552208584363;5417.702026388547;5448.754806033738;5450.727463626823;5463.836084917459;5478.616496845222;5464.890702185954;5468.234447177379;5476.069068258405;5477.5070243678065;5503.284573005523;5455.918161227585;5466.9179962300595;5468.890622187574;5480.479354461339;5498.615096943216;5459.69971651559;5495.2856128703015;5495.752691128909;5506.807261745819;5507.118860982264;5307.628466007381;5371.597130215249;5447.373552041527;5492.5605951524185;5504;5963.224780778514;6000.969995149996;6043.063325184604;6087.0869369594475;6144.986077297241;6409.198850143732;6435.6782160892235;6461.57999730016;6528.836779080513;6533.346665333429;6203.2556093269095;6276.96861515694;6293.181886354791;6313.210848643919;6320.683965801738;5856.267966504187;5866.941330586682;5873.735681894325;5886;5891.351951285355;4928.658887028632;6426.260979987268;6451.000094985285;6458.935410645928;6638.236602790645;6365.904511432333;6376.266729326094;6448.580842245239;6465.094886715863;6472.611643301417;6429.6463694496315;6474.546781725234;6474.6762661866715;6556.246031706415;6571.112899758567;6207.503399728102;6297.086922396227;6304.873902521924;6419.197600299963;6514.804555863332;5180.663256888365;6324.936750632527;6334.524910631629;6341.270753863272;6358.586691865014;5093.134167191586;5270.077736396115;5348.9465105348445;5353.902449997741;5361.785528578813;4438.868088637377;4460.821567137278;4473.776311184428;4489.438820147481;4489.820407183676;5505.284313039279;5516.14499752539;5529.529989950899;5557.360903496069;5565.1374037024325;6386.712597933104;6391.041343798374;6393.776217832354;6400.935990640127;6404.23149222087;5476.069068258405;5506.944930550643;5546.057170281062;5570.387257401682;5610.07433773431;5525.198846167284;5756.856078598069;5820.156077368758;5847.1229315603;5859.912101318484;6113.23584551931;6137.478314343331;6140.3552626974415;6164.8767024659255;6171.876562468726;6295.213098362705;6340.778072767615;6357.268914074941;6374.617522948638;6382.32985536512;6091.725872335667;6109.175261339662;6129.601575897553;6130.693465326626;6144.662043587646;6294.464970477561;6294.716737746904;6355.300916899045;6378.138951241523;6400.327965563735;6400.359964003563;6424.807255782334;6522.021696745526;6530.575512591667;6532.738690452519;6024.096385542204;6142.078688196806;6149.477294429845;6214.782482613087;6301.117843501822;6162.352952940056;6164.321924588381;6176.135341052346;6181.629102253879;6182.598131121643;6043.09353596964;6067.848303792441;6085.361037091218;6088.4215999479975;6094.878102437838;5036.546710796046;6127.938720612737;6326.873462530815;6427.292997770335;6450;6102.542309326907;6131.049687298476;6152.630842149485;6183.134361189527;6196.535259855619 15:59:09 INFO - PID 3564 | |1;ext.html;807.8545861744888;817.5666896544833;864.6714248585539;889.1330952321488;893.5576889439728;40363.79818100909;41263;41304.17391652165;41308;41311.79344103275;39766.20467590646;40423.19153616926;43059.78470107653;43060;43100.784496077475;7646.273604007611;7774.727884524043;7788.805279867992;7790.9610451947665;7796.298333150015;7638.388928885676;7753.806154846117;7764.883526747103;7774.339181169579;7775.572343521104;7611.733589324374;7682.462227644067;7745.380369570449;7764.2235776422185;7774.41691873109;7688.384929205678;7705.036870391201;7734.381249500027;7745.806354841146;7769.184235655288;7454;7510.6620202091035;7544.962275188644;7553.509021913558;7558.055243094614;37731.05672358185;37869;37916.43125353122;38167.236655267014;38267;3683.318586061587;3692.150805314766;3696.31618150643;3700.5374328208973;3718.9256214875822;30903.381932361226;30939.690603093906;30985;31048.53427198594;31078.378432431226;4645.488996210414;4715.104130215248;4860.562549370574;4929.507049295078;4995.675281106753;190421;191293;191619;191783;192153;48618.75690621524;48648.51351486511;48920.26619600709;49136;49204.507954919995;51737;51801;51846;52042.47957520452;52064.21903671448;16215;16323.836761632469;16536.503904882873;16557.503274901774;16627.168641567874;13651.249181294925;13725.519606813714;13817.240051797047;13830.37763300654;13832.654183645489;13184.538541151205;13493.257870817199;13501.797473037912;13560.525381611596;13689.589312320646;5293.311869456946;5345.679259244458;5368.624196306221;5449.482299181572;5450.591205659592;975.512243878061;981.6417007792104;982.5234761140983;997.187292356727;1029.9691009269734;23635.40911477227;28385.43229135447;28560.42879142447;28814.855925720236;29493.705062949095;1128.311729844794;1132.0754716981066;1134.8354488599107;1135.9488823002985;1139.128566646516;12472.645515863103;12733.55432559856;12951.676208094685;12957.805632915513;16031.839681603267;216179;216397;217736;233148;235768;57914;58861;59059.70470147708;59352.70323648354;59381.40618593845;1529.6175956010998;1545.5363390982661;1550.9999999999775;1553.7280975829185;1555.9377624894878;27123;27885.860570697827;27960.30099247535;28236.294092647848;28577.714222858336;39766.60233397629;39860.80069599633;40030.59969400269;40205.39691904682;40224.1955160901;208785;210221;211271;211821;212390;35233.29533409369;35688.464673030445;35842.924712258675;36040.63959360373;36485.27029459449;40957.38563921484;44607;44704.55295447004;45102.09795804;45858.31212531748;31118.688813112483;31618.367632646758;31763.20591985219;31770.68229317677;32302.192445188117;30413.543796843507;31736.206594835316;31906.20234494156;31985.8400707995;32069.35861282808;34907;35016;38511.22977540489;39520.802395987834;39534;31475.527867081553;32345.42994218231;33436.33127337488;33462;33843.323133537684;24133.637995430432;24301.27096187117;24642;24768.628470573316;24964.75035249697 15:59:09 INFO - PID 3564 | |2;jquery.html;575.0999685492204;575.4360726488039;576.7347020370632;584.3601256623997;593.8159170657096;16069;21801.345959621198;22793.202237921676;22830.657540136912;22854.31437056889;18377.44867653969;18491;18823.71764423535;18852.34016809412;20790.68813967788;3911.8239679214503;4046.028953051276;6388.041793730954;6403.871922561546;6432.742690292383;6492.610443373389;6608.339166083378;6611.305812889649;6633.402993730563;6646.534742568022;6438.420542151205;6559.8032059038305;6565.507586930976;6578.835529111787;6579.572327798702;6512.641804700739;6561.40947314744;6566.244881838602;6567.573107748005;6577;5996.220491336142;6734.663266836638;6748.190217173921;6764.763233286812;6769.8646027079185;30083.548746768814;30531.542026869614;30818.84590577055;30839.38321233585;30882.382352353052;1990.233760002395;2014.1339224133617;2035.155410504639;2035.297822251321;2039.836813054952;18758.812411875842;19440.125194366286;19596.510087247934;20040.1983920643;20159.193632254694;2264.320703788857;2359.858408495496;2360.173939121311;2360.45709486819;2369.3010561884284;125082;129472.35263823715;129846;130297;136141;19823.414126869815;20427.387178384673;21630.783692162877;21940.45148871259;22405.43986400353;42576.361354579705;42720.57279427166;42781.78609106997;42961;43015.35476967848;11445.427728613537;11641.708957276136;11670.241434306743;11840;11919.404029798476;9711.757206069904;9714.3199976001;9774.51127443625;9806.803863922823;9814.509274536387;11279.379634120201;11428.771424571461;11557.537698492135;11599.246049006957;11785.116116291312;4198.139381426861;4262.42457268271;4318.827246910151;4340.848070317524;4355.695101342875;970.8883478399933;978.1636700621009;984.9892358960708;1002.6891663584166;1015.0864222200079;18440.815591844177;18780.154893029845;18845.717314240297;18864.622707545772;18966.52583685419;1039.1271332081087;1061.9469026548795;1063.160103518212;1084.1056128693858;1084.8426978088132;9949.502524873727;10032.799344013225;10149.898501014895;10190.337628054302;10243.84634230487;454146;454618;465444;466655;467990;112834;116221.418892905;116942;117835;118405;1101;1198.4906414773686;1229.164168365502;1254.7678679444332;1280.6414204022888;18600.34898778536;18645.533861653566;18688.81311186871;18789.530261743566;18819;48937.75531122321;50849.23726144185;51873.740631296605;53658.195127072344;53815.73092134671;65388.34611654013;65660.34339656543;66024;66215.33784662091;66981.33018669946;18138.365157219436;18800.7179892299;19334.12996415193;19473.221071156993;19556.119974600893;21190.576188476454;21408.892955535124;22384.888075559516;22476.213332533283;22497.550048999256;17395;17459.650806983536;17737.113144342475;17755;18067.728984065514;14925.552233433014;15502.302396391964;15789.605259868595;16122.67754644924;16498;17274.913625431793;17561.736573951144;17583.648327033643;17869.73195402044;19429.902850485658;14359.856401435853;14385.208813515357;14414.711705765616;14447.638809029439;14548.854511455173;16984.745228821826;18012.90993545024;18024.729629055313;18052.097395130455;18224.45326640203 15:59:09 INFO - PID 3564 | |3;mootools.html;1379.9034067615269;1452.3754785442263;1457.1402872305339;1461.6711239971007;1475.122302230173;12774.744505109904;13427.664308392295;13454.394552245149;13470;13478;11702.239354441956;12043.578474753385;12507.124501284914;12515.123941324111;12565.183263087893;2599.4801039792023;2637.4593208392234;2648.9470210595778;2667.213172114231;2669.7997650176217;2522.8612426316545;2584.056819260975;2590.456004239112;2596.5715656916586;2598.5192739343283;2530.8354956927833;2557.5268575313535;2587.8964841406323;2592.520383729007;2596.31197732601;2442.9755702442926;2489.3776555861036;2493.1772515069983;2495.5258500884865;2500.0749722602663;2419.6491508731137;2429.27121863442;2558.744125587445;2582.483503299348;2601.9609705854427;12389.504419823195;12646.936765316206;12675.17611355259;12681.619551413472;12716.618501444971;7195.460340474486;7472.140703819076;7479.962600187018;7481.289277518627;7490.288422599844;4773.976130119362;4924.236743304794;5009.674371165863;5056.595472362203;5059.671121377099;1782.8217178282198;1845.8523318134517;1880.2479008396751;1900.6008738164865;1912.3020097664253;19893.900530497398;20695.379138625714;21019.684704729287;21201.46996325089;21517.462063448384;6311.873762524724;6414.294427612959;6618;6663.567797753882;6666.100076489709;17054.14729263532;17054.829451705325;17098;17122.82877171237;17222.483325500256;7425;7563.243675632392;7568;7595;7622.123455802654;6713.832154196184;6745.696443660047;6857.794266172023;6892.689828957709;6958.165020197609;5121.385433747974;5291.285676433709;5308.150695888639;5366.2755528004;5444.074507333763;1573.8190108137483;1640.1225344440668;1653.5866033491627;1662.0858527809655;1666.1752432545968;903.5301643145527;916.9679061232824;928.2017464980112;933.0669330669331;941.2799208605422;6936.93063069373;6976.127984002;7005.894911576331;7008.299170082951;7093.361597456254;705.5519744961883;722.342668171961;722.8048426924701;725.1733024352243;731.4587205468022;4328.696991210585;5006.173981293119;5029.698218106925;5055.595552355802;5120.590352771769;15064.623384415258;15619.687606247811;15732.68534629301;15766.211689415484;16501.257443415074;17371.131443427777;17422.390216342366;17744.645107097786;17790.110494475484;17955.910220448815;8349.081601023883;10506.581611482505;10540.156787456985;10564.471776411148;10572.101371383365;6945.826354341182;7981.40139489529;8002.359811214972;8026.719064832703;8072.9192708074515;13888.583342499742;14214.360353783897;15199.924000379928;16073.35706571724;16163.67672646564;15042.699146017238;15304.387824486896;15985.920070399574;16218.432354867524;16425.753613696044;10273.434961077213;10504.42225677595;10517.894821051997;10534.209934254808;10548;12362.75274494523;12744.936275318563;12760.553380631633;12768.808467873176;12837.550685725955;9919.107280344804;10160.390376577428;10300.278980471296;10310.690679279634;10352.068313851789;9353.11145441182;9367.721044345402;9474;9523.857142143012;9708.320417570985;9026.18764311215;9170.908290917005;9175.26597872182;9177.77055573616;9178.67874624385;6794.150731158606;7007.299270072952;7056.294370563108;7095.219525852049;7180.856382872418;7015.543989640657;7049.682764275723;7102.431805455654;7174.677139528838;7240.746573869889 15:59:09 INFO - PID 3564 | |4;prototype.html;490.4378978222449;499.8419472103682;516.7158063065315;519.200431335743;521.6244304101045;5996.730147143378;6055.788047418341;6073;6122.969385153079;6140.508759299257;5725.599208055427;5937.901488224681;5981;6060.2424696912885;6095.207623009002;4868.537488938545;4894.730789806559;4932.53140951609;4936.284238785374;4959.479254678261;4870.561649451549;4891.16850135476;4900.558949694527;4901.485344038878;4925.635694866466;4845.903081938359;4857.635677324197;4869.805207791684;4872.78072486739;4875.341828853113;4639.976800115995;4778.689385189951;4821.674039639092;4856.15017371962;4876.536729010738;4353.825846966118;4354.825806967718;4355.5208927018;4365.541618130114;4374.737515749065;5823.417658234185;5846.883062338729;5896.351401345849;5925.4370834770625;5939.227900372967;5551.944480555224;5554.111342185231;5564.1931919871795;5595.944040559623;5621.718914054321;6367.363263673642;6434.388733070351;6438.742450301982;6448.871022579569;6487;4797.088553174885;4809.446913604946;4816.397950256218;4826.806927722887;4835.588974937099;6632.568883022588;6645.435138013275;6741.224759152711;6761.898571521431;6791.151106111736;4918.803247870045;4947.095368283237;4959.305697202394;4968.6025117990475;4969.229769385751;4875.878103047452;4952.232403977389;4972.801087956514;4988.650794444354;5016.949830501721;5424.674519528762;5432.239486471897;5448.509634132947;5525.696086715269;5554.972225138848;6393.584417012972;6432.903506447407;6443.96778016107;6457.903131453032;6483.4164925156965;1712.24661149094;1716.9399071032453;1736.192670408241;1736.6787144378332;1739.4172952061201;1106.446776611694;1199.736058067224;1209.7036226124656;1218.2386008744534;1220.8412906322299;5489.615726899079;5571.749271282802;5640.746166422438;5666.631668941588;5676.943230567724;6604.603723776589;6611;6637.269900310962;6642.900356494656;6658.334166583303;5583.888322233533;5607.243022191952;5625.268715067097;5649.774009039593;5675.3757086720425;3482.338355712457;3495.4407294833213;3501.509788629594;3508.456189290664;3511.455724362728;6260.40526150015;6269.902767015754;6276.278228003746;6416.550841441054;6417.711202995876;6630.701618427182;6632.6352050636715;6643.734250629921;6662.300458451793;6710.496712746563;6282.340354262828;6382.968085159545;6411.935880641227;6424.710888009958;6446.258680251831;6622.271550129385;6626.370494802986;6640.800775976729;6665.400113989765;6681.062491877301;6474.449671777952;6494.415502604599;6514.413702766774;6526.412622863965;6527.934720652733;6225.906611400742;6317.905231421624;6361.332060133619;6368.216899268213;6408.679566021587;4761.357216775691;4851.854444366674;4853.805847766191;4894.877628059327;4901.5588597026435;6568.113304703804;6586.407223349922;6593.868122637425;6630.171228596426;6662.6335551545135;6332.8284267408835;6397.744090236339;6445.2265728112925;6453.45145662624;6465.353464653497;6443.67781610927;6467.320931302145;6467.805965821033;6473.611583305017;6475.643839588868;6234.220722409699;6286.5599408041;6321.52588555851;6375.449820072008;6400.51996100285;5908.586398952204;6349.6507692077375;6398.456131228898;6407.839804004937;6459.547831651739;5986.4978987292925;6072.574919755575;6088.330283668704;6098.115318717459;6231.077448815385 15:59:09 INFO - PID 3564 | |5;yui.html;926.1248120526103;929.1173385283981;948.0850978805456;949.7483166960752;957.1242313283346;18313.359032433884;18678;18867.62264754704;18907.716384254247;18987;19260.711089333672;20062.097205625745;20648;20890.89554552225;20952.26667066653;1031.6750223679535;1051.3008849115367;1051.374432212836;1052.431686889079;1053.3258714422775;1056.8520407143005;1064.435849000031;1068.60995736556;1070.411273799411;1070.464767616192;1066.3921564708119;1095.1457862866937;1103.189155970361;1108.2685427617773;1109.1459576126379;1107.0479387726589;1110.6612483192623;1114.5318966034204;1115.074488174821;1119.0040863631375;799.7880561651167;803.3452736020125;803.9919600803976;803.995980020102;804.0512195609178;18759.812401875944;18923;19001.42995710131;19153.425397238105;20088.995550222575;19527.218911243534;19598.412047638452;19892.303769368147;20118;20244.493887652778;15511.844881551266;15612.29744661493;15822.841771582367;15850.44523441674;15859.207039648087;3540.4689296605457;3547.1486843157713;3552.236269202108;3563.322968635951;3570.2145527983803;102700.99999999926;105750;107744;110484;111300.4434977828;16039.117848518443;16549.338026479047;16556.917215414087;16616.750748738777;16651.833481665028;28281.292967675563;29150.416991660048;29269.56095658567;29328.26679333034;29522.261943451154;8612.698555550525;8669.393142479967;8699.304055675531;8731.956340218385;8806.823863522694;4162.937555936664;4234.06850492891;4242.215190189825;4278.272693642089;4304.289792184317;5041.521055499722;5149.45930677281;5152.793888244429;5156.587473002151;5158.92261616076;909.3997961345481;944.8724422203052;950.8336041192764;1066.6213494209599;1072.1851392941421;629.2951893878793;676.4655921821706;690.7616872179091;709.3686618909175;722.4725950056488;10846.62036828723;11064.17018723599;11690.47392867323;11866.288022718665;12028.578999734968;639.5810743962712;650.187265917603;661.6790856434625;663.7510933399975;666.1273731411866;5091.465396133427;5268.710220937885;5301.3373328333955;5371.892562148735;5409.594280428983;93343.53328233451;96267;98355;101100;101483;85064;85203;87246.69129963056;88157.55921220481;89118;71739;75139.62430187814;75722;76358.6182069086;77513.61243193748;10338;10526.578936842747;10778.461076945965;10853.294535855144;10872.891271087188;32579.674203257666;32860.1784955378;33150.5027424584;34138.31723365469;34873.12817179591;41216.38175427431;42317.78841105775;43287.350689740306;43869.78065109654;44343;15666.686666266383;15783.053016819027;16003.679926401639;16238.837611624205;16322.591935201715;14578.85421145775;15012.099274043592;15154.242287885781;15230.390784368501;15416.614584635025;14618.634534136307;15073.17097559601;15117.244137793286;15138.621534461727;15241.31414086391;15346.616334591277;15588.68822623564;15743.921280393524;15799.447019354728;16020.919895400448;14763.852361476247;14800.555983320517;14848.554543363716;14873.628159296104;15156.393744250548;10225.590976360862;10841;10844.67465976022;11097.278676885977;11259.268147570381;9922.454265015205;9943.453110079015;10035.397876127456;10231.181505479395;10389.168866490814 15:59:09 INFO - PID 3564 | __end_tp_report 15:59:09 INFO - PID 3564 | __start_cc_report 15:59:09 INFO - PID 3564 | _x_x_mozilla_cycle_collect,348 15:59:09 INFO - PID 3564 | __end_cc_report 15:59:09 INFO - PID 3564 | __startTimestamp1499727549587__endTimestamp 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | ------- Summary: start ------- 15:59:09 INFO - PID 3564 | Number of tests: 6 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#0] dojo.html Cycles:165 Average:5865.52 Median:6091.73 stddev:678.72 (11.1%) stddev-sans-first:643.85 15:59:09 INFO - PID 3564 | Values: 3049.6 3122.1 3138.8 3153.7 3168.0 5781.9 5850.8 5851.7 5875.6 5923.2 5878.5 5938.5 5944.4 5965.3 5970.6 5417.7 5448.8 5450.7 5463.8 5478.6 5464.9 5468.2 5476.1 5477.5 5503.3 5455.9 5466.9 5468.9 5480.5 5498.6 5459.7 5495.3 5495.8 5506.8 5507.1 5307.6 5371.6 5447.4 5492.6 5504.0 5963.2 6001.0 6043.1 6087.1 6145.0 6409.2 6435.7 6461.6 6528.8 6533.3 6203.3 6277.0 6293.2 6313.2 6320.7 5856.3 5866.9 5873.7 5886.0 5891.4 4928.7 6426.3 6451.0 6458.9 6638.2 6365.9 6376.3 6448.6 6465.1 6472.6 6429.6 6474.5 6474.7 6556.2 6571.1 6207.5 6297.1 6304.9 6419.2 6514.8 5180.7 6324.9 6334.5 6341.3 6358.6 5093.1 5270.1 5348.9 5353.9 5361.8 4438.9 4460.8 4473.8 4489.4 4489.8 5505.3 5516.1 5529.5 5557.4 5565.1 6386.7 6391.0 6393.8 6400.9 6404.2 5476.1 5506.9 5546.1 5570.4 5610.1 5525.2 5756.9 5820.2 5847.1 5859.9 6113.2 6137.5 6140.4 6164.9 6171.9 6295.2 6340.8 6357.3 6374.6 6382.3 6091.7 6109.2 6129.6 6130.7 6144.7 6294.5 6294.7 6355.3 6378.1 6400.3 6400.4 6424.8 6522.0 6530.6 6532.7 6024.1 6142.1 6149.5 6214.8 6301.1 6162.4 6164.3 6176.1 6181.6 6182.6 6043.1 6067.8 6085.4 6088.4 6094.9 5036.5 6127.9 6326.9 6427.3 6450.0 6102.5 6131.0 6152.6 6183.1 6196.5 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#1] ext.html Cycles:180 Average:38502.76 Median:3698.43 stddev:54171.50 (1464.7%) stddev-sans-first:54249.52 15:59:09 INFO - PID 3564 | Values: 807.9 817.6 864.7 889.1 893.6 40363.8 41263.0 41304.2 41308.0 41311.8 39766.2 40423.2 43059.8 43060.0 43100.8 7646.3 7774.7 7788.8 7791.0 7796.3 7638.4 7753.8 7764.9 7774.3 7775.6 7611.7 7682.5 7745.4 7764.2 7774.4 7688.4 7705.0 7734.4 7745.8 7769.2 7454.0 7510.7 7545.0 7553.5 7558.1 37731.1 37869.0 37916.4 38167.2 38267.0 3683.3 3692.2 3696.3 3700.5 3718.9 30903.4 30939.7 30985.0 31048.5 31078.4 4645.5 4715.1 4860.6 4929.5 4995.7 190421.0 191293.0 191619.0 191783.0 192153.0 48618.8 48648.5 48920.3 49136.0 49204.5 51737.0 51801.0 51846.0 52042.5 52064.2 16215.0 16323.8 16536.5 16557.5 16627.2 13651.2 13725.5 13817.2 13830.4 13832.7 13184.5 13493.3 13501.8 13560.5 13689.6 5293.3 5345.7 5368.6 5449.5 5450.6 975.5 981.6 982.5 997.2 1030.0 23635.4 28385.4 28560.4 28814.9 29493.7 1128.3 1132.1 1134.8 1135.9 1139.1 12472.6 12733.6 12951.7 12957.8 16031.8 216179.0 216397.0 217736.0 233148.0 235768.0 57914.0 58861.0 59059.7 59352.7 59381.4 1529.6 1545.5 1551.0 1553.7 1555.9 27123.0 27885.9 27960.3 28236.3 28577.7 39766.6 39860.8 40030.6 40205.4 40224.2 208785.0 210221.0 211271.0 211821.0 212390.0 35233.3 35688.5 35842.9 36040.6 36485.3 40957.4 44607.0 44704.6 45102.1 45858.3 31118.7 31618.4 31763.2 31770.7 32302.2 30413.5 31736.2 31906.2 31985.8 32069.4 34907.0 35016.0 38511.2 39520.8 39534.0 31475.5 32345.4 33436.3 33462.0 33843.3 24133.6 24301.3 24642.0 24768.6 24964.8 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#2] jquery.html Cycles:180 Average:34179.94 Median:2037.57 stddev:77834.01 (3819.9%) stddev-sans-first:78011.46 15:59:09 INFO - PID 3564 | Values: 575.1 575.4 576.7 584.4 593.8 16069.0 21801.3 22793.2 22830.7 22854.3 18377.4 18491.0 18823.7 18852.3 20790.7 3911.8 4046.0 6388.0 6403.9 6432.7 6492.6 6608.3 6611.3 6633.4 6646.5 6438.4 6559.8 6565.5 6578.8 6579.6 6512.6 6561.4 6566.2 6567.6 6577.0 5996.2 6734.7 6748.2 6764.8 6769.9 30083.5 30531.5 30818.8 30839.4 30882.4 1990.2 2014.1 2035.2 2035.3 2039.8 18758.8 19440.1 19596.5 20040.2 20159.2 2264.3 2359.9 2360.2 2360.5 2369.3 125082.0 129472.4 129846.0 130297.0 136141.0 19823.4 20427.4 21630.8 21940.5 22405.4 42576.4 42720.6 42781.8 42961.0 43015.4 11445.4 11641.7 11670.2 11840.0 11919.4 9711.8 9714.3 9774.5 9806.8 9814.5 11279.4 11428.8 11557.5 11599.2 11785.1 4198.1 4262.4 4318.8 4340.8 4355.7 970.9 978.2 985.0 1002.7 1015.1 18440.8 18780.2 18845.7 18864.6 18966.5 1039.1 1061.9 1063.2 1084.1 1084.8 9949.5 10032.8 10149.9 10190.3 10243.8 454146.0 454618.0 465444.0 466655.0 467990.0 112834.0 116221.4 116942.0 117835.0 118405.0 1101.0 1198.5 1229.2 1254.8 1280.6 18600.3 18645.5 18688.8 18789.5 18819.0 48937.8 50849.2 51873.7 53658.2 53815.7 65388.3 65660.3 66024.0 66215.3 66981.3 18138.4 18800.7 19334.1 19473.2 19556.1 21190.6 21408.9 22384.9 22476.2 22497.6 17395.0 17459.7 17737.1 17755.0 18067.7 14925.6 15502.3 15789.6 16122.7 16498.0 17274.9 17561.7 17583.6 17869.7 19429.9 14359.9 14385.2 14414.7 14447.6 14548.9 16984.7 18012.9 18024.7 18052.1 18224.5 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#3] mootools.html Cycles:180 Average:8179.79 Median:2585.98 stddev:5360.59 (207.3%) stddev-sans-first:5351.27 15:59:09 INFO - PID 3564 | Values: 1379.9 1452.4 1457.1 1461.7 1475.1 12774.7 13427.7 13454.4 13470.0 13478.0 11702.2 12043.6 12507.1 12515.1 12565.2 2599.5 2637.5 2648.9 2667.2 2669.8 2522.9 2584.1 2590.5 2596.6 2598.5 2530.8 2557.5 2587.9 2592.5 2596.3 2443.0 2489.4 2493.2 2495.5 2500.1 2419.6 2429.3 2558.7 2582.5 2602.0 12389.5 12646.9 12675.2 12681.6 12716.6 7195.5 7472.1 7480.0 7481.3 7490.3 4774.0 4924.2 5009.7 5056.6 5059.7 1782.8 1845.9 1880.2 1900.6 1912.3 19893.9 20695.4 21019.7 21201.5 21517.5 6311.9 6414.3 6618.0 6663.6 6666.1 17054.1 17054.8 17098.0 17122.8 17222.5 7425.0 7563.2 7568.0 7595.0 7622.1 6713.8 6745.7 6857.8 6892.7 6958.2 5121.4 5291.3 5308.2 5366.3 5444.1 1573.8 1640.1 1653.6 1662.1 1666.2 903.5 917.0 928.2 933.1 941.3 6936.9 6976.1 7005.9 7008.3 7093.4 705.6 722.3 722.8 725.2 731.5 4328.7 5006.2 5029.7 5055.6 5120.6 15064.6 15619.7 15732.7 15766.2 16501.3 17371.1 17422.4 17744.6 17790.1 17955.9 8349.1 10506.6 10540.2 10564.5 10572.1 6945.8 7981.4 8002.4 8026.7 8072.9 13888.6 14214.4 15199.9 16073.4 16163.7 15042.7 15304.4 15985.9 16218.4 16425.8 10273.4 10504.4 10517.9 10534.2 10548.0 12362.8 12744.9 12760.6 12768.8 12837.6 9919.1 10160.4 10300.3 10310.7 10352.1 9353.1 9367.7 9474.0 9523.9 9708.3 9026.2 9170.9 9175.3 9177.8 9178.7 6794.2 7007.3 7056.3 7095.2 7180.9 7015.5 7049.7 7102.4 7174.7 7240.7 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#4] prototype.html Cycles:180 Average:5385.25 Median:5931.67 stddev:1508.80 (25.4%) stddev-sans-first:1467.62 15:59:09 INFO - PID 3564 | Values: 490.4 499.8 516.7 519.2 521.6 5996.7 6055.8 6073.0 6123.0 6140.5 5725.6 5937.9 5981.0 6060.2 6095.2 4868.5 4894.7 4932.5 4936.3 4959.5 4870.6 4891.2 4900.6 4901.5 4925.6 4845.9 4857.6 4869.8 4872.8 4875.3 4640.0 4778.7 4821.7 4856.2 4876.5 4353.8 4354.8 4355.5 4365.5 4374.7 5823.4 5846.9 5896.4 5925.4 5939.2 5551.9 5554.1 5564.2 5595.9 5621.7 6367.4 6434.4 6438.7 6448.9 6487.0 4797.1 4809.4 4816.4 4826.8 4835.6 6632.6 6645.4 6741.2 6761.9 6791.2 4918.8 4947.1 4959.3 4968.6 4969.2 4875.9 4952.2 4972.8 4988.7 5016.9 5424.7 5432.2 5448.5 5525.7 5555.0 6393.6 6432.9 6444.0 6457.9 6483.4 1712.2 1716.9 1736.2 1736.7 1739.4 1106.4 1199.7 1209.7 1218.2 1220.8 5489.6 5571.7 5640.7 5666.6 5676.9 6604.6 6611.0 6637.3 6642.9 6658.3 5583.9 5607.2 5625.3 5649.8 5675.4 3482.3 3495.4 3501.5 3508.5 3511.5 6260.4 6269.9 6276.3 6416.6 6417.7 6630.7 6632.6 6643.7 6662.3 6710.5 6282.3 6383.0 6411.9 6424.7 6446.3 6622.3 6626.4 6640.8 6665.4 6681.1 6474.4 6494.4 6514.4 6526.4 6527.9 6225.9 6317.9 6361.3 6368.2 6408.7 4761.4 4851.9 4853.8 4894.9 4901.6 6568.1 6586.4 6593.9 6630.2 6662.6 6332.8 6397.7 6445.2 6453.5 6465.4 6443.7 6467.3 6467.8 6473.6 6475.6 6234.2 6286.6 6321.5 6375.4 6400.5 5908.6 6349.7 6398.5 6407.8 6459.5 5986.5 6072.6 6088.3 6098.1 6231.1 15:59:09 INFO - PID 3564 | 15:59:09 INFO - PID 3564 | [#5] yui.html Cycles:180 Average:20531.85 Median:19207.07 stddev:27446.39 (142.9%) stddev-sans-first:27483.90 15:59:09 INFO - PID 3564 | Values: 926.1 929.1 948.1 949.7 957.1 18313.4 18678.0 18867.6 18907.7 18987.0 19260.7 20062.1 20648.0 20890.9 20952.3 1031.7 1051.3 1051.4 1052.4 1053.3 1056.9 1064.4 1068.6 1070.4 1070.5 1066.4 1095.1 1103.2 1108.3 1109.1 1107.0 1110.7 1114.5 1115.1 1119.0 799.8 803.3 804.0 804.0 804.1 18759.8 18923.0 19001.4 19153.4 20089.0 19527.2 19598.4 19892.3 20118.0 20244.5 15511.8 15612.3 15822.8 15850.4 15859.2 3540.5 3547.1 3552.2 3563.3 3570.2 102701.0 105750.0 107744.0 110484.0 111300.4 16039.1 16549.3 16556.9 16616.8 16651.8 28281.3 29150.4 29269.6 29328.3 29522.3 8612.7 8669.4 8699.3 8732.0 8806.8 4162.9 4234.1 4242.2 4278.3 4304.3 5041.5 5149.5 5152.8 5156.6 5158.9 909.4 944.9 950.8 1066.6 1072.2 629.3 676.5 690.8 709.4 722.5 10846.6 11064.2 11690.5 11866.3 12028.6 639.6 650.2 661.7 663.8 666.1 5091.5 5268.7 5301.3 5371.9 5409.6 93343.5 96267.0 98355.0 101100.0 101483.0 85064.0 85203.0 87246.7 88157.6 89118.0 71739.0 75139.6 75722.0 76358.6 77513.6 10338.0 10526.6 10778.5 10853.3 10872.9 32579.7 32860.2 33150.5 34138.3 34873.1 41216.4 42317.8 43287.4 43869.8 44343.0 15666.7 15783.1 16003.7 16238.8 16322.6 14578.9 15012.1 15154.2 15230.4 15416.6 14618.6 15073.2 15117.2 15138.6 15241.3 15346.6 15588.7 15743.9 15799.4 16020.9 14763.9 14800.6 14848.6 14873.6 15156.4 10225.6 10841.0 10844.7 11097.3 11259.3 9922.5 9943.5 10035.4 10231.2 10389.2 15:59:09 INFO - PID 3564 | -------- Summary: end -------- 15:59:09 INFO - PID 3564 | 15:59:10 INFO - TEST-INFO | 3564: exit 0 15:59:10 INFO - TEST-OK | dromaeo_css | took 1115247ms 15:59:10 INFO - TEST-START | kraken 15:59:10 INFO - Initialising browser for kraken test... 15:59:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49802/getInfo.html -profile /tmp/tmpuF1rDS/profile 15:59:10 INFO - TEST-INFO | started process 3975 (/builds/slave/test/build/application/firefox/firefox http://localhost:49802/getInfo.html) 15:59:16 INFO - TEST-INFO | 3975: exit 0 15:59:16 INFO - Browser initialized. 15:59:16 INFO - Running cycle 1/1 for kraken test... 15:59:16 INFO - TEST-INFO | started process 4198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuF1rDS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:27 INFO - PID 4198 | RSS: Main: 173289472 15:59:27 INFO - PID 4198 | 15:59:30 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49802/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:31 INFO - PID 4198 | RSS: Main: 177831936 15:59:31 INFO - PID 4198 | 15:59:34 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49802/tests/kraken/driver.html?testName=audio-dft) 15:59:34 INFO - PID 4198 | RSS: Main: 178343936 15:59:34 INFO - PID 4198 | 15:59:37 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49802/tests/kraken/driver.html?testName=audio-fft) 15:59:38 INFO - PID 4198 | RSS: Main: 173113344 15:59:38 INFO - PID 4198 | 15:59:40 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49802/tests/kraken/driver.html?testName=audio-oscillator) 15:59:41 INFO - PID 4198 | RSS: Main: 173469696 15:59:41 INFO - PID 4198 | 15:59:43 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49802/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:43 INFO - PID 4198 | RSS: Main: 173109248 15:59:43 INFO - PID 4198 | 15:59:46 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49802/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:47 INFO - PID 4198 | RSS: Main: 175923200 15:59:47 INFO - PID 4198 | 15:59:50 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49802/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:51 INFO - PID 4198 | RSS: Main: 177688576 15:59:51 INFO - PID 4198 | 15:59:54 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49802/tests/kraken/driver.html?testName=json-parse-financial) 15:59:54 INFO - PID 4198 | RSS: Main: 177598464 15:59:54 INFO - PID 4198 | 15:59:56 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49802/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:57 INFO - PID 4198 | RSS: Main: 177410048 15:59:57 INFO - PID 4198 | 15:59:58 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:59 INFO - PID 4198 | RSS: Main: 177192960 15:59:59 INFO - PID 4198 | 16:00:01 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:00:02 INFO - PID 4198 | RSS: Main: 176881664 16:00:02 INFO - PID 4198 | 16:00:04 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:00:05 INFO - PID 4198 | RSS: Main: 177086464 16:00:05 INFO - PID 4198 | 16:00:08 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:00:09 INFO - PID 4198 | RSS: Main: 177180672 16:00:09 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:49802/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49802/tests/kraken/driver.html?testName=ai-astar) 16:00:11 INFO - PID 4198 | RSS: Main: 178708480 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | __start_tp_report 16:00:11 INFO - PID 4198 | _x_x_mozilla_page_load 16:00:11 INFO - PID 4198 | _x_x_mozilla_page_load_details 16:00:11 INFO - PID 4198 | |i|pagename|runs| 16:00:11 INFO - PID 4198 | |0;ai-astar;101;111;110;109;109;110;116;109;110;110 16:00:11 INFO - PID 4198 | |1;audio-beat-detection;147;122;144;184;122;156;152;123;178;119 16:00:11 INFO - PID 4198 | |2;audio-dft;163;163;164;161;162;169;163;174;173;169 16:00:11 INFO - PID 4198 | |3;audio-fft;74;75;75;147;77;75;76;75;95;75 16:00:11 INFO - PID 4198 | |4;audio-oscillator;82;82;144;83;83;82;140;83;82;148 16:00:11 INFO - PID 4198 | |5;imaging-gaussian-blur;115;115;114;114;114;114;114;113;113;113 16:00:11 INFO - PID 4198 | |6;imaging-darkroom;149;150;150;150;151;150;149;149;151;150 16:00:11 INFO - PID 4198 | |7;imaging-desaturate;95;95;94;94;94;94;94;94;94;94 16:00:11 INFO - PID 4198 | |8;json-parse-financial;59;58;56;56;59;59;59;57;58;58 16:00:11 INFO - PID 4198 | |9;json-stringify-tinderbox;54;54;55;55;55;53;54;54;56;56 16:00:11 INFO - PID 4198 | |10;stanford-crypto-aes;78;78;78;79;76;77;79;76;77;77 16:00:11 INFO - PID 4198 | |11;stanford-crypto-ccm;128;129;124;129;126;133;128;131;126;152 16:00:11 INFO - PID 4198 | |12;stanford-crypto-pbkdf2;186;180;180;183;193;188;181;180;194;185 16:00:11 INFO - PID 4198 | |13;stanford-crypto-sha256-iterative;68;68;69;72;67;70;68;75;68;68 16:00:11 INFO - PID 4198 | __end_tp_report 16:00:11 INFO - PID 4198 | __start_cc_report 16:00:11 INFO - PID 4198 | _x_x_mozilla_cycle_collect,951 16:00:11 INFO - PID 4198 | __end_cc_report 16:00:11 INFO - PID 4198 | __startTimestamp1499727611285__endTimestamp 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | ------- Summary: start ------- 16:00:11 INFO - PID 4198 | Number of tests: 14 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:3.63 (3.3%) stddev-sans-first:2.19 16:00:11 INFO - PID 4198 | Values: 101.0 111.0 110.0 109.0 109.0 110.0 116.0 109.0 110.0 110.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.50 stddev:23.58 (15.8%) stddev-sans-first:24.99 16:00:11 INFO - PID 4198 | Values: 147.0 122.0 144.0 184.0 122.0 156.0 152.0 123.0 178.0 119.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.50 stddev:4.75 (2.9%) stddev-sans-first:4.90 16:00:11 INFO - PID 4198 | Values: 163.0 163.0 164.0 161.0 162.0 169.0 163.0 174.0 173.0 169.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#3] audio-fft Cycles:10 Average:84.40 Median:75.00 stddev:22.87 (30.5%) stddev-sans-first:23.94 16:00:11 INFO - PID 4198 | Values: 74.0 75.0 75.0 147.0 77.0 75.0 76.0 75.0 95.0 75.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:82.00 stddev:29.80 (36.3%) stddev-sans-first:30.82 16:00:11 INFO - PID 4198 | Values: 82.0 82.0 144.0 83.0 83.0 82.0 140.0 83.0 82.0 148.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 16:00:11 INFO - PID 4198 | Values: 115.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 16:00:11 INFO - PID 4198 | Values: 149.0 150.0 150.0 150.0 151.0 150.0 149.0 149.0 151.0 150.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:00:11 INFO - PID 4198 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.50 stddev:1.20 (2.0%) stddev-sans-first:1.20 16:00:11 INFO - PID 4198 | Values: 59.0 58.0 56.0 56.0 59.0 59.0 59.0 57.0 58.0 58.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 16:00:11 INFO - PID 4198 | Values: 54.0 54.0 55.0 55.0 55.0 53.0 54.0 54.0 56.0 56.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:1.08 (1.4%) stddev-sans-first:1.13 16:00:11 INFO - PID 4198 | Values: 78.0 78.0 78.0 79.0 76.0 77.0 79.0 76.0 77.0 77.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:129.00 stddev:7.95 (6.2%) stddev-sans-first:8.37 16:00:11 INFO - PID 4198 | Values: 128.0 129.0 124.0 129.0 126.0 133.0 128.0 131.0 126.0 152.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:185.50 stddev:5.27 (2.8%) stddev-sans-first:5.58 16:00:11 INFO - PID 4198 | Values: 186.0 180.0 180.0 183.0 193.0 188.0 181.0 180.0 194.0 185.0 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:2.45 (3.6%) stddev-sans-first:2.55 16:00:11 INFO - PID 4198 | Values: 68.0 68.0 69.0 72.0 67.0 70.0 68.0 75.0 68.0 68.0 16:00:11 INFO - PID 4198 | -------- Summary: end -------- 16:00:11 INFO - PID 4198 | 16:00:11 INFO - PID 4198 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:00:11 INFO - TEST-INFO | 4198: exit 0 16:00:12 INFO - TEST-OK | kraken | took 61871ms 16:00:12 INFO - SUITE-END | took 1177s 16:00:12 INFO - Completed test suite (00:19:37) 16:00:12 INFO - javascript benchmark 16:00:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8270.76028654316, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.6035515382996, 3122.1258047746624, 3138.827364494953, 3153.731932785714, 3168.017914446522, 5781.913271300934, 5850.79522216723, 5851.707414629267, 5875.618084824494, 5923.229980102581, 5878.52971762259, 5938.495227905622, 5944.4352786485215, 5965.313988891279, 5970.552208584363, 5417.702026388547, 5448.754806033738, 5450.727463626823, 5463.836084917459, 5478.616496845222, 5464.890702185954, 5468.234447177379, 5476.069068258405, 5477.5070243678065, 5503.284573005523, 5455.918161227585, 5466.9179962300595, 5468.890622187574, 5480.479354461339, 5498.615096943216, 5459.69971651559, 5495.2856128703015, 5495.752691128909, 5506.807261745819, 5507.118860982264, 5307.628466007381, 5371.597130215249, 5447.373552041527, 5492.5605951524185, 5504.0, 5963.224780778514, 6000.969995149996, 6043.063325184604, 6087.0869369594475, 6144.986077297241, 6409.198850143732, 6435.6782160892235, 6461.57999730016, 6528.836779080513, 6533.346665333429, 6203.2556093269095, 6276.96861515694, 6293.181886354791, 6313.210848643919, 6320.683965801738, 5856.267966504187, 5866.941330586682, 5873.735681894325, 5886.0, 5891.351951285355, 4928.658887028632, 6426.260979987268, 6451.000094985285, 6458.935410645928, 6638.236602790645, 6365.904511432333, 6376.266729326094, 6448.580842245239, 6465.094886715863, 6472.611643301417, 6429.6463694496315, 6474.546781725234, 6474.6762661866715, 6556.246031706415, 6571.112899758567, 6207.503399728102, 6297.086922396227, 6304.873902521924, 6419.197600299963, 6514.804555863332, 5180.663256888365, 6324.936750632527, 6334.524910631629, 6341.270753863272, 6358.586691865014, 5093.134167191586, 5270.077736396115, 5348.9465105348445, 5353.902449997741, 5361.785528578813, 4438.868088637377, 4460.821567137278, 4473.776311184428, 4489.438820147481, 4489.820407183676, 5505.284313039279, 5516.14499752539, 5529.529989950899, 5557.360903496069, 5565.1374037024325, 6386.712597933104, 6391.041343798374, 6393.776217832354, 6400.935990640127, 6404.23149222087, 5476.069068258405, 5506.944930550643, 5546.057170281062, 5570.387257401682, 5610.07433773431, 5525.198846167284, 5756.856078598069, 5820.156077368758, 5847.1229315603, 5859.912101318484, 6113.23584551931, 6137.478314343331, 6140.3552626974415, 6164.8767024659255, 6171.876562468726, 6295.213098362705, 6340.778072767615, 6357.268914074941, 6374.617522948638, 6382.32985536512, 6091.725872335667, 6109.175261339662, 6129.601575897553, 6130.693465326626, 6144.662043587646, 6294.464970477561, 6294.716737746904, 6355.300916899045, 6378.138951241523, 6400.327965563735, 6400.359964003563, 6424.807255782334, 6522.021696745526, 6530.575512591667, 6532.738690452519, 6024.096385542204, 6142.078688196806, 6149.477294429845, 6214.782482613087, 6301.117843501822, 6162.352952940056, 6164.321924588381, 6176.135341052346, 6181.629102253879, 6182.598131121643, 6043.09353596964, 6067.848303792441, 6085.361037091218, 6088.4215999479975, 6094.878102437838, 5036.546710796046, 6127.938720612737, 6326.873462530815, 6427.292997770335, 6450.0, 6102.542309326907, 6131.049687298476, 6152.630842149485, 6183.134361189527, 6196.535259855619], "value": 5819.053045514878, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.8545861744888, 817.5666896544833, 864.6714248585539, 889.1330952321488, 893.5576889439728, 40363.79818100909, 41263.0, 41304.17391652165, 41308.0, 41311.79344103275, 39766.20467590646, 40423.19153616926, 43059.78470107653, 43060.0, 43100.784496077475, 7646.273604007611, 7774.727884524043, 7788.805279867992, 7790.9610451947665, 7796.298333150015, 7638.388928885676, 7753.806154846117, 7764.883526747103, 7774.339181169579, 7775.572343521104, 7611.733589324374, 7682.462227644067, 7745.380369570449, 7764.2235776422185, 7774.41691873109, 7688.384929205678, 7705.036870391201, 7734.381249500027, 7745.806354841146, 7769.184235655288, 7454.0, 7510.6620202091035, 7544.962275188644, 7553.509021913558, 7558.055243094614, 37731.05672358185, 37869.0, 37916.43125353122, 38167.236655267014, 38267.0, 3683.318586061587, 3692.150805314766, 3696.31618150643, 3700.5374328208973, 3718.9256214875822, 30903.381932361226, 30939.690603093906, 30985.0, 31048.53427198594, 31078.378432431226, 4645.488996210414, 4715.104130215248, 4860.562549370574, 4929.507049295078, 4995.675281106753, 190421.0, 191293.0, 191619.0, 191783.0, 192153.0, 48618.75690621524, 48648.51351486511, 48920.26619600709, 49136.0, 49204.507954919995, 51737.0, 51801.0, 51846.0, 52042.47957520452, 52064.21903671448, 16215.0, 16323.836761632469, 16536.503904882873, 16557.503274901774, 16627.168641567874, 13651.249181294925, 13725.519606813714, 13817.240051797047, 13830.37763300654, 13832.654183645489, 13184.538541151205, 13493.257870817199, 13501.797473037912, 13560.525381611596, 13689.589312320646, 5293.311869456946, 5345.679259244458, 5368.624196306221, 5449.482299181572, 5450.591205659592, 975.512243878061, 981.6417007792104, 982.5234761140983, 997.187292356727, 1029.9691009269734, 23635.40911477227, 28385.43229135447, 28560.42879142447, 28814.855925720236, 29493.705062949095, 1128.311729844794, 1132.0754716981066, 1134.8354488599107, 1135.9488823002985, 1139.128566646516, 12472.645515863103, 12733.55432559856, 12951.676208094685, 12957.805632915513, 16031.839681603267, 216179.0, 216397.0, 217736.0, 233148.0, 235768.0, 57914.0, 58861.0, 59059.70470147708, 59352.70323648354, 59381.40618593845, 1529.6175956010998, 1545.5363390982661, 1550.9999999999775, 1553.7280975829185, 1555.9377624894878, 27123.0, 27885.860570697827, 27960.30099247535, 28236.294092647848, 28577.714222858336, 39766.60233397629, 39860.80069599633, 40030.59969400269, 40205.39691904682, 40224.1955160901, 208785.0, 210221.0, 211271.0, 211821.0, 212390.0, 35233.29533409369, 35688.464673030445, 35842.924712258675, 36040.63959360373, 36485.27029459449, 40957.38563921484, 44607.0, 44704.55295447004, 45102.09795804, 45858.31212531748, 31118.688813112483, 31618.367632646758, 31763.20591985219, 31770.68229317677, 32302.192445188117, 30413.543796843507, 31736.206594835316, 31906.20234494156, 31985.8400707995, 32069.35861282808, 34907.0, 35016.0, 38511.22977540489, 39520.802395987834, 39534.0, 31475.527867081553, 32345.42994218231, 33436.33127337488, 33462.0, 33843.323133537684, 24133.637995430432, 24301.27096187117, 24642.0, 24768.628470573316, 24964.75035249697], "value": 17573.191435911674, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.0999685492204, 575.4360726488039, 576.7347020370632, 584.3601256623997, 593.8159170657096, 16069.0, 21801.345959621198, 22793.202237921676, 22830.657540136912, 22854.31437056889, 18377.44867653969, 18491.0, 18823.71764423535, 18852.34016809412, 20790.68813967788, 3911.8239679214503, 4046.028953051276, 6388.041793730954, 6403.871922561546, 6432.742690292383, 6492.610443373389, 6608.339166083378, 6611.305812889649, 6633.402993730563, 6646.534742568022, 6438.420542151205, 6559.8032059038305, 6565.507586930976, 6578.835529111787, 6579.572327798702, 6512.641804700739, 6561.40947314744, 6566.244881838602, 6567.573107748005, 6577.0, 5996.220491336142, 6734.663266836638, 6748.190217173921, 6764.763233286812, 6769.8646027079185, 30083.548746768814, 30531.542026869614, 30818.84590577055, 30839.38321233585, 30882.382352353052, 1990.233760002395, 2014.1339224133617, 2035.155410504639, 2035.297822251321, 2039.836813054952, 18758.812411875842, 19440.125194366286, 19596.510087247934, 20040.1983920643, 20159.193632254694, 2264.320703788857, 2359.858408495496, 2360.173939121311, 2360.45709486819, 2369.3010561884284, 125082.0, 129472.35263823715, 129846.0, 130297.0, 136141.0, 19823.414126869815, 20427.387178384673, 21630.783692162877, 21940.45148871259, 22405.43986400353, 42576.361354579705, 42720.57279427166, 42781.78609106997, 42961.0, 43015.35476967848, 11445.427728613537, 11641.708957276136, 11670.241434306743, 11840.0, 11919.404029798476, 9711.757206069904, 9714.3199976001, 9774.51127443625, 9806.803863922823, 9814.509274536387, 11279.379634120201, 11428.771424571461, 11557.537698492135, 11599.246049006957, 11785.116116291312, 4198.139381426861, 4262.42457268271, 4318.827246910151, 4340.848070317524, 4355.695101342875, 970.8883478399933, 978.1636700621009, 984.9892358960708, 1002.6891663584166, 1015.0864222200079, 18440.815591844177, 18780.154893029845, 18845.717314240297, 18864.622707545772, 18966.52583685419, 1039.1271332081087, 1061.9469026548795, 1063.160103518212, 1084.1056128693858, 1084.8426978088132, 9949.502524873727, 10032.799344013225, 10149.898501014895, 10190.337628054302, 10243.84634230487, 454146.0, 454618.0, 465444.0, 466655.0, 467990.0, 112834.0, 116221.418892905, 116942.0, 117835.0, 118405.0, 1101.0, 1198.4906414773686, 1229.164168365502, 1254.7678679444332, 1280.6414204022888, 18600.34898778536, 18645.533861653566, 18688.81311186871, 18789.530261743566, 18819.0, 48937.75531122321, 50849.23726144185, 51873.740631296605, 53658.195127072344, 53815.73092134671, 65388.34611654013, 65660.34339656543, 66024.0, 66215.33784662091, 66981.33018669946, 18138.365157219436, 18800.7179892299, 19334.12996415193, 19473.221071156993, 19556.119974600893, 21190.576188476454, 21408.892955535124, 22384.888075559516, 22476.213332533283, 22497.550048999256, 17395.0, 17459.650806983536, 17737.113144342475, 17755.0, 18067.728984065514, 14925.552233433014, 15502.302396391964, 15789.605259868595, 16122.67754644924, 16498.0, 17274.913625431793, 17561.736573951144, 17583.648327033643, 17869.73195402044, 19429.902850485658, 14359.856401435853, 14385.208813515357, 14414.711705765616, 14447.638809029439, 14548.854511455173, 16984.745228821826, 18012.90993545024, 18024.729629055313, 18052.097395130455, 18224.45326640203], "value": 12363.940090345272, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.9034067615269, 1452.3754785442263, 1457.1402872305339, 1461.6711239971007, 1475.122302230173, 12774.744505109904, 13427.664308392295, 13454.394552245149, 13470.0, 13478.0, 11702.239354441956, 12043.578474753385, 12507.124501284914, 12515.123941324111, 12565.183263087893, 2599.4801039792023, 2637.4593208392234, 2648.9470210595778, 2667.213172114231, 2669.7997650176217, 2522.8612426316545, 2584.056819260975, 2590.456004239112, 2596.5715656916586, 2598.5192739343283, 2530.8354956927833, 2557.5268575313535, 2587.8964841406323, 2592.520383729007, 2596.31197732601, 2442.9755702442926, 2489.3776555861036, 2493.1772515069983, 2495.5258500884865, 2500.0749722602663, 2419.6491508731137, 2429.27121863442, 2558.744125587445, 2582.483503299348, 2601.9609705854427, 12389.504419823195, 12646.936765316206, 12675.17611355259, 12681.619551413472, 12716.618501444971, 7195.460340474486, 7472.140703819076, 7479.962600187018, 7481.289277518627, 7490.288422599844, 4773.976130119362, 4924.236743304794, 5009.674371165863, 5056.595472362203, 5059.671121377099, 1782.8217178282198, 1845.8523318134517, 1880.2479008396751, 1900.6008738164865, 1912.3020097664253, 19893.900530497398, 20695.379138625714, 21019.684704729287, 21201.46996325089, 21517.462063448384, 6311.873762524724, 6414.294427612959, 6618.0, 6663.567797753882, 6666.100076489709, 17054.14729263532, 17054.829451705325, 17098.0, 17122.82877171237, 17222.483325500256, 7425.0, 7563.243675632392, 7568.0, 7595.0, 7622.123455802654, 6713.832154196184, 6745.696443660047, 6857.794266172023, 6892.689828957709, 6958.165020197609, 5121.385433747974, 5291.285676433709, 5308.150695888639, 5366.2755528004, 5444.074507333763, 1573.8190108137483, 1640.1225344440668, 1653.5866033491627, 1662.0858527809655, 1666.1752432545968, 903.5301643145527, 916.9679061232824, 928.2017464980112, 933.0669330669331, 941.2799208605422, 6936.93063069373, 6976.127984002, 7005.894911576331, 7008.299170082951, 7093.361597456254, 705.5519744961883, 722.342668171961, 722.8048426924701, 725.1733024352243, 731.4587205468022, 4328.696991210585, 5006.173981293119, 5029.698218106925, 5055.595552355802, 5120.590352771769, 15064.623384415258, 15619.687606247811, 15732.68534629301, 15766.211689415484, 16501.257443415074, 17371.131443427777, 17422.390216342366, 17744.645107097786, 17790.110494475484, 17955.910220448815, 8349.081601023883, 10506.581611482505, 10540.156787456985, 10564.471776411148, 10572.101371383365, 6945.826354341182, 7981.40139489529, 8002.359811214972, 8026.719064832703, 8072.9192708074515, 13888.583342499742, 14214.360353783897, 15199.924000379928, 16073.35706571724, 16163.67672646564, 15042.699146017238, 15304.387824486896, 15985.920070399574, 16218.432354867524, 16425.753613696044, 10273.434961077213, 10504.42225677595, 10517.894821051997, 10534.209934254808, 10548.0, 12362.75274494523, 12744.936275318563, 12760.553380631633, 12768.808467873176, 12837.550685725955, 9919.107280344804, 10160.390376577428, 10300.278980471296, 10310.690679279634, 10352.068313851789, 9353.11145441182, 9367.721044345402, 9474.0, 9523.857142143012, 9708.320417570985, 9026.18764311215, 9170.908290917005, 9175.26597872182, 9177.77055573616, 9178.67874624385, 6794.150731158606, 7007.299270072952, 7056.294370563108, 7095.219525852049, 7180.856382872418, 7015.543989640657, 7049.682764275723, 7102.431805455654, 7174.677139528838, 7240.746573869889], "value": 6080.800972848814, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.4378978222449, 499.8419472103682, 516.7158063065315, 519.200431335743, 521.6244304101045, 5996.730147143378, 6055.788047418341, 6073.0, 6122.969385153079, 6140.508759299257, 5725.599208055427, 5937.901488224681, 5981.0, 6060.2424696912885, 6095.207623009002, 4868.537488938545, 4894.730789806559, 4932.53140951609, 4936.284238785374, 4959.479254678261, 4870.561649451549, 4891.16850135476, 4900.558949694527, 4901.485344038878, 4925.635694866466, 4845.903081938359, 4857.635677324197, 4869.805207791684, 4872.78072486739, 4875.341828853113, 4639.976800115995, 4778.689385189951, 4821.674039639092, 4856.15017371962, 4876.536729010738, 4353.825846966118, 4354.825806967718, 4355.5208927018, 4365.541618130114, 4374.737515749065, 5823.417658234185, 5846.883062338729, 5896.351401345849, 5925.4370834770625, 5939.227900372967, 5551.944480555224, 5554.111342185231, 5564.1931919871795, 5595.944040559623, 5621.718914054321, 6367.363263673642, 6434.388733070351, 6438.742450301982, 6448.871022579569, 6487.0, 4797.088553174885, 4809.446913604946, 4816.397950256218, 4826.806927722887, 4835.588974937099, 6632.568883022588, 6645.435138013275, 6741.224759152711, 6761.898571521431, 6791.151106111736, 4918.803247870045, 4947.095368283237, 4959.305697202394, 4968.6025117990475, 4969.229769385751, 4875.878103047452, 4952.232403977389, 4972.801087956514, 4988.650794444354, 5016.949830501721, 5424.674519528762, 5432.239486471897, 5448.509634132947, 5525.696086715269, 5554.972225138848, 6393.584417012972, 6432.903506447407, 6443.96778016107, 6457.903131453032, 6483.4164925156965, 1712.24661149094, 1716.9399071032453, 1736.192670408241, 1736.6787144378332, 1739.4172952061201, 1106.446776611694, 1199.736058067224, 1209.7036226124656, 1218.2386008744534, 1220.8412906322299, 5489.615726899079, 5571.749271282802, 5640.746166422438, 5666.631668941588, 5676.943230567724, 6604.603723776589, 6611.0, 6637.269900310962, 6642.900356494656, 6658.334166583303, 5583.888322233533, 5607.243022191952, 5625.268715067097, 5649.774009039593, 5675.3757086720425, 3482.338355712457, 3495.4407294833213, 3501.509788629594, 3508.456189290664, 3511.455724362728, 6260.40526150015, 6269.902767015754, 6276.278228003746, 6416.550841441054, 6417.711202995876, 6630.701618427182, 6632.6352050636715, 6643.734250629921, 6662.300458451793, 6710.496712746563, 6282.340354262828, 6382.968085159545, 6411.935880641227, 6424.710888009958, 6446.258680251831, 6622.271550129385, 6626.370494802986, 6640.800775976729, 6665.400113989765, 6681.062491877301, 6474.449671777952, 6494.415502604599, 6514.413702766774, 6526.412622863965, 6527.934720652733, 6225.906611400742, 6317.905231421624, 6361.332060133619, 6368.216899268213, 6408.679566021587, 4761.357216775691, 4851.854444366674, 4853.805847766191, 4894.877628059327, 4901.5588597026435, 6568.113304703804, 6586.407223349922, 6593.868122637425, 6630.171228596426, 6662.6335551545135, 6332.8284267408835, 6397.744090236339, 6445.2265728112925, 6453.45145662624, 6465.353464653497, 6443.67781610927, 6467.320931302145, 6467.805965821033, 6473.611583305017, 6475.643839588868, 6234.220722409699, 6286.5599408041, 6321.52588555851, 6375.449820072008, 6400.51996100285, 5908.586398952204, 6349.6507692077375, 6398.456131228898, 6407.839804004937, 6459.547831651739, 5986.4978987292925, 6072.574919755575, 6088.330283668704, 6098.115318717459, 6231.077448815385], "value": 4943.406188145211, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [926.1248120526103, 929.1173385283981, 948.0850978805456, 949.7483166960752, 957.1242313283346, 18313.359032433884, 18678.0, 18867.62264754704, 18907.716384254247, 18987.0, 19260.711089333672, 20062.097205625745, 20648.0, 20890.89554552225, 20952.26667066653, 1031.6750223679535, 1051.3008849115367, 1051.374432212836, 1052.431686889079, 1053.3258714422775, 1056.8520407143005, 1064.435849000031, 1068.60995736556, 1070.411273799411, 1070.464767616192, 1066.3921564708119, 1095.1457862866937, 1103.189155970361, 1108.2685427617773, 1109.1459576126379, 1107.0479387726589, 1110.6612483192623, 1114.5318966034204, 1115.074488174821, 1119.0040863631375, 799.7880561651167, 803.3452736020125, 803.9919600803976, 803.995980020102, 804.0512195609178, 18759.812401875944, 18923.0, 19001.42995710131, 19153.425397238105, 20088.995550222575, 19527.218911243534, 19598.412047638452, 19892.303769368147, 20118.0, 20244.493887652778, 15511.844881551266, 15612.29744661493, 15822.841771582367, 15850.44523441674, 15859.207039648087, 3540.4689296605457, 3547.1486843157713, 3552.236269202108, 3563.322968635951, 3570.2145527983803, 102700.99999999926, 105750.0, 107744.0, 110484.0, 111300.4434977828, 16039.117848518443, 16549.338026479047, 16556.917215414087, 16616.750748738777, 16651.833481665028, 28281.292967675563, 29150.416991660048, 29269.56095658567, 29328.26679333034, 29522.261943451154, 8612.698555550525, 8669.393142479967, 8699.304055675531, 8731.956340218385, 8806.823863522694, 4162.937555936664, 4234.06850492891, 4242.215190189825, 4278.272693642089, 4304.289792184317, 5041.521055499722, 5149.45930677281, 5152.793888244429, 5156.587473002151, 5158.92261616076, 909.3997961345481, 944.8724422203052, 950.8336041192764, 1066.6213494209599, 1072.1851392941421, 629.2951893878793, 676.4655921821706, 690.7616872179091, 709.3686618909175, 722.4725950056488, 10846.62036828723, 11064.17018723599, 11690.47392867323, 11866.288022718665, 12028.578999734968, 639.5810743962712, 650.187265917603, 661.6790856434625, 663.7510933399975, 666.1273731411866, 5091.465396133427, 5268.710220937885, 5301.3373328333955, 5371.892562148735, 5409.594280428983, 93343.53328233451, 96267.0, 98355.0, 101100.0, 101483.0, 85064.0, 85203.0, 87246.69129963056, 88157.55921220481, 89118.0, 71739.0, 75139.62430187814, 75722.0, 76358.6182069086, 77513.61243193748, 10338.0, 10526.578936842747, 10778.461076945965, 10853.294535855144, 10872.891271087188, 32579.674203257666, 32860.1784955378, 33150.5027424584, 34138.31723365469, 34873.12817179591, 41216.38175427431, 42317.78841105775, 43287.350689740306, 43869.78065109654, 44343.0, 15666.686666266383, 15783.053016819027, 16003.679926401639, 16238.837611624205, 16322.591935201715, 14578.85421145775, 15012.099274043592, 15154.242287885781, 15230.390784368501, 15416.614584635025, 14618.634534136307, 15073.17097559601, 15117.244137793286, 15138.621534461727, 15241.31414086391, 15346.616334591277, 15588.68822623564, 15743.921280393524, 15799.447019354728, 16020.919895400448, 14763.852361476247, 14800.555983320517, 14848.554543363716, 14873.628159296104, 15156.393744250548, 10225.590976360862, 10841.0, 10844.67465976022, 11097.278676885977, 11259.268147570381, 9922.454265015205, 9943.453110079015, 10035.397876127456, 10231.181505479395, 10389.168866490814], "value": 8421.615666889718, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 109.0, 109.0, 110.0, 116.0, 109.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 144.0, 184.0, 122.0, 156.0, 152.0, 123.0, 178.0, 119.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 161.0, 162.0, 169.0, 163.0, 174.0, 173.0, 169.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 147.0, 77.0, 75.0, 76.0, 75.0, 95.0, 75.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 144.0, 83.0, 83.0, 82.0, 140.0, 83.0, 82.0, 148.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 151.0, 150.0, 149.0, 149.0, 151.0, 150.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 56.0, 56.0, 59.0, 59.0, 59.0, 57.0, 58.0, 58.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 53.0, 54.0, 54.0, 56.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 76.0, 77.0, 79.0, 76.0, 77.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 124.0, 129.0, 126.0, 133.0, 128.0, 131.0, 126.0, 152.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 180.0, 180.0, 183.0, 193.0, 188.0, 181.0, 180.0, 194.0, 185.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 72.0, 67.0, 70.0, 68.0, 75.0, 68.0, 68.0], "value": 69.3, "unit": "score"}]}]} 16:00:12 INFO - Return code: 0 16:00:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:00:12 INFO - # TBPL SUCCESS # 16:00:12 INFO - Running post-action listener: _package_coverage_data 16:00:12 INFO - Running post-action listener: _resource_record_post_action 16:00:12 INFO - [mozharness: 2017-07-10 23:00:12.585003Z] Finished run-tests step (success) 16:00:12 INFO - Running post-run listener: _resource_record_post_run 16:00:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5869568; Write bytes: 434225152; Read time: 2372; Write time: 395984 16:00:12 INFO - TinderboxPrint: CPU usage
13.1% 16:00:12 INFO - TinderboxPrint: I/O read bytes / time
5,869,568 / 2,372 16:00:12 INFO - TinderboxPrint: I/O write bytes / time
434,225,152 / 395,984 16:00:12 INFO - TinderboxPrint: CPU idle
8,283.2 (86.8%) 16:00:12 INFO - TinderboxPrint: CPU user
1,201.4 (12.6%) 16:00:12 INFO - TinderboxPrint: Swap in / out
0 / 0 16:00:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 171020288; Read time: 12; Write time: 144300 16:00:12 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:00:12 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3506176; Write bytes: 248000512; Read time: 1764; Write time: 231776 16:00:13 INFO - Running post-run listener: _upload_blobber_files 16:00:13 INFO - Blob upload gear active. 16:00:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:00:13 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 16:00:13 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'] 16:00:13 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 16:00:13 INFO - (blobuploader) - INFO - Open directory for files ... 16:00:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:00:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:00:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:14 INFO - (blobuploader) - INFO - Done attempting. 16:00:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:00:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:00:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:15 INFO - (blobuploader) - INFO - Done attempting. 16:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:18 INFO - (blobuploader) - INFO - Done attempting. 16:00:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:00:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:00:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:00:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:00:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:00:18 INFO - (blobuploader) - INFO - Done attempting. 16:00:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:00:18 INFO - Return code: 0 16:00:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:00:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:00:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac09df086328bff5dd81459b887c51bba17a7aac6b8312b535482960f0ebc4c50c6135553e7a7ebb3f81b0595113a9689d8fddbfafe6014119e5f0737d66cdbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59e4ea9ad914b31cbdf19d28d64090414334b6a34653ffa3c4ff89a8a4371359766f9ab7ecbdd10c89ce9e4e5d496c015a4814985a04eea23de31628c68a8a8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7767cd5cc4200c981b106d67824286da947171711cc294c9db83f2ce8990f175227c192d527062b15a2a6f5022264cf006043c6d5cd825cb624e786186faef5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a02bfcc095be11601f4b6f45ef4b89546387f1c0edc8c65bec55cf32d053449824f2a766fe12fc2b597ac883bf746214df23b9322e8cbed224d1f9128f4b40"} 16:00:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:00:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:00:18 INFO - Contents: 16:00:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac09df086328bff5dd81459b887c51bba17a7aac6b8312b535482960f0ebc4c50c6135553e7a7ebb3f81b0595113a9689d8fddbfafe6014119e5f0737d66cdbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59e4ea9ad914b31cbdf19d28d64090414334b6a34653ffa3c4ff89a8a4371359766f9ab7ecbdd10c89ce9e4e5d496c015a4814985a04eea23de31628c68a8a8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7767cd5cc4200c981b106d67824286da947171711cc294c9db83f2ce8990f175227c192d527062b15a2a6f5022264cf006043c6d5cd825cb624e786186faef5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a02bfcc095be11601f4b6f45ef4b89546387f1c0edc8c65bec55cf32d053449824f2a766fe12fc2b597ac883bf746214df23b9322e8cbed224d1f9128f4b40"} 16:00:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:00:18 INFO - Copying logs to upload dir... 16:00:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:00:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.443027 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-10 16:00:18.936187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 16:00:18.939301) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac09df086328bff5dd81459b887c51bba17a7aac6b8312b535482960f0ebc4c50c6135553e7a7ebb3f81b0595113a9689d8fddbfafe6014119e5f0737d66cdbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59e4ea9ad914b31cbdf19d28d64090414334b6a34653ffa3c4ff89a8a4371359766f9ab7ecbdd10c89ce9e4e5d496c015a4814985a04eea23de31628c68a8a8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7767cd5cc4200c981b106d67824286da947171711cc294c9db83f2ce8990f175227c192d527062b15a2a6f5022264cf006043c6d5cd825cb624e786186faef5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a02bfcc095be11601f4b6f45ef4b89546387f1c0edc8c65bec55cf32d053449824f2a766fe12fc2b597ac883bf746214df23b9322e8cbed224d1f9128f4b40"} build_url:https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/YF5n3AFNTOGq2PqVxNQIJg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac09df086328bff5dd81459b887c51bba17a7aac6b8312b535482960f0ebc4c50c6135553e7a7ebb3f81b0595113a9689d8fddbfafe6014119e5f0737d66cdbd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/59e4ea9ad914b31cbdf19d28d64090414334b6a34653ffa3c4ff89a8a4371359766f9ab7ecbdd10c89ce9e4e5d496c015a4814985a04eea23de31628c68a8a8d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7767cd5cc4200c981b106d67824286da947171711cc294c9db83f2ce8990f175227c192d527062b15a2a6f5022264cf006043c6d5cd825cb624e786186faef5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81a02bfcc095be11601f4b6f45ef4b89546387f1c0edc8c65bec55cf32d053449824f2a766fe12fc2b597ac883bf746214df23b9322e8cbed224d1f9128f4b40"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-10 16:00:18.969310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:00:18.969666) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1499726360.48369-833722679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-10 16:00:19.055372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 16:00:19.056017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-10 16:00:19.056667) ========= ========= Total master_lag: 0.22 =========