builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1500553642.6 results: success (0) revision: 68046a58f82913eb7804e4796ec981f6f8ea490e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.605810) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.606564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.607299) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.631268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.631683) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-20 05:27:22-- 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% 222M=0s 2017-07-20 05:27:23 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.287111 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.932654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.933079) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015777 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:22.985112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-20 05:27:22.985484) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 68046a58f82913eb7804e4796ec981f6f8ea490e --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 68046a58f82913eb7804e4796ec981f6f8ea490e --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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-20 05:27:23,171 truncating revision to first 12 chars 2017-07-20 05:27:23,171 Setting DEBUG logging. 2017-07-20 05:27:23,171 attempt 1/10 2017-07-20 05:27:23,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/68046a58f829?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-20 05:27:24,265 unpacking tar archive at: mozilla-central-68046a58f829/testing/mozharness/ program finished with exit code 0 elapsedTime=1.440527 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-20 05:27:24.442402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:24.442834) ========= script_repo_revision: 68046a58f82913eb7804e4796ec981f6f8ea490e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:24.443254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:24.443558) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 05:27:24.455136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-07-20 05:27:24.455532) ========= /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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:27:24 INFO - MultiFileLogger online at 20170720 05:27:24 in /builds/slave/test 05:27:24 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 05:27:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:24 INFO - {'append_to_log': False, 05:27:24 INFO - 'base_work_dir': '/builds/slave/test', 05:27:24 INFO - 'blob_upload_branch': 'Firefox', 05:27:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:24 INFO - 'branch': 'Firefox', 05:27:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:24 INFO - 'code_coverage': False, 05:27:24 INFO - 'config_files': ('talos/linux_config.py',), 05:27:24 INFO - 'default_actions': ('clobber', 05:27:24 INFO - 'read-buildbot-config', 05:27:24 INFO - 'download-and-extract', 05:27:24 INFO - 'populate-webroot', 05:27:24 INFO - 'create-virtualenv', 05:27:24 INFO - 'install', 05:27:24 INFO - 'setup-mitmproxy', 05:27:24 INFO - 'run-tests'), 05:27:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:24 INFO - 'disable_ccov_upload': False, 05:27:24 INFO - 'download_minidump_stackwalk': True, 05:27:24 INFO - 'download_symbols': 'ondemand', 05:27:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:24 INFO - 'gecko_profile': False, 05:27:24 INFO - 'gecko_profile_interval': 0, 05:27:24 INFO - 'installer_path': 'installer.exe', 05:27:24 INFO - 'log_level': 'info', 05:27:24 INFO - 'log_name': 'talos', 05:27:24 INFO - 'log_to_console': True, 05:27:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:27:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:27:24 INFO - 'opt_config_files': (), 05:27:24 INFO - 'pip_index': False, 05:27:24 INFO - 'suite': 'dromaeojs-e10s', 05:27:24 INFO - 'system_bits': '32', 05:27:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:24 INFO - 'title': 'talos-linux64-ix-029', 05:27:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:24 INFO - 'use_talos_json': True, 05:27:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:24 INFO - 'work_dir': 'build'} 05:27:24 INFO - [mozharness: 2017-07-20 12:27:24.747038Z] Running clobber step. 05:27:24 INFO - Running pre-action listener: _resource_record_pre_action 05:27:24 INFO - Running main action method: clobber 05:27:24 INFO - rmtree: /builds/slave/test/build 05:27:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:26 INFO - Running post-action listener: _resource_record_post_action 05:27:26 INFO - [mozharness: 2017-07-20 12:27:26.292481Z] Finished clobber step (success) 05:27:26 INFO - [mozharness: 2017-07-20 12:27:26.292582Z] Running read-buildbot-config step. 05:27:26 INFO - Running pre-action listener: _resource_record_pre_action 05:27:26 INFO - Running main action method: read_buildbot_config 05:27:26 INFO - Using buildbot properties: 05:27:26 INFO - { 05:27:26 INFO - "project": "", 05:27:26 INFO - "product": "firefox", 05:27:26 INFO - "who": "archaeopteryx@coole-files.de", 05:27:26 INFO - "installer_path": "public/build/target.tar.bz2", 05:27:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:27:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:27:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:27:26 INFO - "stage_platform": "linux64-pgo", 05:27:26 INFO - "basedir": "/builds/slave/test", 05:27:26 INFO - "buildnumber": 82, 05:27:26 INFO - "platform": "ubuntu64_hw", 05:27:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:27:26 INFO - "slavebuilddir": "test", 05:27:26 INFO - "taskId": "PZPBISMzSx6pZ2NT-2jIuw", 05:27:26 INFO - "branch": "mozilla-central", 05:27:26 INFO - "script_repo_revision": "production", 05:27:26 INFO - "revision": "68046a58f82913eb7804e4796ec981f6f8ea490e", 05:27:26 INFO - "slavename": "talos-linux64-ix-029", 05:27:26 INFO - "repo_path": "mozilla-central" 05:27:26 INFO - } 05:27:26 INFO - Finding installer, test and symbols from parent task. 05:27:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PZPBISMzSx6pZ2NT-2jIuw'}, attempt #1 05:27:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PZPBISMzSx6pZ2NT-2jIuw'}, attempt #1 05:27:27 INFO - Task dependencies: H7H_GZpQRVWqGOEfUjVfmw 05:27:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw'}, attempt #1 05:27:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 05:27:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/test_packages.json 05:27:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.crashreporter-symbols.zip 05:27:27 INFO - Running post-action listener: _resource_record_post_action 05:27:27 INFO - [mozharness: 2017-07-20 12:27:27.842839Z] Finished read-buildbot-config step (success) 05:27:27 INFO - [mozharness: 2017-07-20 12:27:27.843147Z] Running download-and-extract step. 05:27:27 INFO - Running pre-action listener: _resource_record_pre_action 05:27:27 INFO - Running main action method: download_and_extract 05:27:27 INFO - mkdir: /builds/slave/test/build/tests 05:27:28 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')]} 05:27:28 INFO - trying https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.test_packages.json 05:27:28 INFO - Downloading https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:27:28 INFO - Downloaded 989 bytes. 05:27:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:27:28 INFO - Using the following test package requirements: 05:27:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:27:28 INFO - u'common': [u'target.common.tests.zip'], 05:27:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:27:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:27:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:27:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:27:28 INFO - u'mozbase': [u'target.common.tests.zip'], 05:27:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:27:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:27:28 INFO - u'web-platform': [u'target.common.tests.zip', 05:27:28 INFO - u'target.web-platform.tests.tar.gz'], 05:27:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:27:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip 05:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip into memory 05:27:30 INFO - Content-Length response header: 73365338 05:27:30 INFO - Bytes received: 73365338 05:27:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:27:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip 05:27:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:27:41 INFO - Fetch https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.common.tests.zip into memory 05:27:43 INFO - Content-Length response header: 73365338 05:27:43 INFO - Bytes received: 73365338 05:27:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.talos.tests.zip 05:27:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:27:55 INFO - Fetch https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.talos.tests.zip into memory 05:28:04 INFO - Content-Length response header: 14498965 05:28:04 INFO - Bytes received: 14498965 05:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:05 INFO - trying https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 05:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:28:06 INFO - Downloaded 62806504 bytes. 05:28:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 05:28:06 INFO - mkdir: /builds/slave/test/properties 05:28:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:06 INFO - Contents: 05:28:06 INFO - build_url:https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 05:28:06 INFO - Running post-action listener: _resource_record_post_action 05:28:06 INFO - Running post-action listener: set_extra_try_arguments 05:28:06 INFO - [mozharness: 2017-07-20 12:28:06.854827Z] Finished download-and-extract step (success) 05:28:06 INFO - [mozharness: 2017-07-20 12:28:06.854925Z] Running populate-webroot step. 05:28:06 INFO - Running pre-action listener: _resource_record_pre_action 05:28:06 INFO - Running main action method: populate_webroot 05:28:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:06 INFO - '--tppagecycles', 05:28:06 INFO - '7'], 05:28:06 INFO - 'tests': ['tsvgm']}}, 05:28:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['damp', 'tps']}, 05:28:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'tests': ['damp', 'tps']}, 05:28:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['dromaeo_dom']}, 05:28:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:28:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:28:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:28:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_many_windows', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_many_windows', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_many_windows', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['a11yr', 05:28:06 INFO - 'ts_paint', 05:28:06 INFO - 'tpaint', 05:28:06 INFO - 'sessionrestore', 05:28:06 INFO - 'sessionrestore_no_auto_restore', 05:28:06 INFO - 'tabpaint']}, 05:28:06 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:28:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:28:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:28:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:28:06 INFO - 'talos_options': ['--mitmproxy', 05:28:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:28:06 INFO - '--firstNonBlankPaint'], 05:28:06 INFO - 'tests': ['quantum_pageload_google', 05:28:06 INFO - 'quantum_pageload_youtube', 05:28:06 INFO - 'quantum_pageload_amazon', 05:28:06 INFO - 'quantum_pageload_facebook']}, 05:28:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['tsvgx', 05:28:06 INFO - 'tsvgr_opacity', 05:28:06 INFO - 'tart', 05:28:06 INFO - 'tscrollx', 05:28:06 INFO - 'cart', 05:28:06 INFO - 'tsvg_static']}, 05:28:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:06 INFO - 'tsvgr_opacity', 05:28:06 INFO - 'tart', 05:28:06 INFO - 'tscrollx', 05:28:06 INFO - 'cart', 05:28:06 INFO - 'tsvg_static']}, 05:28:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'talos_options': ['--disable-e10s'], 05:28:06 INFO - 'tests': ['tp5o']}, 05:28:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:28:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'talos_options': ['--disable-e10s', 05:28:06 INFO - '--xperf_path', 05:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:06 INFO - 'tests': ['tp5n']}, 05:28:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:28:06 INFO - 'talos_options': ['--xperf_path', 05:28:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:06 INFO - 'tests': ['tp5n']}}, 05:28:06 INFO - 'talos.zip': {'path': '', 05:28:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:06 INFO - Running post-action listener: _resource_record_post_action 05:28:06 INFO - [mozharness: 2017-07-20 12:28:06.870423Z] Finished populate-webroot step (success) 05:28:06 INFO - [mozharness: 2017-07-20 12:28:06.870514Z] Running create-virtualenv step. 05:28:06 INFO - Running pre-action listener: _resource_record_pre_action 05:28:06 INFO - Running main action method: create_virtualenv 05:28:06 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:28:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:28:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:06 INFO - Using real prefix '/usr' 05:28:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:09 INFO - Installing pip.................done. 05:28:09 INFO - Return code: 0 05:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:28:09 INFO - Reading from file tmpfile_stdout 05:28:09 INFO - Output received: 05:28:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:28:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28: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')]} 05:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:10 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:10 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 05:28:10 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 05:28:10 INFO - Using env: {'DISPLAY': ':0', 05:28:10 INFO - 'HOME': '/home/cltbld', 05:28:10 INFO - 'LANG': 'en_US.UTF-8', 05:28:10 INFO - 'LANGUAGE': 'en_US:en', 05:28:10 INFO - 'LOGNAME': 'cltbld', 05:28:10 INFO - 'MAIL': '/var/mail/cltbld', 05:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:10 INFO - 'MOZ_NO_REMOTE': '1', 05:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:10 INFO - 'NO_EM_RESTART': '1', 05:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:10 INFO - 'PWD': '/builds/slave/test', 05:28:10 INFO - 'SHELL': '/bin/bash', 05:28:10 INFO - 'SHLVL': '1', 05:28:10 INFO - 'TERM': 'linux', 05:28:10 INFO - 'TMOUT': '86400', 05:28:10 INFO - 'USER': 'cltbld', 05:28:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:10 INFO - '_': '/tools/buildbot/bin/python'} 05:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:10 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 05:28:10 INFO - Cleaning up... 05:28:10 INFO - Return code: 0 05:28:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28:10 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')]} 05:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:10 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')]} 05:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:10 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:10 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 05:28:10 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 05:28:10 INFO - Using env: {'DISPLAY': ':0', 05:28:10 INFO - 'HOME': '/home/cltbld', 05:28:10 INFO - 'LANG': 'en_US.UTF-8', 05:28:10 INFO - 'LANGUAGE': 'en_US:en', 05:28:10 INFO - 'LOGNAME': 'cltbld', 05:28:10 INFO - 'MAIL': '/var/mail/cltbld', 05:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:10 INFO - 'MOZ_NO_REMOTE': '1', 05:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:10 INFO - 'NO_EM_RESTART': '1', 05:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:10 INFO - 'PWD': '/builds/slave/test', 05:28:10 INFO - 'SHELL': '/bin/bash', 05:28:10 INFO - 'SHLVL': '1', 05:28:10 INFO - 'TERM': 'linux', 05:28:10 INFO - 'TMOUT': '86400', 05:28:10 INFO - 'USER': 'cltbld', 05:28:10 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:10 INFO - '_': '/tools/buildbot/bin/python'} 05:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:10 INFO - Downloading/unpacking psutil>=3.1.1 05:28:10 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 05:28:10 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 05:28:10 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 05:28:10 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 05:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:12 INFO - Installing collected packages: psutil 05:28:12 INFO - Running setup.py install for psutil 05:28:12 INFO - building 'psutil._psutil_linux' extension 05:28:12 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 05:28:12 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 05:28:12 INFO - building 'psutil._psutil_posix' extension 05:28:12 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 05:28:13 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 05:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:13 INFO - Successfully installed psutil 05:28:13 INFO - Cleaning up... 05:28:13 INFO - Return code: 0 05:28:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:28:13 INFO - Using env: {'DISPLAY': ':0', 05:28:13 INFO - 'HOME': '/home/cltbld', 05:28:13 INFO - 'LANG': 'en_US.UTF-8', 05:28:13 INFO - 'LANGUAGE': 'en_US:en', 05:28:13 INFO - 'LOGNAME': 'cltbld', 05:28:13 INFO - 'MAIL': '/var/mail/cltbld', 05:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:13 INFO - 'MOZ_NO_REMOTE': '1', 05:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:13 INFO - 'NO_EM_RESTART': '1', 05:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:13 INFO - 'PWD': '/builds/slave/test', 05:28:13 INFO - 'SHELL': '/bin/bash', 05:28:13 INFO - 'SHLVL': '1', 05:28:13 INFO - 'TERM': 'linux', 05:28:13 INFO - 'TMOUT': '86400', 05:28:13 INFO - 'USER': 'cltbld', 05:28:13 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:13 INFO - '_': '/tools/buildbot/bin/python'} 05:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28: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 05:28: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 05:28: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 05:28: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 05:28:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:15 INFO - Installing collected packages: mozsystemmonitor 05:28:15 INFO - Running setup.py install for mozsystemmonitor 05:28:15 INFO - Successfully installed mozsystemmonitor 05:28:15 INFO - Cleaning up... 05:28:15 INFO - Return code: 0 05:28:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28: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')]} 05:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:16 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:16 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 05:28:16 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 05:28:16 INFO - Using env: {'DISPLAY': ':0', 05:28:16 INFO - 'HOME': '/home/cltbld', 05:28:16 INFO - 'LANG': 'en_US.UTF-8', 05:28:16 INFO - 'LANGUAGE': 'en_US:en', 05:28:16 INFO - 'LOGNAME': 'cltbld', 05:28:16 INFO - 'MAIL': '/var/mail/cltbld', 05:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:16 INFO - 'MOZ_NO_REMOTE': '1', 05:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:16 INFO - 'NO_EM_RESTART': '1', 05:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:16 INFO - 'PWD': '/builds/slave/test', 05:28:16 INFO - 'SHELL': '/bin/bash', 05:28:16 INFO - 'SHLVL': '1', 05:28:16 INFO - 'TERM': 'linux', 05:28:16 INFO - 'TMOUT': '86400', 05:28:16 INFO - 'USER': 'cltbld', 05:28:16 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:16 INFO - '_': '/tools/buildbot/bin/python'} 05:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:16 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:18 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 05:28:18 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 05:28:18 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 05:28:18 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 05:28:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:18 INFO - warning: no files found matching '*.txt' 05:28:18 INFO - no previously-included directories found matching 'build' 05:28:18 INFO - no previously-included directories found matching 'dist' 05:28:18 INFO - no previously-included directories found matching '.git*' 05:28:18 INFO - Installing collected packages: jsonschema, functools32 05:28:18 INFO - Running setup.py install for functools32 05:28:18 INFO - warning: no files found matching '*.txt' 05:28:18 INFO - no previously-included directories found matching 'build' 05:28:18 INFO - no previously-included directories found matching 'dist' 05:28:18 INFO - no previously-included directories found matching '.git*' 05:28:18 INFO - Successfully installed jsonschema functools32 05:28:18 INFO - Cleaning up... 05:28:18 INFO - Return code: 0 05:28:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:18 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')]} 05:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:18 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')]} 05:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:19 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:19 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 05:28:19 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 05:28:19 INFO - Using env: {'DISPLAY': ':0', 05:28:19 INFO - 'HOME': '/home/cltbld', 05:28:19 INFO - 'LANG': 'en_US.UTF-8', 05:28:19 INFO - 'LANGUAGE': 'en_US:en', 05:28:19 INFO - 'LOGNAME': 'cltbld', 05:28:19 INFO - 'MAIL': '/var/mail/cltbld', 05:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:19 INFO - 'MOZ_NO_REMOTE': '1', 05:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:19 INFO - 'NO_EM_RESTART': '1', 05:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:19 INFO - 'PWD': '/builds/slave/test', 05:28:19 INFO - 'SHELL': '/bin/bash', 05:28:19 INFO - 'SHLVL': '1', 05:28:19 INFO - 'TERM': 'linux', 05:28:19 INFO - 'TMOUT': '86400', 05:28:19 INFO - 'USER': 'cltbld', 05:28:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:19 INFO - '_': '/tools/buildbot/bin/python'} 05:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:19 INFO - Cleaning up... 05:28:19 INFO - Return code: 0 05:28:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:19 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')]} 05:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:19 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')]} 05:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:20 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:20 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 05:28:20 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 05:28:20 INFO - Using env: {'DISPLAY': ':0', 05:28:20 INFO - 'HOME': '/home/cltbld', 05:28:20 INFO - 'LANG': 'en_US.UTF-8', 05:28:20 INFO - 'LANGUAGE': 'en_US:en', 05:28:20 INFO - 'LOGNAME': 'cltbld', 05:28:20 INFO - 'MAIL': '/var/mail/cltbld', 05:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:20 INFO - 'MOZ_NO_REMOTE': '1', 05:28:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:20 INFO - 'NO_EM_RESTART': '1', 05:28:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:20 INFO - 'PWD': '/builds/slave/test', 05:28:20 INFO - 'SHELL': '/bin/bash', 05:28:20 INFO - 'SHLVL': '1', 05:28:20 INFO - 'TERM': 'linux', 05:28:20 INFO - 'TMOUT': '86400', 05:28:20 INFO - 'USER': 'cltbld', 05:28:20 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:20 INFO - '_': '/tools/buildbot/bin/python'} 05:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:21 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 05:28:21 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 05:28:21 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 05:28:21 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 05:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:22 INFO - Downloading docopt-0.6.1.tar.gz 05:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:22 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:22 INFO - Running setup.py install for blobuploader 05:28:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:22 INFO - Running setup.py install for requests 05:28:22 INFO - Running setup.py install for docopt 05:28:23 INFO - Successfully installed blobuploader requests docopt 05:28:23 INFO - Cleaning up... 05:28:23 INFO - Return code: 0 05:28:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:23 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:23 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 05:28:23 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 05:28:23 INFO - Using env: {'DISPLAY': ':0', 05:28:23 INFO - 'HOME': '/home/cltbld', 05:28:23 INFO - 'LANG': 'en_US.UTF-8', 05:28:23 INFO - 'LANGUAGE': 'en_US:en', 05:28:23 INFO - 'LOGNAME': 'cltbld', 05:28:23 INFO - 'MAIL': '/var/mail/cltbld', 05:28:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:23 INFO - 'MOZ_NO_REMOTE': '1', 05:28:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:23 INFO - 'NO_EM_RESTART': '1', 05:28:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:23 INFO - 'PWD': '/builds/slave/test', 05:28:23 INFO - 'SHELL': '/bin/bash', 05:28:23 INFO - 'SHLVL': '1', 05:28:23 INFO - 'TERM': 'linux', 05:28:23 INFO - 'TMOUT': '86400', 05:28:23 INFO - 'USER': 'cltbld', 05:28:23 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:23 INFO - '_': '/tools/buildbot/bin/python'} 05:28:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:23 INFO - Running setup.py (path:/tmp/pip-mFrsFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:23 INFO - Running setup.py (path:/tmp/pip-IYnS14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:23 INFO - Running setup.py (path:/tmp/pip-rI0_th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:23 INFO - Running setup.py (path:/tmp/pip-INs8cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:23 INFO - Running setup.py (path:/tmp/pip-NcfaaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:24 INFO - Running setup.py (path:/tmp/pip-fcDqd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:24 INFO - Running setup.py (path:/tmp/pip-jwMoOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:24 INFO - Running setup.py (path:/tmp/pip-vFxvg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:24 INFO - Running setup.py (path:/tmp/pip-yO1tEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:24 INFO - Running setup.py (path:/tmp/pip-rXHe9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:24 INFO - Running setup.py (path:/tmp/pip-xbYyi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:24 INFO - Running setup.py (path:/tmp/pip-kMdSPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:24 INFO - Running setup.py (path:/tmp/pip-5NhWPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:24 INFO - Running setup.py (path:/tmp/pip-fbBYQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:24 INFO - Running setup.py (path:/tmp/pip-zllVU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:24 INFO - Running setup.py (path:/tmp/pip-e7opyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:24 INFO - Running setup.py (path:/tmp/pip-2f03xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:24 INFO - Running setup.py install for manifestparser 05:28:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for mozcrash 05:28:25 INFO - Running setup.py install for mozdebug 05:28:25 INFO - Running setup.py install for mozdevice 05:28:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for mozfile 05:28:25 INFO - Running setup.py install for mozhttpd 05:28:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for mozinfo 05:28:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for mozInstall 05:28:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for mozleak 05:28:25 INFO - Running setup.py install for mozlog 05:28:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:25 INFO - Running setup.py install for moznetwork 05:28:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Running setup.py install for mozprocess 05:28:26 INFO - Running setup.py install for mozprofile 05:28:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Running setup.py install for mozrunner 05:28:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Running setup.py install for mozscreenshot 05:28:26 INFO - Running setup.py install for moztest 05:28:26 INFO - Running setup.py install for mozversion 05:28:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:26 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:27 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:27 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 05:28:27 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 05:28:27 INFO - Using env: {'DISPLAY': ':0', 05:28:27 INFO - 'HOME': '/home/cltbld', 05:28:27 INFO - 'LANG': 'en_US.UTF-8', 05:28:27 INFO - 'LANGUAGE': 'en_US:en', 05:28:27 INFO - 'LOGNAME': 'cltbld', 05:28:27 INFO - 'MAIL': '/var/mail/cltbld', 05:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:27 INFO - 'MOZ_NO_REMOTE': '1', 05:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:27 INFO - 'NO_EM_RESTART': '1', 05:28:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:27 INFO - 'PWD': '/builds/slave/test', 05:28:27 INFO - 'SHELL': '/bin/bash', 05:28:27 INFO - 'SHLVL': '1', 05:28:27 INFO - 'TERM': 'linux', 05:28:27 INFO - 'TMOUT': '86400', 05:28:27 INFO - 'USER': 'cltbld', 05:28:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:27 INFO - '_': '/tools/buildbot/bin/python'} 05:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:27 INFO - Running setup.py (path:/tmp/pip-POYXDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:27 INFO - Running setup.py (path:/tmp/pip-EzIyeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:27 INFO - Running setup.py (path:/tmp/pip-GijXHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:27 INFO - Running setup.py (path:/tmp/pip-ldiSEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:27 INFO - Running setup.py (path:/tmp/pip-riwesj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:27 INFO - Running setup.py (path:/tmp/pip-DKIwQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:27 INFO - Running setup.py (path:/tmp/pip-t9KAsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:27 INFO - Running setup.py (path:/tmp/pip-Mb_hzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:27 INFO - Running setup.py (path:/tmp/pip-QUpwGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:27 INFO - Running setup.py (path:/tmp/pip-aBSN4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:27 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)) 05:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:27 INFO - Running setup.py (path:/tmp/pip-itYFlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:28 INFO - Running setup.py (path:/tmp/pip-IvQzW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:28 INFO - Running setup.py (path:/tmp/pip-E7I1yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:28 INFO - Running setup.py (path:/tmp/pip-lS0ojH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:28 INFO - Running setup.py (path:/tmp/pip-DiiEyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:28 INFO - Running setup.py (path:/tmp/pip-wT8Rkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:28 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)) 05:28:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:28 INFO - Running setup.py (path:/tmp/pip-T4Km6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:28 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)) 05:28:28 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)) 05:28:28 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)) 05:28:28 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)) 05:28:28 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)) 05:28:28 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)) 05:28:28 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)) 05:28:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:29 INFO - Downloading blessings-1.6.tar.gz 05:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:29 INFO - Installing collected packages: blessings 05:28:29 INFO - Running setup.py install for blessings 05:28:30 INFO - Successfully installed blessings 05:28:30 INFO - Cleaning up... 05:28:30 INFO - Return code: 0 05:28:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:30 INFO - Reading from file tmpfile_stdout 05:28:30 INFO - Current package versions: 05:28:30 INFO - argparse == 1.2.1 05:28:30 INFO - blessings == 1.6 05:28:30 INFO - blobuploader == 1.2.4 05:28:30 INFO - docopt == 0.6.1 05:28:30 INFO - functools32 == 3.2.3-2 05:28:30 INFO - jsonschema == 2.5.1 05:28:30 INFO - manifestparser == 1.1 05:28:30 INFO - mozInstall == 1.13 05:28:30 INFO - mozcrash == 1.0 05:28:30 INFO - mozdebug == 0.1 05:28:30 INFO - mozdevice == 0.51 05:28:30 INFO - mozfile == 1.2 05:28:30 INFO - mozhttpd == 0.7 05:28:30 INFO - mozinfo == 0.10 05:28:30 INFO - mozleak == 0.1 05:28:30 INFO - mozlog == 3.5 05:28:30 INFO - moznetwork == 0.27 05:28:30 INFO - mozprocess == 0.25 05:28:30 INFO - mozprofile == 0.28 05:28:30 INFO - mozrunner == 6.13 05:28:30 INFO - mozscreenshot == 0.1 05:28:30 INFO - mozsystemmonitor == 0.3 05:28:30 INFO - moztest == 0.8 05:28:30 INFO - mozversion == 1.4 05:28:30 INFO - psutil == 3.1.1 05:28:30 INFO - requests == 1.2.3 05:28:30 INFO - wsgiref == 0.1.2 05:28:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:30 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 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:30 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 05:28:30 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 05:28:30 INFO - Using env: {'DISPLAY': ':0', 05:28:30 INFO - 'HOME': '/home/cltbld', 05:28:30 INFO - 'LANG': 'en_US.UTF-8', 05:28:30 INFO - 'LANGUAGE': 'en_US:en', 05:28:30 INFO - 'LOGNAME': 'cltbld', 05:28:30 INFO - 'MAIL': '/var/mail/cltbld', 05:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:30 INFO - 'MOZ_NO_REMOTE': '1', 05:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:30 INFO - 'NO_EM_RESTART': '1', 05:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:30 INFO - 'PWD': '/builds/slave/test', 05:28:30 INFO - 'SHELL': '/bin/bash', 05:28:30 INFO - 'SHLVL': '1', 05:28:30 INFO - 'TERM': 'linux', 05:28:30 INFO - 'TMOUT': '86400', 05:28:30 INFO - 'USER': 'cltbld', 05:28:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:30 INFO - '_': '/tools/buildbot/bin/python'} 05:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 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)) 05:28:30 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:28:30 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 05:28:30 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 05:28:30 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 05:28:30 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 05:28:32 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:28:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:28:32 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 05:28:32 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 05:28:32 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 05:28:32 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 05:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:28:33 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)) 05:28:33 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)) 05:28:33 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)) 05:28:33 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)) 05:28:33 INFO - Installing collected packages: marionette-driver, simplejson 05:28:33 INFO - Running setup.py install for marionette-driver 05:28:33 INFO - Running setup.py install for simplejson 05:28:33 INFO - building 'simplejson._speedups' extension 05:28:33 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 05:28:34 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 05:28:34 INFO - Successfully installed marionette-driver simplejson 05:28:34 INFO - Cleaning up... 05:28:34 INFO - Return code: 0 05:28:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28: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')]} 05:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa811f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf2b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', '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 05:28:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:28:34 INFO - Using env: {'DISPLAY': ':0', 05:28:34 INFO - 'HOME': '/home/cltbld', 05:28:34 INFO - 'LANG': 'en_US.UTF-8', 05:28:34 INFO - 'LANGUAGE': 'en_US:en', 05:28:34 INFO - 'LOGNAME': 'cltbld', 05:28:34 INFO - 'MAIL': '/var/mail/cltbld', 05:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:34 INFO - 'MOZ_NO_REMOTE': '1', 05:28:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:34 INFO - 'NO_EM_RESTART': '1', 05:28:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:34 INFO - 'PWD': '/builds/slave/test', 05:28:34 INFO - 'SHELL': '/bin/bash', 05:28:34 INFO - 'SHLVL': '1', 05:28:34 INFO - 'TERM': 'linux', 05:28:34 INFO - 'TMOUT': '86400', 05:28:34 INFO - 'USER': 'cltbld', 05:28:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:34 INFO - '_': '/tools/buildbot/bin/python'} 05:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:34 INFO - Cleaning up... 05:28:34 INFO - Return code: 0 05:28:34 INFO - Running post-action listener: _resource_record_post_action 05:28:34 INFO - Running post-action listener: _start_resource_monitoring 05:28:34 INFO - Starting resource monitoring. 05:28:34 INFO - [mozharness: 2017-07-20 12:28:34.866513Z] Finished create-virtualenv step (success) 05:28:34 INFO - [mozharness: 2017-07-20 12:28:34.867022Z] Running install step. 05:28:34 INFO - Running pre-action listener: _resource_record_pre_action 05:28:34 INFO - Running main action method: install 05:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:35 INFO - Reading from file tmpfile_stdout 05:28:35 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:35 INFO - Reading from file tmpfile_stdout 05:28:35 INFO - Output received: 05:28:35 INFO - Usage: mozinstall [options] installer 05:28:35 INFO - Options: 05:28:35 INFO - -h, --help show this help message and exit 05:28:35 INFO - -d DEST, --destination=DEST 05:28:35 INFO - Directory to install application into. [default: 05:28:35 INFO - "/builds/slave/test"] 05:28:35 INFO - --app=APP Application being installed. [default: firefox] 05:28:35 INFO - mkdir: /builds/slave/test/build/application 05:28:35 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'] 05:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:28:53 INFO - Reading from file tmpfile_stdout 05:28:53 INFO - Output received: 05:28:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:28:53 INFO - Running post-action listener: _resource_record_post_action 05:28:53 INFO - [mozharness: 2017-07-20 12:28:53.113590Z] Finished install step (success) 05:28:53 INFO - [mozharness: 2017-07-20 12:28:53.113843Z] Running setup-mitmproxy step. 05:28:53 INFO - Running pre-action listener: _resource_record_pre_action 05:28:53 INFO - Running main action method: setup_mitmproxy 05:28:53 INFO - Skipping: mitmproxy is not required 05:28:53 INFO - Running post-action listener: _resource_record_post_action 05:28:53 INFO - [mozharness: 2017-07-20 12:28:53.114969Z] Finished setup-mitmproxy step (success) 05:28:53 INFO - [mozharness: 2017-07-20 12:28:53.115206Z] Running run-tests step. 05:28:53 INFO - Running pre-action listener: _resource_record_pre_action 05:28:53 INFO - Running pre-action listener: _set_gcov_prefix 05:28:53 INFO - Running main action method: run_tests 05:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:53 INFO - Python 2.7.3 05:28:53 INFO - Return code: 0 05:28:53 INFO - grabbing minidump binary from tooltool 05:28: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')]} 05:28:53 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 0xdefd00>, '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 0xdf0c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdf1090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:53 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 05:28:53 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 05:28:53 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 05:28:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:53 INFO - Return code: 0 05:28:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:28:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:53 INFO - ENV: RUST_BACKTRACE is now 1 05:28:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:28:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:53 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/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 05:28:53 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/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 05:28:53 INFO - Using env: {'DISPLAY': ':0', 05:28:53 INFO - 'HOME': '/home/cltbld', 05:28:53 INFO - 'LANG': 'en_US.UTF-8', 05:28:53 INFO - 'LANGUAGE': 'en_US:en', 05:28:53 INFO - 'LOGNAME': 'cltbld', 05:28:53 INFO - 'MAIL': '/var/mail/cltbld', 05:28:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:53 INFO - 'MOZ_NO_REMOTE': '1', 05:28:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:53 INFO - 'NO_EM_RESTART': '1', 05:28:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:53 INFO - 'PWD': '/builds/slave/test', 05:28:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:53 INFO - 'RUST_BACKTRACE': '1', 05:28:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:28:53 INFO - 'SHELL': '/bin/bash', 05:28:53 INFO - 'SHLVL': '1', 05:28:53 INFO - 'TERM': 'linux', 05:28:53 INFO - 'TMOUT': '86400', 05:28:53 INFO - 'USER': 'cltbld', 05:28:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611', 05:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:53 INFO - '_': '/tools/buildbot/bin/python'} 05:28:53 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/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 05:28:53 INFO - mozversion application_buildid: 20170720112422 05:28:53 INFO - mozversion application_changeset: 68046a58f82913eb7804e4796ec981f6f8ea490e 05:28:53 INFO - mozversion application_display_name: Nightly 05:28:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:53 INFO - mozversion application_name: Firefox 05:28:53 INFO - mozversion application_remotingname: firefox 05:28:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:28:53 INFO - mozversion application_vendor: Mozilla 05:28:53 INFO - mozversion application_version: 56.0a1 05:28:53 INFO - mozversion platform_buildid: 20170720112422 05:28:53 INFO - mozversion platform_changeset: 68046a58f82913eb7804e4796ec981f6f8ea490e 05:28:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:28:53 INFO - mozversion platform_version: 56.0a1 05:28:53 INFO - using testdate: 1500553733 05:28:53 INFO - actual date: 1500553733 05:28:53 INFO - starting webserver on 'localhost:55741' 05:28:53 INFO - SUITE-START | Running 2 tests 05:28:53 INFO - TEST-START | dromaeo_css 05:28:53 INFO - Initialising browser for dromaeo_css test... 05:28:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html -profile /tmp/tmp5VA1lA/profile 05:28:53 INFO - TEST-INFO | started process 28118 (/builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html) 05:28:59 INFO - TEST-INFO | 28118: exit 0 05:29:00 INFO - Browser initialized. 05:29:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:00 INFO - TEST-INFO | started process 28336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5VA1lA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:11 INFO - PID 28336 | RSS: Main: 165576704 05:29:11 INFO - PID 28336 | 05:32:09 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55741/tests/dromaeo/cssquery-ext.html) 05:32:10 INFO - PID 28336 | RSS: Main: 171814912 05:32:10 INFO - PID 28336 | 05:35:12 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-ext.html (next: http://localhost:55741/tests/dromaeo/cssquery-jquery.html) 05:35:12 INFO - PID 28336 | RSS: Main: 169893888 05:35:12 INFO - PID 28336 | 05:38:14 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55741/tests/dromaeo/cssquery-mootools.html) 05:38:15 INFO - PID 28336 | RSS: Main: 171065344 05:38:15 INFO - PID 28336 | 05:41:16 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55741/tests/dromaeo/cssquery-prototype.html) 05:41:17 INFO - PID 28336 | RSS: Main: 169709568 05:41:17 INFO - PID 28336 | 05:44:20 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55741/tests/dromaeo/cssquery-yui.html) 05:44:21 INFO - PID 28336 | RSS: Main: 171597824 05:44:21 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-yui.html (next: http://localhost:55741/tests/dromaeo/cssquery-dojo.html) 05:47:23 INFO - PID 28336 | RSS: Main: 173654016 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | __start_tp_report 05:47:23 INFO - PID 28336 | _x_x_mozilla_page_load 05:47:23 INFO - PID 28336 | _x_x_mozilla_page_load_details 05:47:23 INFO - PID 28336 | |i|pagename|runs| 05:47:23 INFO - PID 28336 | |0;dojo.html;3334.783239089459;3349.464085746281;3362.361151381238;3373.98313008435;3381;5965.880682386355;6088.695565221743;6122.571420000601;6138.693065346732;6139.72371243294;6005.759769609222;6065.332813390534;6105.389461053904;6107.572469927107;6143.907841382383;5324.866878328034;5347;5425.728713564306;5428.511433970942;5473.67157970521;5248.107821670306;5317.9468205317835;5340.198970154469;5419.512243898049;5477.917831232535;5263.605229607776;5360.705161216131;5365.06111430502;5379.408265090837;5384.515393614574;5352.759125839347;5352.946470535284;5414.729263536847;5419.512243898068;5428.240046393508;5284.735763211863;5286.9471305287225;5343.225232341328;5347.6256662033675;5400.108982018001;5884.529237660977;5928.6739229342365;5955.196048533436;5975.043992961106;6045.78839740607;6547.116139321179;6560.606363618151;6561.2782593914635;6567.408933195988;6579.046038324416;6576.145101136822;6594.637294948776;6658.201015878126;6685.498587605949;6706.094677218562;6014.278286605591;6020.337762846083;6119.357467465897;6179.752809887599;6204;6635.469162466991;6698.095757072733;6728.428083612947;6754.155730533684;6784.3554862288;6456.192975878015;6473.385028422293;6531.804045878631;6542.934570654328;6544.181977252843;6500.739970401131;6584.144061272004;6653.367930046637;6669.1330127083165;6679.131712877392;6357.237131544244;6426.485881129498;6427.357264273629;6510.544261901621;6558.1802274715665;6446.129772480749;6523.412892839572;6539.378759017885;6594.142761440982;6600.900986485207;4722.244440889442;4724.4094488188975;4742.407199100113;4751.572358487752;4758.262469317261;4280.828766849291;4306.375575541591;4314.848980285675;4338.848140315074;4339.848105316299;6094.146819445281;6215;6252.812415627538;6303.464205542488;6329.905051424233;6466.902996455057;6501.8699626008165;6521.902171467432;6522.771702990372;6527.3472652734345;6198.2252218472695;6220.253569571681;6245.18812554365;6283.214598175228;6291.150694656254;5411.64824286428;5431.782728690887;5432.402435732066;5439.211314359396;5440.891182176334;6759.695813688396;6822.658867056726;6829.52193346461;6937.375636192767;6952.930470695228;6411.5832470889245;6464.838379040561;6511.34886511345;6618.900716489353;6627.105340779126;6711.966440167768;6897.41371983387;6909.550879192836;6922.896156557555;6933.16801983745;6476.579022363531;6490.740370385131;6505.121808555974;6568.080468734285;6590.47276217911;6509.218893732783;6569.37590928861;6621.404073633396;6627.966860165669;6690.933090669031;6416.679166041586;6430.807075787734;6433.420992110732;6435.420812126744;6468.967655161694;6402.487800976004;6402.583832050902;6467.482601391972;6475.061116138039;6489.967550162219;6339.5562310637815;6367.840803979752;6379.649119298483;6465.515086368447;6465.612063276219;6392.264889537762;6428.4214420702365;6466.579672321284;6483.2544257411;6488.318726533646;6200.224971878515;6205.6586887721605;6274.403931626488;6278.497720182466;6301.590396624205 05:47:23 INFO - PID 28336 | |1;ext.html;767.3630886364315;780.3250188586874;794;817.3706246190437;822.0874828939876;42192.36711449327;42877.78561107198;43320.13359732804;43322.56677433225;43382.13235735287;39442;39832.800835995855;39907.80046099773;39972.80013599935;39984.80007599965;6705.597664140155;6815.31846815317;6816.284290149537;6822.079019332376;6823.3858952694245;6674.899876501856;6732.764353247638;6740.8314792130095;6742.7640032598865;6743.3256674332415;6670.433013193884;7292.489525733201;7512.286332798375;7513.323800857949;7514.211007844179;7415.629218539051;7433.0337056182625;7435.814104647373;7439.925600743977;7443.59060251686;7211.819704507429;7319.780406587811;7452.366548843354;7467.925320746777;7469.290417410337;40186.598134018575;40230.798846005586;40534.594654053675;40535.7973210135;40725.389119163236;3413.6415676354122;3446.7414943879307;3466.9306613867834;3477.6522347765276;3477.8956631301103;31552.526712099338;31566.684333156605;31656.525152122736;31722.365552689047;31795.84102079475;4986.601071914238;4988.276699878534;5002.274670172841;5004.899902001939;5068.797248110071;272631;273745;276016;276997;277179;52192.478075218765;52754.73622631862;52862.20706689403;52891.47108528943;52932.47067529352;55053.44946550483;55265.72367138219;55267.44732552623;55283.44716552863;55363.72318138464;15311;15640.921795391178;15654;15749.68500629981;15756.60608484797;12898.355082245851;13030.348482576022;13035.957123430102;13058.151220170848;13080.803787943189;15087.396504139711;15144.848551514564;15226.390944362323;15264.923675381775;15438.768418473732;6028.4272994065495;6037.607555508878;6055.6063855849225;6249.437550620466;6267.2792628847355;1070.400575677623;1075.9462026898623;1076.650088721153;1080.098118071419;1096.5449338524581;23911.7608823913;24387.756122438903;24441.755582444304;24514.754852451602;24619.87690061574;1163.1857699610307;1199.7420554580808;1201.3212534917743;1213.1023042948154;1221.1268942706008;12498.38013497216;12870.456384285697;12960.222386656831;13016.674583135497;13020.763027512372;260682;272610;274781;275057;275524;48008;48839.75580122077;54367.45632543624;54381;54870;1546.4510098914948;1551.9379224831107;1560.087348900883;1561.3364320163657;1584.67514159597;28265.57601635936;28350.574741379307;28355.291117722223;29007.129786106452;29693.85153074221;53705.46294537161;54289.45710543002;54321.72839135779;54326.45673543372;54472.182917257065;242478;244554;244982;245297;248592;36651.45022824713;36793;36818.447723284706;37022.8148859254;37091;48247.75876120597;48953.755231223615;49397.50602493929;49422.50577494323;49584.256236157205;33385;34955.47566786449;35080;35663.28673426465;35744;33403.83298083494;33967.3206535863;34891.30217395587;35124.297514050086;35361.82319088388;40378.1924361517;41179.38230926599;41410.79294603508;41889.58110418979;42074.57925420706;32762.180945476553;33526.66473335236;34013.48979765355;34097.31805363829;34509;24592.262232133064;25200.243992680247;25327;25711.228663140137;25746.871265643553 05:47:23 INFO - PID 28336 | |2;jquery.html;555.7943560882469;564.3481778545779;571.4514066496164;574.184657785944;578.756922092721;22758.88620556895;22859.771402285973;23644.527109457802;23654.935527901263;23675.5264894702;23380.41548961277;23569.528609427845;23953.88023059882;23997.40006499834;24124.879375603097;6341.239051313849;6468.935310646881;6480.319566445526;6481.060246264289;6487.318831522693;6046.365131661179;6351.872962540747;6387.744490220385;6392.7123279452535;6399.968000160016;6299.905501417483;6309.495240380781;6353.9682301588655;6357.110004599337;6359.745610175611;6286.9056964145575;6291.307956124822;6345.270293916189;6349.396807303298;6352.650604216767;5885.293764748215;5907.911381329241;5909.261342332208;5911;5915.970420147914;29425.705742942726;29940.251493712614;30067.248318791986;31310;31680;2216.1024784962115;2249.6737972993988;2256.8533045352;2270.591293567157;2271.375371772776;18794.154263058193;19718.605627887504;19760.70358944617;19775.307864224826;20080.397588072236;2363.243761996162;2423.7455067217866;2424.6363045543135;2426.5389575980685;2434.9269521914193;151036;155259;157527;157656.2117189418;157803;15169.24153792328;15864.841351586336;16023.19884005795;16076.356945722275;16090.275937582837;23986.52026959451;24045.398865028514;24121;24126.155584554457;24173.51652966931;10392.844107338396;10557.63048293306;10718.517666705016;10782.299150555189;10815.891841081488;8555.914440855637;8943.776405589912;9739.56171972263;9784.412935223909;9924.206063515046;9206.677766278148;9553.570089345996;9829.606815727291;9932.751681207883;9941.30410871232;2707.986460067687;2753.518134326485;2831.844248566307;2859.9428011439654;2942.7204415580486;1043.984340234897;1049.228816819637;1055.9049685528187;1059.2267644619317;1064.8509208710786;21313.25403610866;22396;25516.744832551438;26776.866115669298;27081.45837083247;1060.9045185933303;1091.7652704668535;1130.2032067392468;1143.3368646185359;1145.7937571237092;11714.53568303962;11733.647990560126;11944.64166075019;11993.34036627994;12000;581652.4739245754;587461;612108;619184;632890;125130;130370;131216;133655;136598.31700841433;1333.1401246196342;1347.487954577274;1366.7539842828387;1375.7523645743863;1385.764420048594;17725.379611713528;18681.719774203128;19207;22137.446563836034;23311.650325244795;63190.368096318445;64593;65305.67347163234;65997.67001164964;66995.3300466989;76295.61852190703;84352;86561;87339;87602;12947.158434701714;13360.398782054637;13845.653858653613;15430.614234643775;15644.608884777515;24215.636765448886;24254.63618045766;24456.6331505024;24493.877530612233;24782.38044048913;19862.404127876187;20297.89851050735;20421.591568168256;20453.48866278355;20558.691619626017;16399.59001024936;17384;17531.651879174966;17601.471955841345;17968.550786230448;20467.8976605116;20581.89709051505;20611;20618.896905515376;20695.8965205173;14385.928070359581;14972.550823475312;15033.774493382389;15106.848931510543;15106.924465377602;19034.33379831699;19074.52313692169;19234.422967311002;19372.806271937665;19510.12204450775 05:47:23 INFO - PID 28336 | |3;mootools.html;1448.768197088466;1493.8879584031201;1513.40220612858;1538.923053847308;1544.8722432624184;14894.47869324574;15203.923980380096;15787.684246315066;15838.762418563701;15845.762313565307;15825.762613560777;16138.596535086628;16164.595885102848;16172.75740863888;16199.1090490023;2809;2862.9284267893363;2865.2980019895153;2865.355295058616;2866.7276608722136;2728;2805.0322638689618;2810.775137988956;2812.70466601007;2817;2743.231895069384;2763.4196818668;2778.88884444623;2779.069011881022;2779.680336761268;2604.7785938195275;2697.2447714639934;2748.560230363152;2748.7800975921878;2751.2021513760988;2549.171519256249;2575.2016874768883;2585.728498507667;2587.236765154284;2588.081231162929;15177.772333415007;15289.388424463008;15296.847031529765;15421.383144674199;15519.379224831106;8088.514689118613;8400.41197116202;8416.579171041485;8416.579171041485;8417.873731894026;4871.147549178915;5129.7435128243815;5219.086659834514;5228.241904923802;5321.893562128775;1696.4995326378626;1713.3489274075896;1722.1819635672955;1748.2569907789266;1754.175537497374;27133.728662713514;27366.589501157498;27368.178954631392;27386.589201161798;27398.17805465839;7466;7475.514091584029;7518.173000969889;7787.29914307715;7799.883001754978;18591.34930277434;18621;18668.81331186698;18711.251549938122;18805;8103.837923241502;8239;8245;8253.8349233015;8269.545175015312;6367.7452901884335;6710.698018589175;6905.343992320722;7637.885431718529;7675.961620191863;5248.711320877388;5388.407275199725;5408.486193811582;5420.620556561003;5497.257870187554;1457.890658200618;1459.5548357750988;1470.2134358118356;1476.3430273528177;1490.3293517916982;963.1668606655193;980.2403137568441;985.3693636072919;988.8862780780303;994.6618149829093;7878.212178782191;8135;8175.5503447309775;8353.958230208931;8898.688545900863;726.4696771356834;741.4179868802963;762.4624639629048;764.7399884039453;774.9767506974799;4690.718556886598;4772.49888761675;4794.5924596409695;4797.136515427187;5022.824201152942;20052.298169563994;20797.688034679493;21980;22931.541369172523;22943;21354;21470.57058858814;21596.244131455325;21602.243921462672;21708.348749537538;11371.943140284246;11591.76816463666;11867.703307417383;11970.221935574335;12100.455479503444;8385.58072096405;9280.62877484893;9455.810883782147;9547.761305967406;9565.617375305188;18843.340483083026;19094.713579296043;19160.520986975436;19868.50328741793;20042;18813.341533046278;19180.040997950327;19793.505162371057;19877.701834472784;20455.386338409873;11905.047596192457;12115.212511186744;12347.876521234673;12428.067894907737;12511;13816.171029738249;13879;14004.579862604138;14020.158790472604;14027.158370497802;11134.777304454028;11627.360495172847;11777.116716246144;11928.284302941851;11996.520139194683;10827.945860270649;11019.393933333744;11160.162987775788;11369.488373023069;11427.542898283975;10779.730506737395;10923.399213043358;10924.672259832218;10935.945320273348;10944.616938407118;7669.1947345527915;7880.921190788248;7926.564038977912;8006.559639219666;8039.638216280398;7901.209879012053;8129.105798362294;8131.7560473185895;8206.917930820615;8342.958285208535 05:47:23 INFO - PID 28336 | |4;prototype.html;492.88417221952847;500.2845930319644;518.7769259218537;522.1515038063147;532.510090716541;6079.300880398756;6086.543509236814;6115.496053551806;6127.509799216064;6137.140800287963;5759.798407055754;5916.408359164081;5951.137085122655;5971.880562388749;6015.841683116355;4699.248120300753;4712.976435117836;4716.151092803294;4722.338872557844;4733.822441676833;4605.631549476051;4670.859874203779;4701.952980470186;4738.241881298993;4748.548887855648;4619.445666520006;4664.207084795576;4682.391289132408;4689.671722979393;4713.976430117845;4660.930086048712;4688.859334219979;4693.812247510078;4713.175194340994;4713.835015774465;4290.635295999844;4314.374415709736;4336.588024137734;4342.848000320006;4359.215341238576;5893.941060589382;5982.312034116046;5985.072313791369;6007.399260074001;6014.18808460861;5562.276904002494;5591.440855914376;5614.073677843151;5615.157726341082;5629.887402251932;6329.905051424233;6359.141515895341;6402.423781859655;6403.327650596713;6428.646424446653;4809.326694262806;4839.830605928775;4856.902861942742;4866.391701037371;4878.243872199815;6458.547901646886;6515.4787616990525;6565.212174539038;6576.928267595692;6593.769218077392;4944.184209605447;4996.200607902718;5003.924941125886;5004.149294619923;5029.84910452687;5029.446760856303;5063;5099.889067668719;5103.719295438712;5123;5551.472610102034;5579.637323574036;5646.915296270559;5655.765972440863;5666.03677374839;6170.629762214281;6441.710123044474;6473.190851143607;6485.6108633482145;6551.65691033337;1697.5840918974684;1716.7167417376243;1736.5484973906875;1744.1715185286887;1745.8079611242754;1052.6315789473622;1204.8012078007207;1227.34337129637;1230.2987297240486;1238.1456794811552;6015.578909476382;6078.902778541396;6120.938790612036;6125.816225513242;6175.461036138435;6478;6515.967420162963;6526.608403495806;6577.506686998494;6607.9669601651685;6125.601835880653;6182.319944806068;6202.627842329474;6205.193324867739;6273.905891411632;3447.9827600861836;3474;3487.4655151733664;3531.1172206948263;3542.628024057437;6795.2185498667295;6809.250982391933;6844.531917338168;6872.140982377203;6959.269276725972;6753.729850805913;6776.272050627157;6789;6801.795946121624;6845.349691779273;6760.628165450849;6813.2846051163915;6829.556078854958;6866.244713081557;6878.58728476293;6442.581232219891;6479.352064793483;6482.675866206765;6592.274849766618;6626.939689649633;6512.251091124582;6546.738130474728;6563.9343606563325;6585.209774827052;6587.242467116343;6827.48793840454;6895.241523432318;6926.619035953071;6991.965040174767;6998.440124790106;4922.237053256751;4937.518744376601;4982.775775090057;4998.2002879539095;5003.424606170337;6556.541042127005;6602.8679426410245;6650.3682150195655;6684.6991885364305;6700.229473610597;6297.725182904956;6395.264544577433;6416.422521973045;6424.678766061772;6455.257645370654;6373;6397.168368112302;6414.647194404352;6459.967700161469;6481.0232878972365;6321.146645202839;6332.525060620564;6355.586886852339;6404.231492220963;6406.967965160145;5916.112583112567;6322.936770632235;6423.751686909544;6445.387688169616;6491.28595854465;6156.29202641702;6261.7182226799;6267.373262673878;6282.2147231596055;6309.779157729457 05:47:23 INFO - PID 28336 | |5;yui.html;910.1990248581247;921.4333185091168;935.20974776314;935.9344845860788;945.418567580938;17943.282268709252;19074.523136921584;19081.14134863933;19118.617627647454;21770.564588708257;20771.792282077175;21752;21776.782232177673;21994.670079948814;21997.23009694661;1032.334144476814;1066.4507778494083;1075.7418219627311;1080.567772890842;1081.3133660125798;1012.7822518158595;1071.7642118733866;1081.5727787523924;1082.8050950828847;1087.3041253597703;1157.8494795676593;1158.4960542164144;1159.269660114127;1162.0993729859342;1163.6625378640185;1122.007023783953;1129.0628778114146;1131.7170707323169;1133.7505748735266;1135.9318440893533;819.6229734322219;820.2781552233996;820.4748960665179;824.114077366827;825.2490233887133;19319.613607727766;19588.706169407327;19718.605627887504;19761;20201;20446.284380046774;20681.793182068137;21040.368788936357;21227.68158477624;21230.893845530674;15632.92183539075;16051;16219.756703649455;16243.350265989346;16269.349226030945;3563.55455568054;3577.6422357764277;3578.874739384135;3586.1393265616325;3589.28214357127;136668;140959.29520352435;142355;143455.28272358674;146148;14598.781018284733;14727.705445891237;14816.555503334917;14908.105513669214;14981.325840337211;30991.845040774653;31572.842135789633;31729.20676983094;31981.68018319787;32047.679523204937;8181.550014749246;8621.870671939925;8806.383553151218;8975.057618950046;9147.954260228656;4504.774761261924;4619.376384188159;4632.374629424984;4646.83736069236;4662.323963025342;5366.490183432567;5471.960327537755;5512.173174023928;5536.889262214733;5576.9163462548095;1105.9944700276608;1108.9001989820792;1122.7529943412437;1129.0346753525782;1129.9830502542468;676.5365724478747;682.3858527325348;691.9515633905578;718.586812582767;729.1541811498636;12865.54970576044;12920.612381628565;13025.609231723063;13292.20246785196;13580.25308608036;686.7424715731601;701.1516065560627;709.3722055980494;715.0704084689986;718.9712411503585;5473.75368108436;5572.637778544382;5636.859078522988;5642.943570564324;5670.347909990404;123481.38259308646;129462.35268823596;130278.34860825635;131571;133796;111733;112534.19194464614;113289;114642.4267878672;116123;90590.54704726566;96523.51738241123;96925.5153724241;98655.50672246737;100265;13134.802977955529;13201.537946172222;13530.864691352961;13909.374078166304;14155.716885662436;45224.095518090115;45359;47163.528364715916;47599.28601070918;47668.7616561915;57040.71479642575;59712.70143649254;60136.39863601308;62046;63127.36872631399;17210.225539850988;17530.298788048334;17719.734203986693;17967;18180.909095454437;20700;20962.895185523976;21030.369088927357;21143.8942805285;21378.144874204856;20061.398158055283;20159.39521814348;20309.79690203079;20531.17875284972;20787;19510.512237194183;19523.70714439256;19674.21303147858;19742;19902.90048549806;19458.902705486384;19648.312309069115;20376.898115509328;20550.38348849537;21125.366239012856;14084.436622534984;14213;14357.928210358881;14521.636959076108;14806.333714983068;14541.127532348093;14823.481178158712;15603.141827199614;15890.920545397199;16216.837831621533 05:47:23 INFO - PID 28336 | __end_tp_report 05:47:23 INFO - PID 28336 | __start_cc_report 05:47:23 INFO - PID 28336 | _x_x_mozilla_cycle_collect,341 05:47:23 INFO - PID 28336 | __end_cc_report 05:47:23 INFO - PID 28336 | __startTimestamp1500554843257__endTimestamp 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | ------- Summary: start ------- 05:47:23 INFO - PID 28336 | Number of tests: 6 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#0] dojo.html Cycles:165 Average:6041.13 Median:6367.84 stddev:776.92 (12.2%) stddev-sans-first:749.73 05:47:23 INFO - PID 28336 | Values: 3334.8 3349.5 3362.4 3374.0 3381.0 5965.9 6088.7 6122.6 6138.7 6139.7 6005.8 6065.3 6105.4 6107.6 6143.9 5324.9 5347.0 5425.7 5428.5 5473.7 5248.1 5317.9 5340.2 5419.5 5477.9 5263.6 5360.7 5365.1 5379.4 5384.5 5352.8 5352.9 5414.7 5419.5 5428.2 5284.7 5286.9 5343.2 5347.6 5400.1 5884.5 5928.7 5955.2 5975.0 6045.8 6547.1 6560.6 6561.3 6567.4 6579.0 6576.1 6594.6 6658.2 6685.5 6706.1 6014.3 6020.3 6119.4 6179.8 6204.0 6635.5 6698.1 6728.4 6754.2 6784.4 6456.2 6473.4 6531.8 6542.9 6544.2 6500.7 6584.1 6653.4 6669.1 6679.1 6357.2 6426.5 6427.4 6510.5 6558.2 6446.1 6523.4 6539.4 6594.1 6600.9 4722.2 4724.4 4742.4 4751.6 4758.3 4280.8 4306.4 4314.8 4338.8 4339.8 6094.1 6215.0 6252.8 6303.5 6329.9 6466.9 6501.9 6521.9 6522.8 6527.3 6198.2 6220.3 6245.2 6283.2 6291.2 5411.6 5431.8 5432.4 5439.2 5440.9 6759.7 6822.7 6829.5 6937.4 6952.9 6411.6 6464.8 6511.3 6618.9 6627.1 6712.0 6897.4 6909.6 6922.9 6933.2 6476.6 6490.7 6505.1 6568.1 6590.5 6509.2 6569.4 6621.4 6628.0 6690.9 6416.7 6430.8 6433.4 6435.4 6469.0 6402.5 6402.6 6467.5 6475.1 6490.0 6339.6 6367.8 6379.6 6465.5 6465.6 6392.3 6428.4 6466.6 6483.3 6488.3 6200.2 6205.7 6274.4 6278.5 6301.6 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#1] ext.html Cycles:180 Average:43949.73 Median:36722.23 stddev:68925.09 (187.7%) stddev-sans-first:69042.18 05:47:23 INFO - PID 28336 | Values: 767.4 780.3 794.0 817.4 822.1 42192.4 42877.8 43320.1 43322.6 43382.1 39442.0 39832.8 39907.8 39972.8 39984.8 6705.6 6815.3 6816.3 6822.1 6823.4 6674.9 6732.8 6740.8 6742.8 6743.3 6670.4 7292.5 7512.3 7513.3 7514.2 7415.6 7433.0 7435.8 7439.9 7443.6 7211.8 7319.8 7452.4 7467.9 7469.3 40186.6 40230.8 40534.6 40535.8 40725.4 3413.6 3446.7 3466.9 3477.7 3477.9 31552.5 31566.7 31656.5 31722.4 31795.8 4986.6 4988.3 5002.3 5004.9 5068.8 272631.0 273745.0 276016.0 276997.0 277179.0 52192.5 52754.7 52862.2 52891.5 52932.5 55053.4 55265.7 55267.4 55283.4 55363.7 15311.0 15640.9 15654.0 15749.7 15756.6 12898.4 13030.3 13036.0 13058.2 13080.8 15087.4 15144.8 15226.4 15264.9 15438.8 6028.4 6037.6 6055.6 6249.4 6267.3 1070.4 1075.9 1076.7 1080.1 1096.5 23911.8 24387.8 24441.8 24514.8 24619.9 1163.2 1199.7 1201.3 1213.1 1221.1 12498.4 12870.5 12960.2 13016.7 13020.8 260682.0 272610.0 274781.0 275057.0 275524.0 48008.0 48839.8 54367.5 54381.0 54870.0 1546.5 1551.9 1560.1 1561.3 1584.7 28265.6 28350.6 28355.3 29007.1 29693.9 53705.5 54289.5 54321.7 54326.5 54472.2 242478.0 244554.0 244982.0 245297.0 248592.0 36651.5 36793.0 36818.4 37022.8 37091.0 48247.8 48953.8 49397.5 49422.5 49584.3 33385.0 34955.5 35080.0 35663.3 35744.0 33403.8 33967.3 34891.3 35124.3 35361.8 40378.2 41179.4 41410.8 41889.6 42074.6 32762.2 33526.7 34013.5 34097.3 34509.0 24592.3 25200.2 25327.0 25711.2 25746.9 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#2] jquery.html Cycles:180 Average:40034.24 Median:12966.39 stddev:101821.59 (785.3%) stddev-sans-first:102064.08 05:47:23 INFO - PID 28336 | Values: 555.8 564.3 571.5 574.2 578.8 22758.9 22859.8 23644.5 23654.9 23675.5 23380.4 23569.5 23953.9 23997.4 24124.9 6341.2 6468.9 6480.3 6481.1 6487.3 6046.4 6351.9 6387.7 6392.7 6400.0 6299.9 6309.5 6354.0 6357.1 6359.7 6286.9 6291.3 6345.3 6349.4 6352.7 5885.3 5907.9 5909.3 5911.0 5916.0 29425.7 29940.3 30067.2 31310.0 31680.0 2216.1 2249.7 2256.9 2270.6 2271.4 18794.2 19718.6 19760.7 19775.3 20080.4 2363.2 2423.7 2424.6 2426.5 2434.9 151036.0 155259.0 157527.0 157656.2 157803.0 15169.2 15864.8 16023.2 16076.4 16090.3 23986.5 24045.4 24121.0 24126.2 24173.5 10392.8 10557.6 10718.5 10782.3 10815.9 8555.9 8943.8 9739.6 9784.4 9924.2 9206.7 9553.6 9829.6 9932.8 9941.3 2708.0 2753.5 2831.8 2859.9 2942.7 1044.0 1049.2 1055.9 1059.2 1064.9 21313.3 22396.0 25516.7 26776.9 27081.5 1060.9 1091.8 1130.2 1143.3 1145.8 11714.5 11733.6 11944.6 11993.3 12000.0 581652.5 587461.0 612108.0 619184.0 632890.0 125130.0 130370.0 131216.0 133655.0 136598.3 1333.1 1347.5 1366.8 1375.8 1385.8 17725.4 18681.7 19207.0 22137.4 23311.7 63190.4 64593.0 65305.7 65997.7 66995.3 76295.6 84352.0 86561.0 87339.0 87602.0 12947.2 13360.4 13845.7 15430.6 15644.6 24215.6 24254.6 24456.6 24493.9 24782.4 19862.4 20297.9 20421.6 20453.5 20558.7 16399.6 17384.0 17531.7 17601.5 17968.6 20467.9 20581.9 20611.0 20618.9 20695.9 14385.9 14972.6 15033.8 15106.8 15106.9 19034.3 19074.5 19234.4 19372.8 19510.1 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#3] mootools.html Cycles:180 Average:9648.77 Median:2651.01 stddev:6887.68 (259.8%) stddev-sans-first:6879.45 05:47:23 INFO - PID 28336 | Values: 1448.8 1493.9 1513.4 1538.9 1544.9 14894.5 15203.9 15787.7 15838.8 15845.8 15825.8 16138.6 16164.6 16172.8 16199.1 2809.0 2862.9 2865.3 2865.4 2866.7 2728.0 2805.0 2810.8 2812.7 2817.0 2743.2 2763.4 2778.9 2779.1 2779.7 2604.8 2697.2 2748.6 2748.8 2751.2 2549.2 2575.2 2585.7 2587.2 2588.1 15177.8 15289.4 15296.8 15421.4 15519.4 8088.5 8400.4 8416.6 8416.6 8417.9 4871.1 5129.7 5219.1 5228.2 5321.9 1696.5 1713.3 1722.2 1748.3 1754.2 27133.7 27366.6 27368.2 27386.6 27398.2 7466.0 7475.5 7518.2 7787.3 7799.9 18591.3 18621.0 18668.8 18711.3 18805.0 8103.8 8239.0 8245.0 8253.8 8269.5 6367.7 6710.7 6905.3 7637.9 7676.0 5248.7 5388.4 5408.5 5420.6 5497.3 1457.9 1459.6 1470.2 1476.3 1490.3 963.2 980.2 985.4 988.9 994.7 7878.2 8135.0 8175.6 8354.0 8898.7 726.5 741.4 762.5 764.7 775.0 4690.7 4772.5 4794.6 4797.1 5022.8 20052.3 20797.7 21980.0 22931.5 22943.0 21354.0 21470.6 21596.2 21602.2 21708.3 11371.9 11591.8 11867.7 11970.2 12100.5 8385.6 9280.6 9455.8 9547.8 9565.6 18843.3 19094.7 19160.5 19868.5 20042.0 18813.3 19180.0 19793.5 19877.7 20455.4 11905.0 12115.2 12347.9 12428.1 12511.0 13816.2 13879.0 14004.6 14020.2 14027.2 11134.8 11627.4 11777.1 11928.3 11996.5 10827.9 11019.4 11160.2 11369.5 11427.5 10779.7 10923.4 10924.7 10935.9 10944.6 7669.2 7880.9 7926.6 8006.6 8039.6 7901.2 8129.1 8131.8 8206.9 8343.0 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#4] prototype.html Cycles:180 Average:5451.42 Median:6118.22 stddev:1556.39 (25.4%) stddev-sans-first:1515.60 05:47:23 INFO - PID 28336 | Values: 492.9 500.3 518.8 522.2 532.5 6079.3 6086.5 6115.5 6127.5 6137.1 5759.8 5916.4 5951.1 5971.9 6015.8 4699.2 4713.0 4716.2 4722.3 4733.8 4605.6 4670.9 4702.0 4738.2 4748.5 4619.4 4664.2 4682.4 4689.7 4714.0 4660.9 4688.9 4693.8 4713.2 4713.8 4290.6 4314.4 4336.6 4342.8 4359.2 5893.9 5982.3 5985.1 6007.4 6014.2 5562.3 5591.4 5614.1 5615.2 5629.9 6329.9 6359.1 6402.4 6403.3 6428.6 4809.3 4839.8 4856.9 4866.4 4878.2 6458.5 6515.5 6565.2 6576.9 6593.8 4944.2 4996.2 5003.9 5004.1 5029.8 5029.4 5063.0 5099.9 5103.7 5123.0 5551.5 5579.6 5646.9 5655.8 5666.0 6170.6 6441.7 6473.2 6485.6 6551.7 1697.6 1716.7 1736.5 1744.2 1745.8 1052.6 1204.8 1227.3 1230.3 1238.1 6015.6 6078.9 6120.9 6125.8 6175.5 6478.0 6516.0 6526.6 6577.5 6608.0 6125.6 6182.3 6202.6 6205.2 6273.9 3448.0 3474.0 3487.5 3531.1 3542.6 6795.2 6809.3 6844.5 6872.1 6959.3 6753.7 6776.3 6789.0 6801.8 6845.3 6760.6 6813.3 6829.6 6866.2 6878.6 6442.6 6479.4 6482.7 6592.3 6626.9 6512.3 6546.7 6563.9 6585.2 6587.2 6827.5 6895.2 6926.6 6992.0 6998.4 4922.2 4937.5 4982.8 4998.2 5003.4 6556.5 6602.9 6650.4 6684.7 6700.2 6297.7 6395.3 6416.4 6424.7 6455.3 6373.0 6397.2 6414.6 6460.0 6481.0 6321.1 6332.5 6355.6 6404.2 6407.0 5916.1 6322.9 6423.8 6445.4 6491.3 6156.3 6261.7 6267.4 6282.2 6309.8 05:47:23 INFO - PID 28336 | 05:47:23 INFO - PID 28336 | [#5] yui.html Cycles:180 Average:25707.39 Median:19982.15 stddev:36385.03 (182.1%) stddev-sans-first:36439.46 05:47:23 INFO - PID 28336 | Values: 910.2 921.4 935.2 935.9 945.4 17943.3 19074.5 19081.1 19118.6 21770.6 20771.8 21752.0 21776.8 21994.7 21997.2 1032.3 1066.5 1075.7 1080.6 1081.3 1012.8 1071.8 1081.6 1082.8 1087.3 1157.8 1158.5 1159.3 1162.1 1163.7 1122.0 1129.1 1131.7 1133.8 1135.9 819.6 820.3 820.5 824.1 825.2 19319.6 19588.7 19718.6 19761.0 20201.0 20446.3 20681.8 21040.4 21227.7 21230.9 15632.9 16051.0 16219.8 16243.4 16269.3 3563.6 3577.6 3578.9 3586.1 3589.3 136668.0 140959.3 142355.0 143455.3 146148.0 14598.8 14727.7 14816.6 14908.1 14981.3 30991.8 31572.8 31729.2 31981.7 32047.7 8181.6 8621.9 8806.4 8975.1 9148.0 4504.8 4619.4 4632.4 4646.8 4662.3 5366.5 5472.0 5512.2 5536.9 5576.9 1106.0 1108.9 1122.8 1129.0 1130.0 676.5 682.4 692.0 718.6 729.2 12865.5 12920.6 13025.6 13292.2 13580.3 686.7 701.2 709.4 715.1 719.0 5473.8 5572.6 5636.9 5642.9 5670.3 123481.4 129462.4 130278.3 131571.0 133796.0 111733.0 112534.2 113289.0 114642.4 116123.0 90590.5 96523.5 96925.5 98655.5 100265.0 13134.8 13201.5 13530.9 13909.4 14155.7 45224.1 45359.0 47163.5 47599.3 47668.8 57040.7 59712.7 60136.4 62046.0 63127.4 17210.2 17530.3 17719.7 17967.0 18180.9 20700.0 20962.9 21030.4 21143.9 21378.1 20061.4 20159.4 20309.8 20531.2 20787.0 19510.5 19523.7 19674.2 19742.0 19902.9 19458.9 19648.3 20376.9 20550.4 21125.4 14084.4 14213.0 14357.9 14521.6 14806.3 14541.1 14823.5 15603.1 15890.9 16216.8 05:47:23 INFO - PID 28336 | -------- Summary: end -------- 05:47:23 INFO - PID 28336 | 05:47:23 INFO - TEST-INFO | 28336: exit 0 05:47:24 INFO - TEST-OK | dromaeo_css | took 1110526ms 05:47:24 INFO - TEST-START | kraken 05:47:24 INFO - Initialising browser for kraken test... 05:47:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html -profile /tmp/tmphBk3uh/profile 05:47:24 INFO - TEST-INFO | started process 28694 (/builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html) 05:47:30 INFO - TEST-INFO | 28694: exit 0 05:47:30 INFO - Browser initialized. 05:47:30 INFO - Running cycle 1/1 for kraken test... 05:47:30 INFO - TEST-INFO | started process 28907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphBk3uh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:41 INFO - PID 28907 | RSS: Main: 165425152 05:47:41 INFO - PID 28907 | 05:47:44 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:45 INFO - PID 28907 | RSS: Main: 169836544 05:47:45 INFO - PID 28907 | 05:47:47 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-dft) 05:47:48 INFO - PID 28907 | RSS: Main: 170500096 05:47:48 INFO - PID 28907 | 05:47:51 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-fft) 05:47:52 INFO - PID 28907 | RSS: Main: 164274176 05:47:52 INFO - PID 28907 | 05:47:54 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-oscillator) 05:47:54 INFO - PID 28907 | RSS: Main: 165593088 05:47:54 INFO - PID 28907 | 05:47:56 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:57 INFO - PID 28907 | RSS: Main: 165699584 05:47:57 INFO - PID 28907 | 05:48:00 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:01 INFO - PID 28907 | RSS: Main: 169160704 05:48:01 INFO - PID 28907 | 05:48:04 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:05 INFO - PID 28907 | RSS: Main: 170090496 05:48:05 INFO - PID 28907 | 05:48:08 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55741/tests/kraken/driver.html?testName=json-parse-financial) 05:48:08 INFO - PID 28907 | RSS: Main: 168669184 05:48:08 INFO - PID 28907 | 05:48:10 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55741/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:10 INFO - PID 28907 | RSS: Main: 168366080 05:48:10 INFO - PID 28907 | 05:48:12 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:13 INFO - PID 28907 | RSS: Main: 168235008 05:48:13 INFO - PID 28907 | 05:48:15 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:15 INFO - PID 28907 | RSS: Main: 168337408 05:48:15 INFO - PID 28907 | 05:48:18 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:19 INFO - PID 28907 | RSS: Main: 168357888 05:48:19 INFO - PID 28907 | 05:48:22 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:22 INFO - PID 28907 | RSS: Main: 168955904 05:48:22 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55741/tests/kraken/driver.html?testName=ai-astar) 05:48:24 INFO - PID 28907 | RSS: Main: 170160128 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | __start_tp_report 05:48:24 INFO - PID 28907 | _x_x_mozilla_page_load 05:48:24 INFO - PID 28907 | _x_x_mozilla_page_load_details 05:48:24 INFO - PID 28907 | |i|pagename|runs| 05:48:24 INFO - PID 28907 | |0;ai-astar;98;108;102;109;108;109;111;101;108;110 05:48:24 INFO - PID 28907 | |1;audio-beat-detection;139;119;138;174;114;144;140;114;164;122 05:48:24 INFO - PID 28907 | |2;audio-dft;162;163;163;161;163;162;161;170;165;166 05:48:24 INFO - PID 28907 | |3;audio-fft;76;75;76;107;76;74;76;90;102;76 05:48:24 INFO - PID 28907 | |4;audio-oscillator;82;81;139;82;80;81;131;81;80;129 05:48:24 INFO - PID 28907 | |5;imaging-gaussian-blur;116;115;114;114;114;114;113;113;117;114 05:48:24 INFO - PID 28907 | |6;imaging-darkroom;149;154;151;147;148;149;148;147;149;148 05:48:24 INFO - PID 28907 | |7;imaging-desaturate;94;94;94;95;94;93;94;94;94;93 05:48:24 INFO - PID 28907 | |8;json-parse-financial;49;48;48;48;47;50;48;49;47;47 05:48:24 INFO - PID 28907 | |9;json-stringify-tinderbox;52;53;59;53;53;54;52;53;53;54 05:48:24 INFO - PID 28907 | |10;stanford-crypto-aes;76;81;75;75;75;75;91;75;75;77 05:48:24 INFO - PID 28907 | |11;stanford-crypto-ccm;120;128;125;130;124;119;124;133;125;163 05:48:24 INFO - PID 28907 | |12;stanford-crypto-pbkdf2;164;164;166;163;164;173;171;172;165;163 05:48:24 INFO - PID 28907 | |13;stanford-crypto-sha256-iterative;63;62;63;67;62;62;62;63;67;61 05:48:24 INFO - PID 28907 | __end_tp_report 05:48:24 INFO - PID 28907 | __start_cc_report 05:48:24 INFO - PID 28907 | _x_x_mozilla_cycle_collect,865 05:48:24 INFO - PID 28907 | __end_cc_report 05:48:24 INFO - PID 28907 | __startTimestamp1500554904652__endTimestamp 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | ------- Summary: start ------- 05:48:24 INFO - PID 28907 | Number of tests: 14 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#0] ai-astar Cycles:10 Average:106.40 Median:109.00 stddev:4.40 (4.0%) stddev-sans-first:3.46 05:48:24 INFO - PID 28907 | Values: 98.0 108.0 102.0 109.0 108.0 109.0 111.0 101.0 108.0 110.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:139.50 stddev:20.46 (14.7%) stddev-sans-first:21.69 05:48:24 INFO - PID 28907 | Values: 139.0 119.0 138.0 174.0 114.0 144.0 140.0 114.0 164.0 122.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.76 (1.7%) stddev-sans-first:2.86 05:48:24 INFO - PID 28907 | Values: 162.0 163.0 163.0 161.0 163.0 162.0 161.0 170.0 165.0 166.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:12.36 (16.3%) stddev-sans-first:12.87 05:48:24 INFO - PID 28907 | Values: 76.0 75.0 76.0 107.0 76.0 74.0 76.0 90.0 102.0 76.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:81.00 stddev:25.25 (31.2%) stddev-sans-first:26.22 05:48:24 INFO - PID 28907 | Values: 82.0 81.0 139.0 82.0 80.0 81.0 131.0 81.0 80.0 129.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.20 05:48:24 INFO - PID 28907 | Values: 116.0 115.0 114.0 114.0 114.0 114.0 113.0 113.0 117.0 114.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:2.11 (1.4%) stddev-sans-first:2.24 05:48:24 INFO - PID 28907 | Values: 149.0 154.0 151.0 147.0 148.0 149.0 148.0 147.0 149.0 148.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:48:24 INFO - PID 28907 | Values: 94.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 94.0 93.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.00 stddev:0.99 (2.1%) stddev-sans-first:1.00 05:48:24 INFO - PID 28907 | Values: 49.0 48.0 48.0 48.0 47.0 50.0 48.0 49.0 47.0 47.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:53.00 stddev:2.01 (3.8%) stddev-sans-first:2.05 05:48:24 INFO - PID 28907 | Values: 52.0 53.0 59.0 53.0 53.0 54.0 52.0 53.0 53.0 54.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:75.50 stddev:5.10 (6.8%) stddev-sans-first:5.39 05:48:24 INFO - PID 28907 | Values: 76.0 81.0 75.0 75.0 75.0 75.0 91.0 75.0 75.0 77.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:126.50 stddev:12.64 (10.0%) stddev-sans-first:12.97 05:48:24 INFO - PID 28907 | Values: 120.0 128.0 125.0 130.0 124.0 119.0 124.0 133.0 125.0 163.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:165.50 stddev:3.92 (2.4%) stddev-sans-first:4.06 05:48:24 INFO - PID 28907 | Values: 164.0 164.0 166.0 163.0 164.0 173.0 171.0 172.0 165.0 163.0 05:48:24 INFO - PID 28907 | 05:48:24 INFO - PID 28907 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.10 (3.3%) stddev-sans-first:2.22 05:48:24 INFO - PID 28907 | Values: 63.0 62.0 63.0 67.0 62.0 62.0 62.0 63.0 67.0 61.0 05:48:24 INFO - PID 28907 | -------- Summary: end -------- 05:48:24 INFO - PID 28907 | 05:48:25 INFO - PID 28907 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:48:25 INFO - TEST-INFO | 28907: exit 0 05:48:25 INFO - TEST-OK | kraken | took 61422ms 05:48:25 INFO - SUITE-END | took 1171s 05:48:25 INFO - Completed test suite (00:19:32) 05:48:25 INFO - javascript benchmark 05:48:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8760.147543101735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3334.783239089459, 3349.464085746281, 3362.361151381238, 3373.98313008435, 3381.0, 5965.880682386355, 6088.695565221743, 6122.571420000601, 6138.693065346732, 6139.72371243294, 6005.759769609222, 6065.332813390534, 6105.389461053904, 6107.572469927107, 6143.907841382383, 5324.866878328034, 5347.0, 5425.728713564306, 5428.511433970942, 5473.67157970521, 5248.107821670306, 5317.9468205317835, 5340.198970154469, 5419.512243898049, 5477.917831232535, 5263.605229607776, 5360.705161216131, 5365.06111430502, 5379.408265090837, 5384.515393614574, 5352.759125839347, 5352.946470535284, 5414.729263536847, 5419.512243898068, 5428.240046393508, 5284.735763211863, 5286.9471305287225, 5343.225232341328, 5347.6256662033675, 5400.108982018001, 5884.529237660977, 5928.6739229342365, 5955.196048533436, 5975.043992961106, 6045.78839740607, 6547.116139321179, 6560.606363618151, 6561.2782593914635, 6567.408933195988, 6579.046038324416, 6576.145101136822, 6594.637294948776, 6658.201015878126, 6685.498587605949, 6706.094677218562, 6014.278286605591, 6020.337762846083, 6119.357467465897, 6179.752809887599, 6204.0, 6635.469162466991, 6698.095757072733, 6728.428083612947, 6754.155730533684, 6784.3554862288, 6456.192975878015, 6473.385028422293, 6531.804045878631, 6542.934570654328, 6544.181977252843, 6500.739970401131, 6584.144061272004, 6653.367930046637, 6669.1330127083165, 6679.131712877392, 6357.237131544244, 6426.485881129498, 6427.357264273629, 6510.544261901621, 6558.1802274715665, 6446.129772480749, 6523.412892839572, 6539.378759017885, 6594.142761440982, 6600.900986485207, 4722.244440889442, 4724.4094488188975, 4742.407199100113, 4751.572358487752, 4758.262469317261, 4280.828766849291, 4306.375575541591, 4314.848980285675, 4338.848140315074, 4339.848105316299, 6094.146819445281, 6215.0, 6252.812415627538, 6303.464205542488, 6329.905051424233, 6466.902996455057, 6501.8699626008165, 6521.902171467432, 6522.771702990372, 6527.3472652734345, 6198.2252218472695, 6220.253569571681, 6245.18812554365, 6283.214598175228, 6291.150694656254, 5411.64824286428, 5431.782728690887, 5432.402435732066, 5439.211314359396, 5440.891182176334, 6759.695813688396, 6822.658867056726, 6829.52193346461, 6937.375636192767, 6952.930470695228, 6411.5832470889245, 6464.838379040561, 6511.34886511345, 6618.900716489353, 6627.105340779126, 6711.966440167768, 6897.41371983387, 6909.550879192836, 6922.896156557555, 6933.16801983745, 6476.579022363531, 6490.740370385131, 6505.121808555974, 6568.080468734285, 6590.47276217911, 6509.218893732783, 6569.37590928861, 6621.404073633396, 6627.966860165669, 6690.933090669031, 6416.679166041586, 6430.807075787734, 6433.420992110732, 6435.420812126744, 6468.967655161694, 6402.487800976004, 6402.583832050902, 6467.482601391972, 6475.061116138039, 6489.967550162219, 6339.5562310637815, 6367.840803979752, 6379.649119298483, 6465.515086368447, 6465.612063276219, 6392.264889537762, 6428.4214420702365, 6466.579672321284, 6483.2544257411, 6488.318726533646, 6200.224971878515, 6205.6586887721605, 6274.403931626488, 6278.497720182466, 6301.590396624205], "value": 5981.603622410469, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.3630886364315, 780.3250188586874, 794.0, 817.3706246190437, 822.0874828939876, 42192.36711449327, 42877.78561107198, 43320.13359732804, 43322.56677433225, 43382.13235735287, 39442.0, 39832.800835995855, 39907.80046099773, 39972.80013599935, 39984.80007599965, 6705.597664140155, 6815.31846815317, 6816.284290149537, 6822.079019332376, 6823.3858952694245, 6674.899876501856, 6732.764353247638, 6740.8314792130095, 6742.7640032598865, 6743.3256674332415, 6670.433013193884, 7292.489525733201, 7512.286332798375, 7513.323800857949, 7514.211007844179, 7415.629218539051, 7433.0337056182625, 7435.814104647373, 7439.925600743977, 7443.59060251686, 7211.819704507429, 7319.780406587811, 7452.366548843354, 7467.925320746777, 7469.290417410337, 40186.598134018575, 40230.798846005586, 40534.594654053675, 40535.7973210135, 40725.389119163236, 3413.6415676354122, 3446.7414943879307, 3466.9306613867834, 3477.6522347765276, 3477.8956631301103, 31552.526712099338, 31566.684333156605, 31656.525152122736, 31722.365552689047, 31795.84102079475, 4986.601071914238, 4988.276699878534, 5002.274670172841, 5004.899902001939, 5068.797248110071, 272631.0, 273745.0, 276016.0, 276997.0, 277179.0, 52192.478075218765, 52754.73622631862, 52862.20706689403, 52891.47108528943, 52932.47067529352, 55053.44946550483, 55265.72367138219, 55267.44732552623, 55283.44716552863, 55363.72318138464, 15311.0, 15640.921795391178, 15654.0, 15749.68500629981, 15756.60608484797, 12898.355082245851, 13030.348482576022, 13035.957123430102, 13058.151220170848, 13080.803787943189, 15087.396504139711, 15144.848551514564, 15226.390944362323, 15264.923675381775, 15438.768418473732, 6028.4272994065495, 6037.607555508878, 6055.6063855849225, 6249.437550620466, 6267.2792628847355, 1070.400575677623, 1075.9462026898623, 1076.650088721153, 1080.098118071419, 1096.5449338524581, 23911.7608823913, 24387.756122438903, 24441.755582444304, 24514.754852451602, 24619.87690061574, 1163.1857699610307, 1199.7420554580808, 1201.3212534917743, 1213.1023042948154, 1221.1268942706008, 12498.38013497216, 12870.456384285697, 12960.222386656831, 13016.674583135497, 13020.763027512372, 260682.0, 272610.0, 274781.0, 275057.0, 275524.0, 48008.0, 48839.75580122077, 54367.45632543624, 54381.0, 54870.0, 1546.4510098914948, 1551.9379224831107, 1560.087348900883, 1561.3364320163657, 1584.67514159597, 28265.57601635936, 28350.574741379307, 28355.291117722223, 29007.129786106452, 29693.85153074221, 53705.46294537161, 54289.45710543002, 54321.72839135779, 54326.45673543372, 54472.182917257065, 242478.0, 244554.0, 244982.0, 245297.0, 248592.0, 36651.45022824713, 36793.0, 36818.447723284706, 37022.8148859254, 37091.0, 48247.75876120597, 48953.755231223615, 49397.50602493929, 49422.50577494323, 49584.256236157205, 33385.0, 34955.47566786449, 35080.0, 35663.28673426465, 35744.0, 33403.83298083494, 33967.3206535863, 34891.30217395587, 35124.297514050086, 35361.82319088388, 40378.1924361517, 41179.38230926599, 41410.79294603508, 41889.58110418979, 42074.57925420706, 32762.180945476553, 33526.66473335236, 34013.48979765355, 34097.31805363829, 34509.0, 24592.262232133064, 25200.243992680247, 25327.0, 25711.228663140137, 25746.871265643553], "value": 18188.19700499508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7943560882469, 564.3481778545779, 571.4514066496164, 574.184657785944, 578.756922092721, 22758.88620556895, 22859.771402285973, 23644.527109457802, 23654.935527901263, 23675.5264894702, 23380.41548961277, 23569.528609427845, 23953.88023059882, 23997.40006499834, 24124.879375603097, 6341.239051313849, 6468.935310646881, 6480.319566445526, 6481.060246264289, 6487.318831522693, 6046.365131661179, 6351.872962540747, 6387.744490220385, 6392.7123279452535, 6399.968000160016, 6299.905501417483, 6309.495240380781, 6353.9682301588655, 6357.110004599337, 6359.745610175611, 6286.9056964145575, 6291.307956124822, 6345.270293916189, 6349.396807303298, 6352.650604216767, 5885.293764748215, 5907.911381329241, 5909.261342332208, 5911.0, 5915.970420147914, 29425.705742942726, 29940.251493712614, 30067.248318791986, 31310.0, 31680.0, 2216.1024784962115, 2249.6737972993988, 2256.8533045352, 2270.591293567157, 2271.375371772776, 18794.154263058193, 19718.605627887504, 19760.70358944617, 19775.307864224826, 20080.397588072236, 2363.243761996162, 2423.7455067217866, 2424.6363045543135, 2426.5389575980685, 2434.9269521914193, 151036.0, 155259.0, 157527.0, 157656.2117189418, 157803.0, 15169.24153792328, 15864.841351586336, 16023.19884005795, 16076.356945722275, 16090.275937582837, 23986.52026959451, 24045.398865028514, 24121.0, 24126.155584554457, 24173.51652966931, 10392.844107338396, 10557.63048293306, 10718.517666705016, 10782.299150555189, 10815.891841081488, 8555.914440855637, 8943.776405589912, 9739.56171972263, 9784.412935223909, 9924.206063515046, 9206.677766278148, 9553.570089345996, 9829.606815727291, 9932.751681207883, 9941.30410871232, 2707.986460067687, 2753.518134326485, 2831.844248566307, 2859.9428011439654, 2942.7204415580486, 1043.984340234897, 1049.228816819637, 1055.9049685528187, 1059.2267644619317, 1064.8509208710786, 21313.25403610866, 22396.0, 25516.744832551438, 26776.866115669298, 27081.45837083247, 1060.9045185933303, 1091.7652704668535, 1130.2032067392468, 1143.3368646185359, 1145.7937571237092, 11714.53568303962, 11733.647990560126, 11944.64166075019, 11993.34036627994, 12000.0, 581652.4739245754, 587461.0, 612108.0, 619184.0, 632890.0, 125130.0, 130370.0, 131216.0, 133655.0, 136598.31700841433, 1333.1401246196342, 1347.487954577274, 1366.7539842828387, 1375.7523645743863, 1385.764420048594, 17725.379611713528, 18681.719774203128, 19207.0, 22137.446563836034, 23311.650325244795, 63190.368096318445, 64593.0, 65305.67347163234, 65997.67001164964, 66995.3300466989, 76295.61852190703, 84352.0, 86561.0, 87339.0, 87602.0, 12947.158434701714, 13360.398782054637, 13845.653858653613, 15430.614234643775, 15644.608884777515, 24215.636765448886, 24254.63618045766, 24456.6331505024, 24493.877530612233, 24782.38044048913, 19862.404127876187, 20297.89851050735, 20421.591568168256, 20453.48866278355, 20558.691619626017, 16399.59001024936, 17384.0, 17531.651879174966, 17601.471955841345, 17968.550786230448, 20467.8976605116, 20581.89709051505, 20611.0, 20618.896905515376, 20695.8965205173, 14385.928070359581, 14972.550823475312, 15033.774493382389, 15106.848931510543, 15106.924465377602, 19034.33379831699, 19074.52313692169, 19234.422967311002, 19372.806271937665, 19510.12204450775], "value": 12661.247917036719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.768197088466, 1493.8879584031201, 1513.40220612858, 1538.923053847308, 1544.8722432624184, 14894.47869324574, 15203.923980380096, 15787.684246315066, 15838.762418563701, 15845.762313565307, 15825.762613560777, 16138.596535086628, 16164.595885102848, 16172.75740863888, 16199.1090490023, 2809.0, 2862.9284267893363, 2865.2980019895153, 2865.355295058616, 2866.7276608722136, 2728.0, 2805.0322638689618, 2810.775137988956, 2812.70466601007, 2817.0, 2743.231895069384, 2763.4196818668, 2778.88884444623, 2779.069011881022, 2779.680336761268, 2604.7785938195275, 2697.2447714639934, 2748.560230363152, 2748.7800975921878, 2751.2021513760988, 2549.171519256249, 2575.2016874768883, 2585.728498507667, 2587.236765154284, 2588.081231162929, 15177.772333415007, 15289.388424463008, 15296.847031529765, 15421.383144674199, 15519.379224831106, 8088.514689118613, 8400.41197116202, 8416.579171041485, 8416.579171041485, 8417.873731894026, 4871.147549178915, 5129.7435128243815, 5219.086659834514, 5228.241904923802, 5321.893562128775, 1696.4995326378626, 1713.3489274075896, 1722.1819635672955, 1748.2569907789266, 1754.175537497374, 27133.728662713514, 27366.589501157498, 27368.178954631392, 27386.589201161798, 27398.17805465839, 7466.0, 7475.514091584029, 7518.173000969889, 7787.29914307715, 7799.883001754978, 18591.34930277434, 18621.0, 18668.81331186698, 18711.251549938122, 18805.0, 8103.837923241502, 8239.0, 8245.0, 8253.8349233015, 8269.545175015312, 6367.7452901884335, 6710.698018589175, 6905.343992320722, 7637.885431718529, 7675.961620191863, 5248.711320877388, 5388.407275199725, 5408.486193811582, 5420.620556561003, 5497.257870187554, 1457.890658200618, 1459.5548357750988, 1470.2134358118356, 1476.3430273528177, 1490.3293517916982, 963.1668606655193, 980.2403137568441, 985.3693636072919, 988.8862780780303, 994.6618149829093, 7878.212178782191, 8135.0, 8175.5503447309775, 8353.958230208931, 8898.688545900863, 726.4696771356834, 741.4179868802963, 762.4624639629048, 764.7399884039453, 774.9767506974799, 4690.718556886598, 4772.49888761675, 4794.5924596409695, 4797.136515427187, 5022.824201152942, 20052.298169563994, 20797.688034679493, 21980.0, 22931.541369172523, 22943.0, 21354.0, 21470.57058858814, 21596.244131455325, 21602.243921462672, 21708.348749537538, 11371.943140284246, 11591.76816463666, 11867.703307417383, 11970.221935574335, 12100.455479503444, 8385.58072096405, 9280.62877484893, 9455.810883782147, 9547.761305967406, 9565.617375305188, 18843.340483083026, 19094.713579296043, 19160.520986975436, 19868.50328741793, 20042.0, 18813.341533046278, 19180.040997950327, 19793.505162371057, 19877.701834472784, 20455.386338409873, 11905.047596192457, 12115.212511186744, 12347.876521234673, 12428.067894907737, 12511.0, 13816.171029738249, 13879.0, 14004.579862604138, 14020.158790472604, 14027.158370497802, 11134.777304454028, 11627.360495172847, 11777.116716246144, 11928.284302941851, 11996.520139194683, 10827.945860270649, 11019.393933333744, 11160.162987775788, 11369.488373023069, 11427.542898283975, 10779.730506737395, 10923.399213043358, 10924.672259832218, 10935.945320273348, 10944.616938407118, 7669.1947345527915, 7880.921190788248, 7926.564038977912, 8006.559639219666, 8039.638216280398, 7901.209879012053, 8129.105798362294, 8131.7560473185895, 8206.917930820615, 8342.958285208535], "value": 6825.590776326788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.88417221952847, 500.2845930319644, 518.7769259218537, 522.1515038063147, 532.510090716541, 6079.300880398756, 6086.543509236814, 6115.496053551806, 6127.509799216064, 6137.140800287963, 5759.798407055754, 5916.408359164081, 5951.137085122655, 5971.880562388749, 6015.841683116355, 4699.248120300753, 4712.976435117836, 4716.151092803294, 4722.338872557844, 4733.822441676833, 4605.631549476051, 4670.859874203779, 4701.952980470186, 4738.241881298993, 4748.548887855648, 4619.445666520006, 4664.207084795576, 4682.391289132408, 4689.671722979393, 4713.976430117845, 4660.930086048712, 4688.859334219979, 4693.812247510078, 4713.175194340994, 4713.835015774465, 4290.635295999844, 4314.374415709736, 4336.588024137734, 4342.848000320006, 4359.215341238576, 5893.941060589382, 5982.312034116046, 5985.072313791369, 6007.399260074001, 6014.18808460861, 5562.276904002494, 5591.440855914376, 5614.073677843151, 5615.157726341082, 5629.887402251932, 6329.905051424233, 6359.141515895341, 6402.423781859655, 6403.327650596713, 6428.646424446653, 4809.326694262806, 4839.830605928775, 4856.902861942742, 4866.391701037371, 4878.243872199815, 6458.547901646886, 6515.4787616990525, 6565.212174539038, 6576.928267595692, 6593.769218077392, 4944.184209605447, 4996.200607902718, 5003.924941125886, 5004.149294619923, 5029.84910452687, 5029.446760856303, 5063.0, 5099.889067668719, 5103.719295438712, 5123.0, 5551.472610102034, 5579.637323574036, 5646.915296270559, 5655.765972440863, 5666.03677374839, 6170.629762214281, 6441.710123044474, 6473.190851143607, 6485.6108633482145, 6551.65691033337, 1697.5840918974684, 1716.7167417376243, 1736.5484973906875, 1744.1715185286887, 1745.8079611242754, 1052.6315789473622, 1204.8012078007207, 1227.34337129637, 1230.2987297240486, 1238.1456794811552, 6015.578909476382, 6078.902778541396, 6120.938790612036, 6125.816225513242, 6175.461036138435, 6478.0, 6515.967420162963, 6526.608403495806, 6577.506686998494, 6607.9669601651685, 6125.601835880653, 6182.319944806068, 6202.627842329474, 6205.193324867739, 6273.905891411632, 3447.9827600861836, 3474.0, 3487.4655151733664, 3531.1172206948263, 3542.628024057437, 6795.2185498667295, 6809.250982391933, 6844.531917338168, 6872.140982377203, 6959.269276725972, 6753.729850805913, 6776.272050627157, 6789.0, 6801.795946121624, 6845.349691779273, 6760.628165450849, 6813.2846051163915, 6829.556078854958, 6866.244713081557, 6878.58728476293, 6442.581232219891, 6479.352064793483, 6482.675866206765, 6592.274849766618, 6626.939689649633, 6512.251091124582, 6546.738130474728, 6563.9343606563325, 6585.209774827052, 6587.242467116343, 6827.48793840454, 6895.241523432318, 6926.619035953071, 6991.965040174767, 6998.440124790106, 4922.237053256751, 4937.518744376601, 4982.775775090057, 4998.2002879539095, 5003.424606170337, 6556.541042127005, 6602.8679426410245, 6650.3682150195655, 6684.6991885364305, 6700.229473610597, 6297.725182904956, 6395.264544577433, 6416.422521973045, 6424.678766061772, 6455.257645370654, 6373.0, 6397.168368112302, 6414.647194404352, 6459.967700161469, 6481.0232878972365, 6321.146645202839, 6332.525060620564, 6355.586886852339, 6404.231492220963, 6406.967965160145, 5916.112583112567, 6322.936770632235, 6423.751686909544, 6445.387688169616, 6491.28595854465, 6156.29202641702, 6261.7182226799, 6267.373262673878, 6282.2147231596055, 6309.779157729457], "value": 4994.052727047272, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.1990248581247, 921.4333185091168, 935.20974776314, 935.9344845860788, 945.418567580938, 17943.282268709252, 19074.523136921584, 19081.14134863933, 19118.617627647454, 21770.564588708257, 20771.792282077175, 21752.0, 21776.782232177673, 21994.670079948814, 21997.23009694661, 1032.334144476814, 1066.4507778494083, 1075.7418219627311, 1080.567772890842, 1081.3133660125798, 1012.7822518158595, 1071.7642118733866, 1081.5727787523924, 1082.8050950828847, 1087.3041253597703, 1157.8494795676593, 1158.4960542164144, 1159.269660114127, 1162.0993729859342, 1163.6625378640185, 1122.007023783953, 1129.0628778114146, 1131.7170707323169, 1133.7505748735266, 1135.9318440893533, 819.6229734322219, 820.2781552233996, 820.4748960665179, 824.114077366827, 825.2490233887133, 19319.613607727766, 19588.706169407327, 19718.605627887504, 19761.0, 20201.0, 20446.284380046774, 20681.793182068137, 21040.368788936357, 21227.68158477624, 21230.893845530674, 15632.92183539075, 16051.0, 16219.756703649455, 16243.350265989346, 16269.349226030945, 3563.55455568054, 3577.6422357764277, 3578.874739384135, 3586.1393265616325, 3589.28214357127, 136668.0, 140959.29520352435, 142355.0, 143455.28272358674, 146148.0, 14598.781018284733, 14727.705445891237, 14816.555503334917, 14908.105513669214, 14981.325840337211, 30991.845040774653, 31572.842135789633, 31729.20676983094, 31981.68018319787, 32047.679523204937, 8181.550014749246, 8621.870671939925, 8806.383553151218, 8975.057618950046, 9147.954260228656, 4504.774761261924, 4619.376384188159, 4632.374629424984, 4646.83736069236, 4662.323963025342, 5366.490183432567, 5471.960327537755, 5512.173174023928, 5536.889262214733, 5576.9163462548095, 1105.9944700276608, 1108.9001989820792, 1122.7529943412437, 1129.0346753525782, 1129.9830502542468, 676.5365724478747, 682.3858527325348, 691.9515633905578, 718.586812582767, 729.1541811498636, 12865.54970576044, 12920.612381628565, 13025.609231723063, 13292.20246785196, 13580.25308608036, 686.7424715731601, 701.1516065560627, 709.3722055980494, 715.0704084689986, 718.9712411503585, 5473.75368108436, 5572.637778544382, 5636.859078522988, 5642.943570564324, 5670.347909990404, 123481.38259308646, 129462.35268823596, 130278.34860825635, 131571.0, 133796.0, 111733.0, 112534.19194464614, 113289.0, 114642.4267878672, 116123.0, 90590.54704726566, 96523.51738241123, 96925.5153724241, 98655.50672246737, 100265.0, 13134.802977955529, 13201.537946172222, 13530.864691352961, 13909.374078166304, 14155.716885662436, 45224.095518090115, 45359.0, 47163.528364715916, 47599.28601070918, 47668.7616561915, 57040.71479642575, 59712.70143649254, 60136.39863601308, 62046.0, 63127.36872631399, 17210.225539850988, 17530.298788048334, 17719.734203986693, 17967.0, 18180.909095454437, 20700.0, 20962.895185523976, 21030.369088927357, 21143.8942805285, 21378.144874204856, 20061.398158055283, 20159.39521814348, 20309.79690203079, 20531.17875284972, 20787.0, 19510.512237194183, 19523.70714439256, 19674.21303147858, 19742.0, 19902.90048549806, 19458.902705486384, 19648.312309069115, 20376.898115509328, 20550.38348849537, 21125.366239012856, 14084.436622534984, 14213.0, 14357.928210358881, 14521.636959076108, 14806.333714983068, 14541.127532348093, 14823.481178158712, 15603.141827199614, 15890.920545397199, 16216.837831621533], "value": 9624.148745453957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 102.0, 109.0, 108.0, 109.0, 111.0, 101.0, 108.0, 110.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 119.0, 138.0, 174.0, 114.0, 144.0, 140.0, 114.0, 164.0, 122.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 163.0, 162.0, 161.0, 170.0, 165.0, 166.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 107.0, 76.0, 74.0, 76.0, 90.0, 102.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 139.0, 82.0, 80.0, 81.0, 131.0, 81.0, 80.0, 129.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 117.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 151.0, 147.0, 148.0, 149.0, 148.0, 147.0, 149.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 48.0, 47.0, 50.0, 48.0, 49.0, 47.0, 47.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 59.0, 53.0, 53.0, 54.0, 52.0, 53.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 75.0, 75.0, 75.0, 75.0, 91.0, 75.0, 75.0, 77.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 128.0, 125.0, 130.0, 124.0, 119.0, 124.0, 133.0, 125.0, 163.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 163.0, 164.0, 173.0, 171.0, 172.0, 165.0, 163.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 67.0, 62.0, 62.0, 62.0, 63.0, 67.0, 61.0], "value": 63.2, "unit": "score"}]}]} 05:48:25 INFO - Return code: 0 05:48:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:25 INFO - # TBPL SUCCESS # 05:48:25 INFO - Running post-action listener: _package_coverage_data 05:48:25 INFO - Running post-action listener: _resource_record_post_action 05:48:25 INFO - [mozharness: 2017-07-20 12:48:25.936472Z] Finished run-tests step (success) 05:48:25 INFO - Running post-run listener: _resource_record_post_run 05:48:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 430022656; Read time: 0; Write time: 612048 05:48:26 INFO - TinderboxPrint: CPU usage
13.1% 05:48:26 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:48:26 INFO - TinderboxPrint: I/O write bytes / time
430,022,656 / 612,048 05:48:26 INFO - TinderboxPrint: CPU idle
8,255.6 (86.9%) 05:48:26 INFO - TinderboxPrint: CPU user
1,191.1 (12.5%) 05:48:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:48:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108843008; Read time: 0; Write time: 210056 05:48:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:48:26 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 321179648; Read time: 0; Write time: 401992 05:48:26 INFO - Running post-run listener: _upload_blobber_files 05:48:26 INFO - Blob upload gear active. 05:48:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:48:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:48:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:48:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:48:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:48:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:27 INFO - (blobuploader) - INFO - Done attempting. 05:48:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:48:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:48:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:28 INFO - (blobuploader) - INFO - Done attempting. 05:48:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:48:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:48:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:29 INFO - (blobuploader) - INFO - Done attempting. 05:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:33 INFO - (blobuploader) - INFO - Done attempting. 05:48:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:33 INFO - Return code: 0 05:48:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8047a8245c90c273f501c680e3c4d04e99a9eabb3232e5180dfa6897583b2e5717b3665a325143f8610b06cfe5a44c0bbab1837ce416b2872a6fb4d2cab670", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66807cded84a8503b0bdceb7f45cde1b06746cceff1da27c51ffdcb22464b4325620713009cb66bd0eaf0dbb80fe8056504d3ce83ba96521ffd42b9b31ec8226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b839a2e878b292277d351113f90f38fda4a8a120943002fa602f8104ec54f33df3835f885fa6340ab0e8d8de9e7fe6736f84f4decef98d5ddf4bd63a6a73e681", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139368a56e062a2f45421929f33630f5f1f6be9e5774a964bfa2f5ff5f898a065bb2662f26c80e59c26bcbcd8d5511e43011f3dbaf8291ac2d42274e13ad191d"} 05:48:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:33 INFO - Contents: 05:48:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8047a8245c90c273f501c680e3c4d04e99a9eabb3232e5180dfa6897583b2e5717b3665a325143f8610b06cfe5a44c0bbab1837ce416b2872a6fb4d2cab670", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66807cded84a8503b0bdceb7f45cde1b06746cceff1da27c51ffdcb22464b4325620713009cb66bd0eaf0dbb80fe8056504d3ce83ba96521ffd42b9b31ec8226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b839a2e878b292277d351113f90f38fda4a8a120943002fa602f8104ec54f33df3835f885fa6340ab0e8d8de9e7fe6736f84f4decef98d5ddf4bd63a6a73e681", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139368a56e062a2f45421929f33630f5f1f6be9e5774a964bfa2f5ff5f898a065bb2662f26c80e59c26bcbcd8d5511e43011f3dbaf8291ac2d42274e13ad191d"} 05:48:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:33 INFO - Copying logs to upload dir... 05:48:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.611847 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-07-20 05:48:33.077523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 05:48:33.081079) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8047a8245c90c273f501c680e3c4d04e99a9eabb3232e5180dfa6897583b2e5717b3665a325143f8610b06cfe5a44c0bbab1837ce416b2872a6fb4d2cab670", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66807cded84a8503b0bdceb7f45cde1b06746cceff1da27c51ffdcb22464b4325620713009cb66bd0eaf0dbb80fe8056504d3ce83ba96521ffd42b9b31ec8226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b839a2e878b292277d351113f90f38fda4a8a120943002fa602f8104ec54f33df3835f885fa6340ab0e8d8de9e7fe6736f84f4decef98d5ddf4bd63a6a73e681", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139368a56e062a2f45421929f33630f5f1f6be9e5774a964bfa2f5ff5f898a065bb2662f26c80e59c26bcbcd8d5511e43011f3dbaf8291ac2d42274e13ad191d"} build_url:https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/H7H_GZpQRVWqGOEfUjVfmw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8047a8245c90c273f501c680e3c4d04e99a9eabb3232e5180dfa6897583b2e5717b3665a325143f8610b06cfe5a44c0bbab1837ce416b2872a6fb4d2cab670", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66807cded84a8503b0bdceb7f45cde1b06746cceff1da27c51ffdcb22464b4325620713009cb66bd0eaf0dbb80fe8056504d3ce83ba96521ffd42b9b31ec8226", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b839a2e878b292277d351113f90f38fda4a8a120943002fa602f8104ec54f33df3835f885fa6340ab0e8d8de9e7fe6736f84f4decef98d5ddf4bd63a6a73e681", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/139368a56e062a2f45421929f33630f5f1f6be9e5774a964bfa2f5ff5f898a065bb2662f26c80e59c26bcbcd8d5511e43011f3dbaf8291ac2d42274e13ad191d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 05:48:33.105824) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:48:33.106153) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500553595.500719-1004261611 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 05:48:33.190695) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 05:48:33.191022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 05:48:33.191342) ========= ========= Total master_lag: 0.17 =========