builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1499256949.25 results: success (0) revision: 211d4dd61025c0a40caea7a54c9066e051bdde8c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.254390) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.254778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.255044) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.297689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.297945) ========= 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=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-05 05:15:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-07-05 05:15:49 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.250745 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.593274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.593634) ========= 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=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018910 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:49.643478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 05:15:49.643816) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 211d4dd61025c0a40caea7a54c9066e051bdde8c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 211d4dd61025c0a40caea7a54c9066e051bdde8c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-05 05:15:50,018 truncating revision to first 12 chars 2017-07-05 05:15:50,018 Setting DEBUG logging. 2017-07-05 05:15:50,018 attempt 1/10 2017-07-05 05:15:50,018 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/211d4dd61025?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-05 05:15:51,409 unpacking tar archive at: mozilla-central-211d4dd61025/testing/mozharness/ program finished with exit code 0 elapsedTime=1.699744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-05 05:15:51.361640) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:51.361941) ========= script_repo_revision: 211d4dd61025c0a40caea7a54c9066e051bdde8c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:51.362317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:51.362637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-05 05:15:51.373225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-05 05:15:51.373618) ========= /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=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:15:51 INFO - MultiFileLogger online at 20170705 05:15:51 in /builds/slave/test 05:15:51 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:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:51 INFO - {'append_to_log': False, 05:15:51 INFO - 'base_work_dir': '/builds/slave/test', 05:15:51 INFO - 'blob_upload_branch': 'Firefox', 05:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:51 INFO - 'branch': 'Firefox', 05:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:51 INFO - 'code_coverage': False, 05:15:51 INFO - 'config_files': ('talos/linux_config.py',), 05:15:51 INFO - 'default_actions': ('clobber', 05:15:51 INFO - 'read-buildbot-config', 05:15:51 INFO - 'download-and-extract', 05:15:51 INFO - 'populate-webroot', 05:15:51 INFO - 'create-virtualenv', 05:15:51 INFO - 'install', 05:15:51 INFO - 'setup-mitmproxy', 05:15:51 INFO - 'run-tests'), 05:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:51 INFO - 'disable_ccov_upload': False, 05:15:51 INFO - 'download_minidump_stackwalk': True, 05:15:51 INFO - 'download_symbols': 'ondemand', 05:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:51 INFO - 'gecko_profile': False, 05:15:51 INFO - 'gecko_profile_interval': 0, 05:15:51 INFO - 'installer_path': 'installer.exe', 05:15:51 INFO - 'log_level': 'info', 05:15:51 INFO - 'log_name': 'talos', 05:15:51 INFO - 'log_to_console': True, 05:15:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:15:51 INFO - 'opt_config_files': (), 05:15:51 INFO - 'pip_index': False, 05:15:51 INFO - 'suite': 'dromaeojs-e10s', 05:15:51 INFO - 'system_bits': '32', 05:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:51 INFO - 'title': 'talos-linux64-ix-047', 05:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:51 INFO - 'use_talos_json': True, 05:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:51 INFO - 'work_dir': 'build'} 05:15:51 INFO - [mozharness: 2017-07-05 12:15:51.929834Z] Running clobber step. 05:15:51 INFO - Running pre-action listener: _resource_record_pre_action 05:15:51 INFO - Running main action method: clobber 05:15:51 INFO - rmtree: /builds/slave/test/build 05:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:52 INFO - Running post-action listener: _resource_record_post_action 05:15:52 INFO - [mozharness: 2017-07-05 12:15:52.920502Z] Finished clobber step (success) 05:15:52 INFO - [mozharness: 2017-07-05 12:15:52.920604Z] Running read-buildbot-config step. 05:15:52 INFO - Running pre-action listener: _resource_record_pre_action 05:15:52 INFO - Running main action method: read_buildbot_config 05:15:52 INFO - Using buildbot properties: 05:15:52 INFO - { 05:15:52 INFO - "project": "", 05:15:52 INFO - "product": "firefox", 05:15:52 INFO - "who": "cbook@mozilla.com", 05:15:52 INFO - "installer_path": "public/build/target.tar.bz2", 05:15:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:15:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:15:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:15:52 INFO - "stage_platform": "linux64-pgo", 05:15:52 INFO - "basedir": "/builds/slave/test", 05:15:52 INFO - "buildnumber": 47, 05:15:52 INFO - "platform": "ubuntu64_hw", 05:15:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:15:52 INFO - "slavebuilddir": "test", 05:15:52 INFO - "taskId": "R6Iq59m5TCOpHdbrhA4nFQ", 05:15:52 INFO - "branch": "mozilla-central", 05:15:52 INFO - "script_repo_revision": "production", 05:15:52 INFO - "revision": "211d4dd61025c0a40caea7a54c9066e051bdde8c", 05:15:52 INFO - "slavename": "talos-linux64-ix-047", 05:15:52 INFO - "repo_path": "mozilla-central" 05:15:52 INFO - } 05:15:52 INFO - Finding installer, test and symbols from parent task. 05:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6Iq59m5TCOpHdbrhA4nFQ'}, attempt #1 05:15:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R6Iq59m5TCOpHdbrhA4nFQ'}, attempt #1 05:15:53 INFO - Task dependencies: V7W_LOs0SyCVuX49DYd0eQ 05:15:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ'}, attempt #1 05:15:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 05:15:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/test_packages.json 05:15:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.crashreporter-symbols.zip 05:15:54 INFO - Running post-action listener: _resource_record_post_action 05:15:54 INFO - [mozharness: 2017-07-05 12:15:54.288407Z] Finished read-buildbot-config step (success) 05:15:54 INFO - [mozharness: 2017-07-05 12:15:54.288629Z] Running download-and-extract step. 05:15:54 INFO - Running pre-action listener: _resource_record_pre_action 05:15:54 INFO - Running main action method: download_and_extract 05:15:54 INFO - mkdir: /builds/slave/test/build/tests 05:15:54 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:15:54 INFO - trying https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.test_packages.json 05:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:15:54 INFO - Downloaded 989 bytes. 05:15:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:15:54 INFO - Using the following test package requirements: 05:15:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:15:54 INFO - u'common': [u'target.common.tests.zip'], 05:15:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:15:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:15:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:15:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:15:54 INFO - u'mozbase': [u'target.common.tests.zip'], 05:15:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:15:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:15:54 INFO - u'web-platform': [u'target.common.tests.zip', 05:15:54 INFO - u'target.web-platform.tests.tar.gz'], 05:15:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:15:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:15:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip 05:15:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:15:54 INFO - Fetch https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip into memory 05:16:05 INFO - Content-Length response header: 68040330 05:16:05 INFO - Bytes received: 68040330 05:16:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:16:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip 05:16:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:16:16 INFO - Fetch https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.common.tests.zip into memory 05:16:17 INFO - Content-Length response header: 68040330 05:16:17 INFO - Bytes received: 68040330 05:16:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.talos.tests.zip 05:16:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:16:30 INFO - Fetch https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.talos.tests.zip into memory 05:16:31 INFO - Content-Length response header: 14472293 05:16:31 INFO - Bytes received: 14472293 05:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:31 INFO - trying https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 05:16:31 INFO - Downloading https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:16:32 INFO - Downloaded 62929170 bytes. 05:16:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 05:16:32 INFO - mkdir: /builds/slave/test/properties 05:16:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:32 INFO - Contents: 05:16:32 INFO - build_url:https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 05:16:32 INFO - Running post-action listener: _resource_record_post_action 05:16:32 INFO - Running post-action listener: set_extra_try_arguments 05:16:32 INFO - [mozharness: 2017-07-05 12:16:32.875141Z] Finished download-and-extract step (success) 05:16:32 INFO - [mozharness: 2017-07-05 12:16:32.875239Z] Running populate-webroot step. 05:16:32 INFO - Running pre-action listener: _resource_record_pre_action 05:16:32 INFO - Running main action method: populate_webroot 05:16:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:32 INFO - '--tppagecycles', 05:16:32 INFO - '7'], 05:16:32 INFO - 'tests': ['tsvgm']}}, 05:16:32 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['damp', 'tps']}, 05:16:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'tests': ['damp', 'tps']}, 05:16:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['dromaeo_dom']}, 05:16:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:16:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:16:32 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:16:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_many_windows', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_many_windows', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_many_windows', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['a11yr', 05:16:32 INFO - 'ts_paint', 05:16:32 INFO - 'tpaint', 05:16:32 INFO - 'sessionrestore', 05:16:32 INFO - 'sessionrestore_no_auto_restore', 05:16:32 INFO - 'tabpaint']}, 05:16:32 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:16:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:16:32 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:16:32 INFO - 'talos_options': ['--mitmproxy', 05:16:32 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:16:32 INFO - '--firstNonBlankPaint'], 05:16:32 INFO - 'tests': ['quantum_pageload_google', 05:16:32 INFO - 'quantum_pageload_youtube', 05:16:32 INFO - 'quantum_pageload_amazon', 05:16:32 INFO - 'quantum_pageload_facebook']}, 05:16:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['tsvgx', 05:16:32 INFO - 'tsvgr_opacity', 05:16:32 INFO - 'tart', 05:16:32 INFO - 'tscrollx', 05:16:32 INFO - 'cart', 05:16:32 INFO - 'tsvg_static']}, 05:16:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:32 INFO - 'tsvgr_opacity', 05:16:32 INFO - 'tart', 05:16:32 INFO - 'tscrollx', 05:16:32 INFO - 'cart', 05:16:32 INFO - 'tsvg_static']}, 05:16:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'talos_options': ['--disable-e10s'], 05:16:32 INFO - 'tests': ['tp5o']}, 05:16:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:16:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'talos_options': ['--disable-e10s', 05:16:32 INFO - '--xperf_path', 05:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:32 INFO - 'tests': ['tp5n']}, 05:16:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:16:32 INFO - 'talos_options': ['--xperf_path', 05:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:32 INFO - 'tests': ['tp5n']}}, 05:16:32 INFO - 'talos.zip': {'path': '', 05:16:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:32 INFO - Running post-action listener: _resource_record_post_action 05:16:32 INFO - [mozharness: 2017-07-05 12:16:32.890354Z] Finished populate-webroot step (success) 05:16:32 INFO - [mozharness: 2017-07-05 12:16:32.890445Z] Running create-virtualenv step. 05:16:32 INFO - Running pre-action listener: _resource_record_pre_action 05:16:32 INFO - Running main action method: create_virtualenv 05:16:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:32 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:16:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:32 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:16:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:33 INFO - Using real prefix '/usr' 05:16:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:35 INFO - Installing pip.................done. 05:16:35 INFO - Return code: 0 05:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:16:35 INFO - Reading from file tmpfile_stdout 05:16:35 INFO - Output received: 05:16:35 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:16:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:35 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:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:35 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:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:35 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:35 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:16:35 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:16:35 INFO - Using env: {'DISPLAY': ':0', 05:16:35 INFO - 'HOME': '/home/cltbld', 05:16:35 INFO - 'LANG': 'en_US.UTF-8', 05:16:35 INFO - 'LANGUAGE': 'en_US:en', 05:16:35 INFO - 'LOGNAME': 'cltbld', 05:16:35 INFO - 'MAIL': '/var/mail/cltbld', 05:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:35 INFO - 'MOZ_NO_REMOTE': '1', 05:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:35 INFO - 'NO_EM_RESTART': '1', 05:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:35 INFO - 'PWD': '/builds/slave/test', 05:16:35 INFO - 'SHELL': '/bin/bash', 05:16:35 INFO - 'SHLVL': '1', 05:16:35 INFO - 'TERM': 'linux', 05:16:35 INFO - 'TMOUT': '86400', 05:16:35 INFO - 'USER': 'cltbld', 05:16:35 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:35 INFO - '_': '/tools/buildbot/bin/python'} 05:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:36 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:16:36 INFO - Cleaning up... 05:16:36 INFO - Return code: 0 05:16:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:16:36 INFO - Using env: {'DISPLAY': ':0', 05:16:36 INFO - 'HOME': '/home/cltbld', 05:16:36 INFO - 'LANG': 'en_US.UTF-8', 05:16:36 INFO - 'LANGUAGE': 'en_US:en', 05:16:36 INFO - 'LOGNAME': 'cltbld', 05:16:36 INFO - 'MAIL': '/var/mail/cltbld', 05:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:36 INFO - 'MOZ_NO_REMOTE': '1', 05:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:36 INFO - 'NO_EM_RESTART': '1', 05:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:36 INFO - 'PWD': '/builds/slave/test', 05:16:36 INFO - 'SHELL': '/bin/bash', 05:16:36 INFO - 'SHLVL': '1', 05:16:36 INFO - 'TERM': 'linux', 05:16:36 INFO - 'TMOUT': '86400', 05:16:36 INFO - 'USER': 'cltbld', 05:16:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:36 INFO - '_': '/tools/buildbot/bin/python'} 05:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:36 INFO - Downloading/unpacking psutil>=3.1.1 05:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:37 INFO - Installing collected packages: psutil 05:16:37 INFO - Running setup.py install for psutil 05:16:37 INFO - building 'psutil._psutil_linux' extension 05:16:37 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:16:38 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:16:38 INFO - building 'psutil._psutil_posix' extension 05:16:38 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:16:38 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:16:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:38 INFO - Successfully installed psutil 05:16:38 INFO - Cleaning up... 05:16:38 INFO - Return code: 0 05:16:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:38 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:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:38 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:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:38 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:38 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:16:38 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:16:38 INFO - Using env: {'DISPLAY': ':0', 05:16:38 INFO - 'HOME': '/home/cltbld', 05:16:38 INFO - 'LANG': 'en_US.UTF-8', 05:16:38 INFO - 'LANGUAGE': 'en_US:en', 05:16:38 INFO - 'LOGNAME': 'cltbld', 05:16:38 INFO - 'MAIL': '/var/mail/cltbld', 05:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:38 INFO - 'MOZ_NO_REMOTE': '1', 05:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:38 INFO - 'NO_EM_RESTART': '1', 05:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:38 INFO - 'PWD': '/builds/slave/test', 05:16:38 INFO - 'SHELL': '/bin/bash', 05:16:38 INFO - 'SHLVL': '1', 05:16:38 INFO - 'TERM': 'linux', 05:16:38 INFO - 'TMOUT': '86400', 05:16:38 INFO - 'USER': 'cltbld', 05:16:38 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:38 INFO - '_': '/tools/buildbot/bin/python'} 05:16:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16:39 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:16:39 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:16:39 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:16:39 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:16:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:40 INFO - Installing collected packages: mozsystemmonitor 05:16:40 INFO - Running setup.py install for mozsystemmonitor 05:16:40 INFO - Successfully installed mozsystemmonitor 05:16:40 INFO - Cleaning up... 05:16:40 INFO - Return code: 0 05:16:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:40 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:40 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:16:40 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:16:40 INFO - Using env: {'DISPLAY': ':0', 05:16:40 INFO - 'HOME': '/home/cltbld', 05:16:40 INFO - 'LANG': 'en_US.UTF-8', 05:16:40 INFO - 'LANGUAGE': 'en_US:en', 05:16:40 INFO - 'LOGNAME': 'cltbld', 05:16:40 INFO - 'MAIL': '/var/mail/cltbld', 05:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:40 INFO - 'MOZ_NO_REMOTE': '1', 05:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:40 INFO - 'NO_EM_RESTART': '1', 05:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:40 INFO - 'PWD': '/builds/slave/test', 05:16:40 INFO - 'SHELL': '/bin/bash', 05:16:40 INFO - 'SHLVL': '1', 05:16:40 INFO - 'TERM': 'linux', 05:16:40 INFO - 'TMOUT': '86400', 05:16:40 INFO - 'USER': 'cltbld', 05:16:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:40 INFO - '_': '/tools/buildbot/bin/python'} 05:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:40 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:16:40 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:16:40 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:16:40 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:16:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:41 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:16:41 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:16:41 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:16:41 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:16:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:41 INFO - warning: no files found matching '*.txt' 05:16:41 INFO - no previously-included directories found matching 'build' 05:16:41 INFO - no previously-included directories found matching 'dist' 05:16:41 INFO - no previously-included directories found matching '.git*' 05:16:41 INFO - Installing collected packages: jsonschema, functools32 05:16:41 INFO - Running setup.py install for functools32 05:16:42 INFO - warning: no files found matching '*.txt' 05:16:42 INFO - no previously-included directories found matching 'build' 05:16:42 INFO - no previously-included directories found matching 'dist' 05:16:42 INFO - no previously-included directories found matching '.git*' 05:16:42 INFO - Successfully installed jsonschema functools32 05:16:42 INFO - Cleaning up... 05:16:42 INFO - Return code: 0 05:16:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:42 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:42 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:16:42 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:16:42 INFO - Using env: {'DISPLAY': ':0', 05:16:42 INFO - 'HOME': '/home/cltbld', 05:16:42 INFO - 'LANG': 'en_US.UTF-8', 05:16:42 INFO - 'LANGUAGE': 'en_US:en', 05:16:42 INFO - 'LOGNAME': 'cltbld', 05:16:42 INFO - 'MAIL': '/var/mail/cltbld', 05:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:42 INFO - 'MOZ_NO_REMOTE': '1', 05:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:42 INFO - 'NO_EM_RESTART': '1', 05:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:42 INFO - 'PWD': '/builds/slave/test', 05:16:42 INFO - 'SHELL': '/bin/bash', 05:16:42 INFO - 'SHLVL': '1', 05:16:42 INFO - 'TERM': 'linux', 05:16:42 INFO - 'TMOUT': '86400', 05:16:42 INFO - 'USER': 'cltbld', 05:16:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:42 INFO - '_': '/tools/buildbot/bin/python'} 05:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:42 INFO - Cleaning up... 05:16:42 INFO - Return code: 0 05:16:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:42 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:42 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:16:42 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:16:42 INFO - Using env: {'DISPLAY': ':0', 05:16:42 INFO - 'HOME': '/home/cltbld', 05:16:42 INFO - 'LANG': 'en_US.UTF-8', 05:16:42 INFO - 'LANGUAGE': 'en_US:en', 05:16:42 INFO - 'LOGNAME': 'cltbld', 05:16:42 INFO - 'MAIL': '/var/mail/cltbld', 05:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:42 INFO - 'MOZ_NO_REMOTE': '1', 05:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:42 INFO - 'NO_EM_RESTART': '1', 05:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:42 INFO - 'PWD': '/builds/slave/test', 05:16:42 INFO - 'SHELL': '/bin/bash', 05:16:42 INFO - 'SHLVL': '1', 05:16:42 INFO - 'TERM': 'linux', 05:16:42 INFO - 'TMOUT': '86400', 05:16:42 INFO - 'USER': 'cltbld', 05:16:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:42 INFO - '_': '/tools/buildbot/bin/python'} 05:16:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:42 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:16:42 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:16:42 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:16:42 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:16:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:44 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:16:44 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:16:44 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:16:44 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:16:44 INFO - Downloading docopt-0.6.1.tar.gz 05:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:44 INFO - Running setup.py install for blobuploader 05:16:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:44 INFO - Running setup.py install for requests 05:16:44 INFO - Running setup.py install for docopt 05:16:44 INFO - Successfully installed blobuploader requests docopt 05:16:44 INFO - Cleaning up... 05:16:44 INFO - Return code: 0 05:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:44 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:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:44 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:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:44 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:44 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:16:44 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:16:44 INFO - Using env: {'DISPLAY': ':0', 05:16:44 INFO - 'HOME': '/home/cltbld', 05:16:44 INFO - 'LANG': 'en_US.UTF-8', 05:16:44 INFO - 'LANGUAGE': 'en_US:en', 05:16:44 INFO - 'LOGNAME': 'cltbld', 05:16:44 INFO - 'MAIL': '/var/mail/cltbld', 05:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:44 INFO - 'MOZ_NO_REMOTE': '1', 05:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:44 INFO - 'NO_EM_RESTART': '1', 05:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:44 INFO - 'PWD': '/builds/slave/test', 05:16:44 INFO - 'SHELL': '/bin/bash', 05:16:44 INFO - 'SHLVL': '1', 05:16:44 INFO - 'TERM': 'linux', 05:16:44 INFO - 'TMOUT': '86400', 05:16:44 INFO - 'USER': 'cltbld', 05:16:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:44 INFO - '_': '/tools/buildbot/bin/python'} 05:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:45 INFO - Running setup.py (path:/tmp/pip-yiFio5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:45 INFO - Running setup.py (path:/tmp/pip-X4Ylm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:45 INFO - Running setup.py (path:/tmp/pip-z1ZeK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:45 INFO - Running setup.py (path:/tmp/pip-c7xaDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:45 INFO - Running setup.py (path:/tmp/pip-MwUcLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:45 INFO - Running setup.py (path:/tmp/pip-Veh1mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:45 INFO - Running setup.py (path:/tmp/pip-jE5oFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:45 INFO - Running setup.py (path:/tmp/pip-mb0nEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:45 INFO - Running setup.py (path:/tmp/pip-DAbFta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:45 INFO - Running setup.py (path:/tmp/pip-k4hN8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:45 INFO - Running setup.py (path:/tmp/pip-QZmyLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:45 INFO - Running setup.py (path:/tmp/pip-eJFDnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:45 INFO - Running setup.py (path:/tmp/pip-IuT8vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:46 INFO - Running setup.py (path:/tmp/pip-OXAK__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:46 INFO - Running setup.py (path:/tmp/pip-PxIl3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:46 INFO - Running setup.py (path:/tmp/pip-SCYAi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:46 INFO - Running setup.py (path:/tmp/pip-uRMbCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:46 INFO - Running setup.py install for manifestparser 05:16:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:46 INFO - Running setup.py install for mozcrash 05:16:46 INFO - Running setup.py install for mozdebug 05:16:46 INFO - Running setup.py install for mozdevice 05:16:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:46 INFO - Running setup.py install for mozfile 05:16:46 INFO - Running setup.py install for mozhttpd 05:16:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:46 INFO - Running setup.py install for mozinfo 05:16:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:46 INFO - Running setup.py install for mozInstall 05:16:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Running setup.py install for mozleak 05:16:47 INFO - Running setup.py install for mozlog 05:16:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Running setup.py install for moznetwork 05:16:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Running setup.py install for mozprocess 05:16:47 INFO - Running setup.py install for mozprofile 05:16:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Running setup.py install for mozrunner 05:16:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:47 INFO - Running setup.py install for mozscreenshot 05:16:47 INFO - Running setup.py install for moztest 05:16:47 INFO - Running setup.py install for mozversion 05:16:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:48 INFO - Cleaning up... 05:16:48 INFO - Return code: 0 05:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:48 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:48 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:16:48 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:16:48 INFO - Using env: {'DISPLAY': ':0', 05:16:48 INFO - 'HOME': '/home/cltbld', 05:16:48 INFO - 'LANG': 'en_US.UTF-8', 05:16:48 INFO - 'LANGUAGE': 'en_US:en', 05:16:48 INFO - 'LOGNAME': 'cltbld', 05:16:48 INFO - 'MAIL': '/var/mail/cltbld', 05:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:48 INFO - 'MOZ_NO_REMOTE': '1', 05:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:48 INFO - 'NO_EM_RESTART': '1', 05:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:48 INFO - 'PWD': '/builds/slave/test', 05:16:48 INFO - 'SHELL': '/bin/bash', 05:16:48 INFO - 'SHLVL': '1', 05:16:48 INFO - 'TERM': 'linux', 05:16:48 INFO - 'TMOUT': '86400', 05:16:48 INFO - 'USER': 'cltbld', 05:16:48 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:48 INFO - '_': '/tools/buildbot/bin/python'} 05:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:48 INFO - Running setup.py (path:/tmp/pip-CtkX1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:48 INFO - Running setup.py (path:/tmp/pip-CNL1Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:48 INFO - Running setup.py (path:/tmp/pip-hIcnma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:48 INFO - Running setup.py (path:/tmp/pip-kAAoiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:48 INFO - Running setup.py (path:/tmp/pip-U2BbHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:48 INFO - Running setup.py (path:/tmp/pip-dp_g2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:48 INFO - Running setup.py (path:/tmp/pip-z4A2RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:48 INFO - Running setup.py (path:/tmp/pip-w1vEX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:48 INFO - Running setup.py (path:/tmp/pip-sHqS54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:48 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:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:48 INFO - Running setup.py (path:/tmp/pip-ZRPuf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:49 INFO - Running setup.py (path:/tmp/pip-_gRL0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:49 INFO - Running setup.py (path:/tmp/pip-G5BbUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:49 INFO - Running setup.py (path:/tmp/pip-AqOSMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:49 INFO - Running setup.py (path:/tmp/pip-X74qUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:49 INFO - Running setup.py (path:/tmp/pip-ilmmbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:49 INFO - Running setup.py (path:/tmp/pip-O97MYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:49 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:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:49 INFO - Running setup.py (path:/tmp/pip-Oh3_Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:49 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:16:49 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:16:49 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:16:49 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:16:49 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:16:49 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:16:49 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:16:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:49 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:16:49 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:16:49 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:16:49 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:16:50 INFO - Downloading blessings-1.6.tar.gz 05:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:50 INFO - Installing collected packages: blessings 05:16:50 INFO - Running setup.py install for blessings 05:16:50 INFO - Successfully installed blessings 05:16:50 INFO - Cleaning up... 05:16:50 INFO - Return code: 0 05:16:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:51 INFO - Reading from file tmpfile_stdout 05:16:51 INFO - Current package versions: 05:16:51 INFO - argparse == 1.2.1 05:16:51 INFO - blessings == 1.6 05:16:51 INFO - blobuploader == 1.2.4 05:16:51 INFO - docopt == 0.6.1 05:16:51 INFO - functools32 == 3.2.3-2 05:16:51 INFO - jsonschema == 2.5.1 05:16:51 INFO - manifestparser == 1.1 05:16:51 INFO - mozInstall == 1.13 05:16:51 INFO - mozcrash == 1.0 05:16:51 INFO - mozdebug == 0.1 05:16:51 INFO - mozdevice == 0.51 05:16:51 INFO - mozfile == 1.2 05:16:51 INFO - mozhttpd == 0.7 05:16:51 INFO - mozinfo == 0.10 05:16:51 INFO - mozleak == 0.1 05:16:51 INFO - mozlog == 3.5 05:16:51 INFO - moznetwork == 0.27 05:16:51 INFO - mozprocess == 0.25 05:16:51 INFO - mozprofile == 0.28 05:16:51 INFO - mozrunner == 6.13 05:16:51 INFO - mozscreenshot == 0.1 05:16:51 INFO - mozsystemmonitor == 0.3 05:16:51 INFO - moztest == 0.8 05:16:51 INFO - mozversion == 1.4 05:16:51 INFO - psutil == 3.1.1 05:16:51 INFO - requests == 1.2.3 05:16:51 INFO - wsgiref == 0.1.2 05:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:51 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:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:51 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:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:51 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:51 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:16:51 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:16:51 INFO - Using env: {'DISPLAY': ':0', 05:16:51 INFO - 'HOME': '/home/cltbld', 05:16:51 INFO - 'LANG': 'en_US.UTF-8', 05:16:51 INFO - 'LANGUAGE': 'en_US:en', 05:16:51 INFO - 'LOGNAME': 'cltbld', 05:16:51 INFO - 'MAIL': '/var/mail/cltbld', 05:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:51 INFO - 'MOZ_NO_REMOTE': '1', 05:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:51 INFO - 'NO_EM_RESTART': '1', 05:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:51 INFO - 'PWD': '/builds/slave/test', 05:16:51 INFO - 'SHELL': '/bin/bash', 05:16:51 INFO - 'SHLVL': '1', 05:16:51 INFO - 'TERM': 'linux', 05:16:51 INFO - 'TMOUT': '86400', 05:16:51 INFO - 'USER': 'cltbld', 05:16:51 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:51 INFO - '_': '/tools/buildbot/bin/python'} 05:16:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 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:16:51 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:16:51 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:16:51 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:16:51 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:16:51 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:16:52 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:16:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:16:52 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:16:52 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:16:52 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:16:52 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:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:16:52 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:16:52 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:16:52 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:16:52 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:16:52 INFO - Installing collected packages: marionette-driver, simplejson 05:16:52 INFO - Running setup.py install for marionette-driver 05:16:52 INFO - Running setup.py install for simplejson 05:16:52 INFO - building 'simplejson._speedups' extension 05:16:52 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:16:53 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:16:53 INFO - Successfully installed marionette-driver simplejson 05:16:53 INFO - Cleaning up... 05:16:53 INFO - Return code: 0 05:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16: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:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16: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:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:53 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 0x1d6f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f3ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20defa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', '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:16:53 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:16:53 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:16:53 INFO - Using env: {'DISPLAY': ':0', 05:16:53 INFO - 'HOME': '/home/cltbld', 05:16:53 INFO - 'LANG': 'en_US.UTF-8', 05:16:53 INFO - 'LANGUAGE': 'en_US:en', 05:16:53 INFO - 'LOGNAME': 'cltbld', 05:16:53 INFO - 'MAIL': '/var/mail/cltbld', 05:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:53 INFO - 'MOZ_NO_REMOTE': '1', 05:16:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:53 INFO - 'NO_EM_RESTART': '1', 05:16:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:53 INFO - 'PWD': '/builds/slave/test', 05:16:53 INFO - 'SHELL': '/bin/bash', 05:16:53 INFO - 'SHLVL': '1', 05:16:53 INFO - 'TERM': 'linux', 05:16:53 INFO - 'TMOUT': '86400', 05:16:53 INFO - 'USER': 'cltbld', 05:16:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:53 INFO - '_': '/tools/buildbot/bin/python'} 05:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:54 INFO - Cleaning up... 05:16:54 INFO - Return code: 0 05:16:54 INFO - Running post-action listener: _resource_record_post_action 05:16:54 INFO - Running post-action listener: _start_resource_monitoring 05:16:54 INFO - Starting resource monitoring. 05:16:54 INFO - [mozharness: 2017-07-05 12:16:54.137710Z] Finished create-virtualenv step (success) 05:16:54 INFO - [mozharness: 2017-07-05 12:16:54.138642Z] Running install step. 05:16:54 INFO - Running pre-action listener: _resource_record_pre_action 05:16:54 INFO - Running main action method: install 05:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:54 INFO - Reading from file tmpfile_stdout 05:16:54 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:54 INFO - Reading from file tmpfile_stdout 05:16:54 INFO - Output received: 05:16:54 INFO - Usage: mozinstall [options] installer 05:16:54 INFO - Options: 05:16:54 INFO - -h, --help show this help message and exit 05:16:54 INFO - -d DEST, --destination=DEST 05:16:54 INFO - Directory to install application into. [default: 05:16:54 INFO - "/builds/slave/test"] 05:16:54 INFO - --app=APP Application being installed. [default: firefox] 05:16:54 INFO - mkdir: /builds/slave/test/build/application 05:16:54 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:16:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:17:12 INFO - Reading from file tmpfile_stdout 05:17:12 INFO - Output received: 05:17:12 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:12 INFO - Running post-action listener: _resource_record_post_action 05:17:12 INFO - [mozharness: 2017-07-05 12:17:12.304713Z] Finished install step (success) 05:17:12 INFO - [mozharness: 2017-07-05 12:17:12.304964Z] Running setup-mitmproxy step. 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running main action method: setup_mitmproxy 05:17:12 INFO - Skipping: mitmproxy is not required 05:17:12 INFO - Running post-action listener: _resource_record_post_action 05:17:12 INFO - [mozharness: 2017-07-05 12:17:12.306110Z] Finished setup-mitmproxy step (success) 05:17:12 INFO - [mozharness: 2017-07-05 12:17:12.306331Z] Running run-tests step. 05:17:12 INFO - Running pre-action listener: _resource_record_pre_action 05:17:12 INFO - Running pre-action listener: _set_gcov_prefix 05:17:12 INFO - Running main action method: run_tests 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:12 INFO - Python 2.7.3 05:17:12 INFO - Return code: 0 05:17:12 INFO - grabbing minidump binary from tooltool 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:12 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 0x20e22a0>, '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 0x20e32b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20dd4d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:12 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:17:12 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:17:12 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:17:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:12 INFO - Return code: 0 05:17:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:12 INFO - ENV: RUST_BACKTRACE is now 1 05:17:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:12 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/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:17:12 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/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-047 --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:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:12 INFO - 'RUST_BACKTRACE': '1', 05:17:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 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/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:17:12 INFO - mozversion application_buildid: 20170705110149 05:17:12 INFO - mozversion application_changeset: 211d4dd61025c0a40caea7a54c9066e051bdde8c 05:17:12 INFO - mozversion application_display_name: Nightly 05:17:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:12 INFO - mozversion application_name: Firefox 05:17:12 INFO - mozversion application_remotingname: firefox 05:17:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:12 INFO - mozversion application_vendor: Mozilla 05:17:12 INFO - mozversion application_version: 56.0a1 05:17:12 INFO - mozversion platform_buildid: 20170705110149 05:17:12 INFO - mozversion platform_changeset: 211d4dd61025c0a40caea7a54c9066e051bdde8c 05:17:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:12 INFO - mozversion platform_version: 56.0a1 05:17:12 INFO - using testdate: 1499257032 05:17:12 INFO - actual date: 1499257032 05:17:12 INFO - starting webserver on 'localhost:47143' 05:17:12 INFO - SUITE-START | Running 2 tests 05:17:12 INFO - TEST-START | dromaeo_css 05:17:12 INFO - Initialising browser for dromaeo_css test... 05:17:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47143/getInfo.html -profile /tmp/tmpESq3xF/profile 05:17:12 INFO - TEST-INFO | started process 3371 (/builds/slave/test/build/application/firefox/firefox http://localhost:47143/getInfo.html) 05:17:20 INFO - TEST-INFO | 3371: exit 0 05:17:20 INFO - Browser initialized. 05:17:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:20 INFO - TEST-INFO | started process 3580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpESq3xF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:32 INFO - PID 3580 | RSS: Main: 162107392 05:17:32 INFO - PID 3580 | 05:20:31 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47143/tests/dromaeo/cssquery-ext.html) 05:20:33 INFO - PID 3580 | RSS: Main: 169000960 05:20:33 INFO - PID 3580 | 05:23:34 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-ext.html (next: http://localhost:47143/tests/dromaeo/cssquery-jquery.html) 05:23:35 INFO - PID 3580 | RSS: Main: 168189952 05:23:35 INFO - PID 3580 | 05:26:37 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47143/tests/dromaeo/cssquery-mootools.html) 05:26:37 INFO - PID 3580 | RSS: Main: 170934272 05:26:37 INFO - PID 3580 | 05:29:39 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47143/tests/dromaeo/cssquery-prototype.html) 05:29:39 INFO - PID 3580 | RSS: Main: 169902080 05:29:39 INFO - PID 3580 | 05:32:42 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47143/tests/dromaeo/cssquery-yui.html) 05:32:43 INFO - PID 3580 | RSS: Main: 168812544 05:32:43 INFO - PID 3580 | 05:35:44 INFO - PID 3580 | Cycle 1(1): loaded http://localhost:47143/tests/dromaeo/cssquery-yui.html (next: http://localhost:47143/tests/dromaeo/cssquery-dojo.html) 05:35:45 INFO - PID 3580 | RSS: Main: 171778048 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | __start_tp_report 05:35:45 INFO - PID 3580 | _x_x_mozilla_page_load 05:35:45 INFO - PID 3580 | _x_x_mozilla_page_load_details 05:35:45 INFO - PID 3580 | |i|pagename|runs| 05:35:45 INFO - PID 3580 | |0;dojo.html;3283.8850640227597;3330.816805075721;3369.696727294543;3385.1029477188536;3389.186595217148;6164.938350616492;6199.44205021548;6204.069389591564;6216.036514340279;6309.463695585875;6168.475679567242;6255.906161407583;6258;6295.874082518347;6304.275008374038;5456.890862182754;5493.670379777206;5509.862253443656;5530.557555395579;5545.085060964936;5502.889942201154;5514.5864060195645;5529.419410961851;5554.583406244547;5565;5553.72231388431;5560.9712203242325;5565.582581306398;5571.192177134313;5575.2473416088715;5542.0855558832745;5542.91685624716;5544.667319960775;5568.387477377485;5570.86072848182;5473.17902314652;5481.506664400184;5498.752556134984;5551.1118221084835;5580.246666699984;6234.719437625317;6258.843528911813;6277.905831412532;6302.747890084391;6309.779157729457;6788.9660551696925;6792.320767923217;6846.623435711034;6881.483888708367;6891.035255064295;6642.5350225484235;6667.928023023079;6728.4617230621925;6728.629925354104;6741.258461569223;6275.058741188813;6282.308946015934;6284.4344009039405;6348.111264422984;6357.078223657544;6879.690413931385;6941.757038503628;6949.513534052568;7069.681864316118;7074.575525468488;6583.275839657634;6693.842523063685;6743.629100399427;6755.594664320059;6759.662016899136;6695.230048544382;6755.392014718601;6773.762918297836;6774.830629234309;6781.898271525833;6630.403263706289;6634.170728658918;6647.767328143588;6655.201375834834;6661.333866613397;5278.736063196825;6753.257141714407;6852.246252912176;6858.142732158481;6864.759733409307;5043.9747801260755;5053.620978426559;5125.231215317732;5129.204973229155;5133.9743301284;4456.799444025027;4459.888502787391;4580.862574122782;4589.541045895384;4595.586397224199;6214;6215.098810672427;6217.285012223561;6218.471429928416;6229.221347331583;6627.469802415795;6668.966655166693;6675.365840245169;6676.399124078856;6682;6150.323464418911;6189.442950134509;6212.223472065992;6220.813375598739;6230.43926046658;5560.638558493685;5572.331320241597;5613.438656134354;5624.91562626561;5656.095024796013;7072.257412971564;7087.468439867031;7120.608366539786;7155.499115061895;7178.353948144692;6796.4562834973085;6824;6844.315568443116;6910.827229319308;6923.411510021705;6958.547694399847;7011.368976792113;7057.470689698396;7070.222275549789;7131.82170445743;6689.431398331197;6691.464682825265;6707.765228216989;6720.428763554957;6722.495812813961;6857.348551887562;6864.073350097673;6929.89605155913;6958;6966.825829354307;6595.670216489252;6621.33786621334;6630.403263706289;6701.32986701326;6718.160229971254;6486.772962946275;6548.869022619616;6558.737650493927;6691.46468282546;6711.731530738716;6533.509986751108;6568.343165683585;6608.140941677551;6610.8347291318105;6617.2721000688925;5407.567394608501;6546.672666366568;6624.205095388585;6625.569337993015;6658.1344425224415;6474.741010359533;6478.546501744832;6558.409743123142;6564.081028656087;6583.177102862142 05:35:45 INFO - PID 3580 | |1;ext.html;887.2768693514787;940.3511577011863;965.8406362950113;1181.061056460114;1188.6493484422094;32051.839740801293;32615.67384326156;41104;41913;42041.57958420423;42425.36361954566;42802;42804.785976070154;42806.14387712244;43003.35494967578;7207.279272072803;7309.086364204474;7317.67070481827;7317.817054573625;7331.120265568139;7220.350168484835;7251.70993160273;7281.599512026836;7317.231690672456;7363.042804435443;7370.815729606776;7406.8888966665545;7412.851742965137;7448.180700122982;7450.14323352816;7297.854042919165;7329.120505539343;7344.192138864721;7349.779506614784;7365.484416090876;7216.530925489827;7244.601546914971;7258;7291.963540182318;7295.744648937261;39401.60598394008;39506.60493395058;39692.007699807444;39728.00679982995;39865.60134398677;3418.9316213675834;3436.9484457733156;3448.327576122657;3455.94816077759;3472.9826350868084;29903.252418689488;29989.550156747668;30170.69829301701;30227;30242.54636180459;4708.576228139484;4836.298736683161;4967.105920934267;5016.423111342206;5026.52248036436;203541;207739;208889;209113;211374;44424.3336349955;50078.749606252466;50239.24641130386;50594.241086383736;50801.74599126981;53342.46657533375;53583;53592.19611705827;53766.19350709742;53781.1932821008;16252.918735406483;16275.186240687919;16340.18299085041;16397.180140992903;16445;13131.212127272394;13190.076694631283;13206.207627542186;13213.33933303331;13227.272500012592;14426.927865360816;14701.338439770023;14732.484363047242;14819;14904.254787260594;5942.346341902387;6055.72749226277;6091.08633704939;6091.543134264948;6100.298465676504;1084.9186311026704;1086.7826434713088;1102.72431892027;1107.7618312062946;1130.141092769501;23749.525009499714;24109.638355424682;24290.51418971611;24364.390890227885;24749.381265468506;1183.6685727996176;1200.3758045816128;1202.4588934979295;1208.528673817212;1215.5927764199093;12935.676608084685;12983.675408114872;13093.41079651418;13103.60689179326;13119.475220991244;279797;280870;282708;282929;284006;53599.196012059074;54134.45865541373;54194.72902635462;54197.72901135548;54286.45713542814;1487.2638044168207;1566.5926859016738;1566.8589826915631;1575.2360105348896;1593.3148746039083;24203.87898060569;28117.297067573476;28590.57114143248;29012.709872901843;29379;52608.210876836114;52956;53022;53343.46656533385;53541;248270;248855;249003.75498123118;252125;252205;35460.82269588635;35594.822025889705;36479;36763.816180918926;37368;45811.3128303069;47101.528984709716;47673.76163119162;48280;48444.273335900696;34483.482747759306;34506.482402763475;34528.48207276843;34743.82628086843;35221;33821.661783382835;33854.322913542084;33930.321393571496;34244.82877585596;35213.11967200738;38929.221415572094;39337.606623933396;39801;39870.20259594734;40020;32699.34601308008;32747.181320467178;33385.49921751127;33577.49633755447;33990.15024624404;24536.877315613307;24811;25598.488030239663;25708;25848.741512584635 05:35:45 INFO - PID 3580 | |2;jquery.html;556.6103727390824;560.99861746782;564.2298262871182;584.9298084229893;586.1852025684299;22163.335099947006;23199.420014499647;23352.766472335272;23415.531689366202;23417;24854.875725621347;25982.090626828063;27127.728722712767;27326.180214593594;27367.178984630442;6112.358202388741;6321;6336.619802811846;6342.048692696109;6347.39699728525;6256.468200202989;6295.118683384329;6303.086052522404;6310.905336419957;6315.021171718391;5776.104703770922;6051.848703782397;6096.786612468564;6237.220347456568;6300.495960323163;6130.1111338855835;6136.048912418582;6194.5354098442795;6195.938040619581;6199.256089269272;5740.5981581289325;5748.770049198027;5771.307443106812;5775.740091695884;5780.421957804228;28650.283742906384;29826.40347193066;29989.400211995857;30223;30228.09315720532;2152.440365504964;2193.111789725164;2196.3520761375435;2205.3494219205213;2205.8125059369972;19006.61986760257;19573.608527829507;19587.90206048975;19603.31388401399;19630.116644751022;2379.559781440422;2400.2199285232196;2414.130912871365;2429.465517586146;2444.2667199839975;133950.3302483491;141651;141790;142016.28991854974;142084;14372.640683982774;15193.924030379778;15213.923930380277;15468.767968480483;15715.842841571437;23837.165699200792;23959.760402395754;24038.759612403654;24043.398915026915;24105;10375.84436233457;10415.218858585637;10463.790724185474;10655.041046305869;10689.9465502672;9756.414615122972;9796.706098817047;9807.509624518745;9850.556724947395;9859.802803943881;9163.043748292079;9364.438133711863;9421.528923553795;9481.66814161501;9666.178374838077;2674.2378422149595;2681.9731802682113;2740.6163137160815;2811.2269125990106;2887.9928449727236;1017.5827910556636;1030.7680771826429;1048.5438834107188;1066.751900276678;1074.2909679611419;20556.897215513825;21215.257465988616;21355.03902324399;21369.46576335573;21384;1117.603250845938;1136.9602063927723;1147.2428197389684;1155.1163360029584;1158.692946369213;11488.368139752394;11500.88499115015;11766.117541184274;11904.821427678591;11974.98212651917;612460;626960;636551;636907;651303;124745.37627311805;125332.37333813273;128951.35524322506;129018;132085;1254.9623511294676;1267.3789842976876;1270.7267937393506;1293.043148070421;1296.4554886947317;17948.282068717628;18051.187696553425;18144.27422903122;18214.544636384195;19175.424737257905;53289.20066198933;53892.730536347066;53934;54131.72934135304;55520.167197492876;71239;71352.28647713664;75973.62013189899;79768;82953.58523207346;18300.176492057624;18620.16209270559;18648.720269195703;18828.152733127317;18843.811561884206;16277.186140693155;16926.40757573479;17061.744073839152;20198.99005049771;21002.47493812667;13824;16002.8399716006;16539.75190372121;16763.32946682119;16779.748303775697;14145.858541414455;14447.205403702897;14483.637909051937;14564.708705826037;15120.621984450478;16628.916855415646;16908.15459227009;16999.575010624834;17049.40327088546;17076.91461542734;18355.08224588792;18688.719669205246;18732.344367947055;19019.619607607492;19065.90467047656;15485.148316842231;15507.457238996582;15636.92181539085;15644;16012.199390030219 05:35:45 INFO - PID 3580 | |3;mootools.html;1426.450816435672;1457.701171259892;1473.410635745702;1474.9852501474982;1483.7996870422496;13065.412056457459;14678.41286348546;15192.620184495394;15254.313555889983;15286.464973725922;12807.551735689252;13022;13040.347982600879;14805.851941480581;15146.091234525937;2614.934626634335;2663.1078588672817;2676.8929242830263;2682.7317268273214;2684.2484104450787;2673.5588627876473;2690.7174746651613;2695.3665888516184;2708.8781004854827;2719.9592006119824;2576.3559110222445;2594.195799302213;2598.3374239568884;2604.440045390241;2614.3594819269306;2568.4734629400928;2594.7016093149246;2595.390083330416;2595.8182927195007;2596.026490066225;2399.3881560202212;2452.411421258885;2468.90124395024;2477.6159695247266;2490.514349701809;14386.92806535971;14558.92720536401;14562.490312839;14596.197209153492;14603.853961460356;7969;8267.255946964802;8272.751817445485;8286.70996515119;8296.336293096538;4829.951700482985;4889.559939605452;5059.16523773577;5086.593072554187;5098.59211263098;1857.7027675571978;1873.9156737946826;1946.347973428889;1980.5444747707963;1989.1844343818964;25901.74098259012;25967.480650386886;26052.60921086166;26069.348266293495;26261.343466413302;7242.348188663045;7280;7381.557106573623;7500.324970752658;7539.811504712426;17387.391441299493;19378.515537111685;19434.22263109488;19499.707504387447;19506.12222449993;8045.718399856094;8267.29727973117;8282.378821588405;8309.210624990616;8321.583920803936;7537.2085930977555;7594.202608726115;7638.083429988437;7669.118051424158;7828.686852525949;5251.317328747238;5459.50864422196;5462.863428414322;5468.453154684579;5512.944870551243;1570.6701592665668;1591.172590253062;1593.6095656564216;1617.660291338832;1627.5198816348968;903.9502827344559;909.3452714045876;930.9022552632011;934.1079269297804;946.068122898944;7470.140933792574;7520.887186692204;8033.879491807627;8189.1401402853035;8194.836103277901;715.9785206443815;729.2270193594701;734.8493558820429;739.4306384084333;743.2604558464254;4539.954600454019;4744.240921452551;4860.8784780380065;4940.20956646942;4977.527134922177;19718.211271549266;20107.29624463137;20170.69743953842;20804.687929681066;20873.68689469659;21188.576228475344;21821.67267490989;21889.562208756055;21935.451613709785;22078.558428831333;11877.465514051888;11877.58428455;11972.04223662105;12099;12101.394930253453;7902.881456778038;8148.959255203923;8226.42415030966;8243.752687419386;8252.876206856781;17877.821221787617;18370.816291837444;18560.164792584637;18956.336528221447;19167.32914347991;18351.35770248035;19016.668833181546;19646.115924783706;19771.308004219783;19992.800071999674;12352.75294494123;12640.43118059708;12642.55751048709;12643;12696.555620553236;14028;14029.719405612035;14060.929695351459;14078.084924479876;14099.506517271846;11171.162162837982;11188.66434006981;11689.590864319707;11907.702307442383;12070.094742894142;10570.207234457293;10899.891001090205;11027.83458248111;11133.554657813596;11457.713557161138;9649.9035009649;9713.562889670124;9717.708468745948;9727.124558789743;9740.561674724513;6575.178102737158;6881.174259088942;6940.02839602446;7014.649267536704;7025.01649769043;6753.898691519533;6916;6953.513254072166;7000.369966703021;7019.3682568569075 05:35:45 INFO - PID 3580 | |4;prototype.html;506.6858547700425;516.2050442318829;519.5609709795223;524.1168630857006;537.884354863704;6082.908756368658;6084.0873868919625;6158.6612736299485;6160.229971253593;6262.342454042323;6053.818385448432;6101.0848372744;6135.29444113927;6137.882430561461;6159.722812473438;4913.304909806111;4963.329950456697;4966.180580204262;4966.453690094087;4969.378827646544;4975.800967961277;4976.377952755905;4978.825741099062;4980.12847751642;4986.127427700138;4918.893249018978;4931.408231012284;4934.248341838649;4970.950290497103;4980.203167493201;4899.628104130849;4937.382827146606;4967.950320496803;4972.577330926875;4992.950070499285;4111.0605916769655;4254.936175957363;4283.935740963888;4500.7299562026055;4506.121306345264;5855.121731740273;5902.468777809975;5932.822015339547;5947.4052594740615;5970.402959704038;5608.5793565482345;5636.859078523029;5662.235598194232;5685.914711279334;5706.71466426677;6514.3811337922825;6525.575837570543;6542.836429089263;6545.639989800559;6556.213254409454;4795.400574928134;4809;4825.734584597846;4858.562729354375;4862.902741945141;6516;6723.831904202385;6759.512907160417;6769.424598909099;6811.352921472452;4905.460399356068;4989.426215985208;5018.698878067255;5030.622703297267;5042.520960508746;5056.317397151338;5056.469070747592;5058.898822023539;5063.670861393997;5097.592192624581;5646.096624540054;5684.8863022739315;5720.370759216483;5734.025215713339;5776.191333213354;6476.35236476358;6551.868962620816;6561.80314590563;6563.704633291513;6584;1762.480068379831;1770.3803668716105;1777.9644407111784;1779.8309160629979;1787.6782179207607;1180.819180819181;1238.646985609097;1239.4732238798474;1249.000799360508;1258.8426446694164;6097.987664070934;6169.753209871645;6190.628562286277;6192.752289908443;6279.183706118175;6668.166479190101;6716.429103526158;6724.865502690017;6750.864982700318;6765.594064356154;6145.8156255312415;6161.630302181883;6224.719887605069;6233.532485063638;6262.968685156637;3550.6626870447267;3556.541817854719;3573.2317551726505;3577.463380492895;3577.713782897414;6893.724251030003;6898.793036208922;6910.930890691029;6933.4106600939485;6979.581225126509;6799.456043516507;6837.794866154023;6842.247352791189;6889;6958.269381714948;6386.201724784495;6890.276520965427;6939.375456208965;6944.51388402807;6997.160340759141;6610.4050635443045;6617.900731489128;6640.734370625314;6693;6716.462682985447;6554.868902621825;6562.228198386504;6585.670716464062;6605.339466053356;6680.3987641112535;6915.550489218386;6918.952412838546;6960.990656354901;6965.65171741421;7006.719731210898;5022.623303252344;5052.25697134488;5057;5063.645544811828;5091.363579552556;6526.379993900572;6671.499637527302;6721.966390168213;6745.3591908768585;6754.93245067543;6376.521760868046;6507;6558.540902136995;6569.605823650596;6617.470602351704;6464.612123272619;6499.870002599827;6517.7067031984625;6520;6543.443807276244;6408.212427594011;6487.253965793994;6538.509611779041;6541.92529511129;6556.737730490918;6568.573042752206;6577.638229897401;6606.471482281502;6613.768518102036;6632.568883022588;6427.232511059496;6444.613323200623;6457.61254324742;6504.284528701934;6520.836979075371 05:35:45 INFO - PID 3580 | |5;yui.html;940.2478017585929;954.2509130332691;955.8422860228063;961.5048250151178;982.4743762087282;17726.290948362068;18691.439256822316;18701.81298187018;18702.251909923605;18708.345207917726;16299.348026078942;16601.335946562154;16658.83341166588;19524.41426757196;20678.689819652718;1062.6015244283374;1080.1952545353722;1084.696285040186;1094.3051162511822;1094.6934858239665;1069.9144068474543;1070.3952266969138;1071.2661826648732;1076.3219171921678;1076.7792602516504;1125.6397952655154;1130.4347826086957;1134.1437214902778;1139.641013080877;1140.7091191746135;1122.6688127002553;1126.9492872820701;1135.5401062569672;1194.552042983881;1202.8977536909285;769.730594291999;790.5059337913804;799.6121880887765;800.9627532345627;803.0323460230409;18573.814261857344;18922.337718179937;19206.135723892457;19286.228550857948;19304;19432.70850937237;19703.211871525124;19704.507387315287;19896.20415183391;20002;14859.777103343351;14867.628309292246;14916.030458020303;14992.025518341274;15028;3518.5249991251108;3541.1501239702543;3543.698785603227;3553.9111522211892;3556.78659280444;92701.5364923171;115105;121820;123836.38081809624;127602;13954.162750235018;14242.928785356007;14882.553523394316;16557.668846623;16938.661226775643;29161;30658.69341306603;30759.8462007693;30840.845795770878;30947.0715878524;8567.314614830799;8816.294696424398;8886.24466920319;8887.15572020657;8906.910930890608;4248.214080395137;4284.871453856389;4298.871033868989;4314.784260786948;4317.892052698645;5074.13739664258;5147.974260128675;5149.021685879671;5209.218617207373;5295.549878260314;1010.8938561451089;1042.781015986636;1051.0277992856577;1051.9579216831394;1054.4095306628312;652.5856081388258;659.970301336441;671.8689855478135;671.9563228390236;695.4992405468055;11655.76688466243;13209.603711888658;13459.3943272551;13492.460301587827;13513.662158446117;660.2967839251278;666.6366830077619;684.1960696182066;684.4934748286232;689.1489011071322;5543.7782488700805;6532.5753826001155;6598.802035938929;6622.867542649216;6903.516753827284;111480;114387;117194.41402792932;118078;119140.4042979797;99464;103176.48411757893;105119;105811.4709426448;107274;86595;94697;94983;98644.50677746709;99454.50272748734;13207.933960330136;13468.595942121752;13517.188968661912;13634.250116243702;13641.454341826613;44547.88630284139;44634.3304850434;45032.77483612692;45264.54735452735;46192.76903615595;56442.43557564536;57681.711591443454;58115.418845812696;58249.70875145597;59034.704826475594;15975.121368324853;16275.18624068768;16435.17824108766;16565.17174141264;16713.997160170427;17950.640987180446;18686.719699204794;18762.15570299367;18936.147873346006;19153.425397238105;19130.904345478182;19476.4157075288;19923.701144482555;20007.59984800325;20029.899850500653;18811.71782423292;19047.809521905157;19239.326623568108;19932.90033549823;20512.38462846117;18167.45497635073;19031.90484047571;19136.71294930605;19261.22955081781;19785.40643780689;13809.930950345184;14069.437222511395;14441.989060766065;14544.709105817612;14558.12651240929;14687;15738.842611573738;15759.606009849387;15842.52472425829;16113.274902629644 05:35:45 INFO - PID 3580 | __end_tp_report 05:35:45 INFO - PID 3580 | __start_cc_report 05:35:45 INFO - PID 3580 | _x_x_mozilla_cycle_collect,320 05:35:45 INFO - PID 3580 | __end_cc_report 05:35:45 INFO - PID 3580 | __startTimestamp1499258145096__endTimestamp 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | ------- Summary: start ------- 05:35:45 INFO - PID 3580 | Number of tests: 6 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#0] dojo.html Cycles:165 Average:6211.06 Median:6548.87 stddev:802.89 (12.3%) stddev-sans-first:771.81 05:35:45 INFO - PID 3580 | Values: 3283.9 3330.8 3369.7 3385.1 3389.2 6164.9 6199.4 6204.1 6216.0 6309.5 6168.5 6255.9 6258.0 6295.9 6304.3 5456.9 5493.7 5509.9 5530.6 5545.1 5502.9 5514.6 5529.4 5554.6 5565.0 5553.7 5561.0 5565.6 5571.2 5575.2 5542.1 5542.9 5544.7 5568.4 5570.9 5473.2 5481.5 5498.8 5551.1 5580.2 6234.7 6258.8 6277.9 6302.7 6309.8 6789.0 6792.3 6846.6 6881.5 6891.0 6642.5 6667.9 6728.5 6728.6 6741.3 6275.1 6282.3 6284.4 6348.1 6357.1 6879.7 6941.8 6949.5 7069.7 7074.6 6583.3 6693.8 6743.6 6755.6 6759.7 6695.2 6755.4 6773.8 6774.8 6781.9 6630.4 6634.2 6647.8 6655.2 6661.3 5278.7 6753.3 6852.2 6858.1 6864.8 5044.0 5053.6 5125.2 5129.2 5134.0 4456.8 4459.9 4580.9 4589.5 4595.6 6214.0 6215.1 6217.3 6218.5 6229.2 6627.5 6669.0 6675.4 6676.4 6682.0 6150.3 6189.4 6212.2 6220.8 6230.4 5560.6 5572.3 5613.4 5624.9 5656.1 7072.3 7087.5 7120.6 7155.5 7178.4 6796.5 6824.0 6844.3 6910.8 6923.4 6958.5 7011.4 7057.5 7070.2 7131.8 6689.4 6691.5 6707.8 6720.4 6722.5 6857.3 6864.1 6929.9 6958.0 6966.8 6595.7 6621.3 6630.4 6701.3 6718.2 6486.8 6548.9 6558.7 6691.5 6711.7 6533.5 6568.3 6608.1 6610.8 6617.3 5407.6 6546.7 6624.2 6625.6 6658.1 6474.7 6478.5 6558.4 6564.1 6583.2 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#1] ext.html Cycles:180 Average:42137.78 Median:19108.40 stddev:64759.34 (338.9%) stddev-sans-first:64866.94 05:35:45 INFO - PID 3580 | Values: 887.3 940.4 965.8 1181.1 1188.6 32051.8 32615.7 41104.0 41913.0 42041.6 42425.4 42802.0 42804.8 42806.1 43003.4 7207.3 7309.1 7317.7 7317.8 7331.1 7220.4 7251.7 7281.6 7317.2 7363.0 7370.8 7406.9 7412.9 7448.2 7450.1 7297.9 7329.1 7344.2 7349.8 7365.5 7216.5 7244.6 7258.0 7292.0 7295.7 39401.6 39506.6 39692.0 39728.0 39865.6 3418.9 3436.9 3448.3 3455.9 3473.0 29903.3 29989.6 30170.7 30227.0 30242.5 4708.6 4836.3 4967.1 5016.4 5026.5 203541.0 207739.0 208889.0 209113.0 211374.0 44424.3 50078.7 50239.2 50594.2 50801.7 53342.5 53583.0 53592.2 53766.2 53781.2 16252.9 16275.2 16340.2 16397.2 16445.0 13131.2 13190.1 13206.2 13213.3 13227.3 14426.9 14701.3 14732.5 14819.0 14904.3 5942.3 6055.7 6091.1 6091.5 6100.3 1084.9 1086.8 1102.7 1107.8 1130.1 23749.5 24109.6 24290.5 24364.4 24749.4 1183.7 1200.4 1202.5 1208.5 1215.6 12935.7 12983.7 13093.4 13103.6 13119.5 279797.0 280870.0 282708.0 282929.0 284006.0 53599.2 54134.5 54194.7 54197.7 54286.5 1487.3 1566.6 1566.9 1575.2 1593.3 24203.9 28117.3 28590.6 29012.7 29379.0 52608.2 52956.0 53022.0 53343.5 53541.0 248270.0 248855.0 249003.8 252125.0 252205.0 35460.8 35594.8 36479.0 36763.8 37368.0 45811.3 47101.5 47673.8 48280.0 48444.3 34483.5 34506.5 34528.5 34743.8 35221.0 33821.7 33854.3 33930.3 34244.8 35213.1 38929.2 39337.6 39801.0 39870.2 40020.0 32699.3 32747.2 33385.5 33577.5 33990.2 24536.9 24811.0 25598.5 25708.0 25848.7 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#2] jquery.html Cycles:180 Average:39207.90 Median:2172.78 stddev:105298.92 (4846.3%) stddev-sans-first:105554.32 05:35:45 INFO - PID 3580 | Values: 556.6 561.0 564.2 584.9 586.2 22163.3 23199.4 23352.8 23415.5 23417.0 24854.9 25982.1 27127.7 27326.2 27367.2 6112.4 6321.0 6336.6 6342.0 6347.4 6256.5 6295.1 6303.1 6310.9 6315.0 5776.1 6051.8 6096.8 6237.2 6300.5 6130.1 6136.0 6194.5 6195.9 6199.3 5740.6 5748.8 5771.3 5775.7 5780.4 28650.3 29826.4 29989.4 30223.0 30228.1 2152.4 2193.1 2196.4 2205.3 2205.8 19006.6 19573.6 19587.9 19603.3 19630.1 2379.6 2400.2 2414.1 2429.5 2444.3 133950.3 141651.0 141790.0 142016.3 142084.0 14372.6 15193.9 15213.9 15468.8 15715.8 23837.2 23959.8 24038.8 24043.4 24105.0 10375.8 10415.2 10463.8 10655.0 10689.9 9756.4 9796.7 9807.5 9850.6 9859.8 9163.0 9364.4 9421.5 9481.7 9666.2 2674.2 2682.0 2740.6 2811.2 2888.0 1017.6 1030.8 1048.5 1066.8 1074.3 20556.9 21215.3 21355.0 21369.5 21384.0 1117.6 1137.0 1147.2 1155.1 1158.7 11488.4 11500.9 11766.1 11904.8 11975.0 612460.0 626960.0 636551.0 636907.0 651303.0 124745.4 125332.4 128951.4 129018.0 132085.0 1255.0 1267.4 1270.7 1293.0 1296.5 17948.3 18051.2 18144.3 18214.5 19175.4 53289.2 53892.7 53934.0 54131.7 55520.2 71239.0 71352.3 75973.6 79768.0 82953.6 18300.2 18620.2 18648.7 18828.2 18843.8 16277.2 16926.4 17061.7 20199.0 21002.5 13824.0 16002.8 16539.8 16763.3 16779.7 14145.9 14447.2 14483.6 14564.7 15120.6 16628.9 16908.2 16999.6 17049.4 17076.9 18355.1 18688.7 18732.3 19019.6 19065.9 15485.1 15507.5 15636.9 15644.0 16012.2 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#3] mootools.html Cycles:180 Average:9316.07 Median:2595.60 stddev:6664.07 (256.7%) stddev-sans-first:6656.40 05:35:45 INFO - PID 3580 | Values: 1426.5 1457.7 1473.4 1475.0 1483.8 13065.4 14678.4 15192.6 15254.3 15286.5 12807.6 13022.0 13040.3 14805.9 15146.1 2614.9 2663.1 2676.9 2682.7 2684.2 2673.6 2690.7 2695.4 2708.9 2720.0 2576.4 2594.2 2598.3 2604.4 2614.4 2568.5 2594.7 2595.4 2595.8 2596.0 2399.4 2452.4 2468.9 2477.6 2490.5 14386.9 14558.9 14562.5 14596.2 14603.9 7969.0 8267.3 8272.8 8286.7 8296.3 4830.0 4889.6 5059.2 5086.6 5098.6 1857.7 1873.9 1946.3 1980.5 1989.2 25901.7 25967.5 26052.6 26069.3 26261.3 7242.3 7280.0 7381.6 7500.3 7539.8 17387.4 19378.5 19434.2 19499.7 19506.1 8045.7 8267.3 8282.4 8309.2 8321.6 7537.2 7594.2 7638.1 7669.1 7828.7 5251.3 5459.5 5462.9 5468.5 5512.9 1570.7 1591.2 1593.6 1617.7 1627.5 904.0 909.3 930.9 934.1 946.1 7470.1 7520.9 8033.9 8189.1 8194.8 716.0 729.2 734.8 739.4 743.3 4540.0 4744.2 4860.9 4940.2 4977.5 19718.2 20107.3 20170.7 20804.7 20873.7 21188.6 21821.7 21889.6 21935.5 22078.6 11877.5 11877.6 11972.0 12099.0 12101.4 7902.9 8149.0 8226.4 8243.8 8252.9 17877.8 18370.8 18560.2 18956.3 19167.3 18351.4 19016.7 19646.1 19771.3 19992.8 12352.8 12640.4 12642.6 12643.0 12696.6 14028.0 14029.7 14060.9 14078.1 14099.5 11171.2 11188.7 11689.6 11907.7 12070.1 10570.2 10899.9 11027.8 11133.6 11457.7 9649.9 9713.6 9717.7 9727.1 9740.6 6575.2 6881.2 6940.0 7014.6 7025.0 6753.9 6916.0 6953.5 7000.4 7019.4 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#4] prototype.html Cycles:180 Average:5550.51 Median:6160.93 stddev:1571.37 (25.5%) stddev-sans-first:1529.50 05:35:45 INFO - PID 3580 | Values: 506.7 516.2 519.6 524.1 537.9 6082.9 6084.1 6158.7 6160.2 6262.3 6053.8 6101.1 6135.3 6137.9 6159.7 4913.3 4963.3 4966.2 4966.5 4969.4 4975.8 4976.4 4978.8 4980.1 4986.1 4918.9 4931.4 4934.2 4971.0 4980.2 4899.6 4937.4 4968.0 4972.6 4993.0 4111.1 4254.9 4283.9 4500.7 4506.1 5855.1 5902.5 5932.8 5947.4 5970.4 5608.6 5636.9 5662.2 5685.9 5706.7 6514.4 6525.6 6542.8 6545.6 6556.2 4795.4 4809.0 4825.7 4858.6 4862.9 6516.0 6723.8 6759.5 6769.4 6811.4 4905.5 4989.4 5018.7 5030.6 5042.5 5056.3 5056.5 5058.9 5063.7 5097.6 5646.1 5684.9 5720.4 5734.0 5776.2 6476.4 6551.9 6561.8 6563.7 6584.0 1762.5 1770.4 1778.0 1779.8 1787.7 1180.8 1238.6 1239.5 1249.0 1258.8 6098.0 6169.8 6190.6 6192.8 6279.2 6668.2 6716.4 6724.9 6750.9 6765.6 6145.8 6161.6 6224.7 6233.5 6263.0 3550.7 3556.5 3573.2 3577.5 3577.7 6893.7 6898.8 6910.9 6933.4 6979.6 6799.5 6837.8 6842.2 6889.0 6958.3 6386.2 6890.3 6939.4 6944.5 6997.2 6610.4 6617.9 6640.7 6693.0 6716.5 6554.9 6562.2 6585.7 6605.3 6680.4 6915.6 6919.0 6961.0 6965.7 7006.7 5022.6 5052.3 5057.0 5063.6 5091.4 6526.4 6671.5 6722.0 6745.4 6754.9 6376.5 6507.0 6558.5 6569.6 6617.5 6464.6 6499.9 6517.7 6520.0 6543.4 6408.2 6487.3 6538.5 6541.9 6556.7 6568.6 6577.6 6606.5 6613.8 6632.6 6427.2 6444.6 6457.6 6504.3 6520.8 05:35:45 INFO - PID 3580 | 05:35:45 INFO - PID 3580 | [#5] yui.html Cycles:180 Average:23807.03 Median:19089.36 stddev:32388.26 (169.7%) stddev-sans-first:32433.61 05:35:45 INFO - PID 3580 | Values: 940.2 954.3 955.8 961.5 982.5 17726.3 18691.4 18701.8 18702.3 18708.3 16299.3 16601.3 16658.8 19524.4 20678.7 1062.6 1080.2 1084.7 1094.3 1094.7 1069.9 1070.4 1071.3 1076.3 1076.8 1125.6 1130.4 1134.1 1139.6 1140.7 1122.7 1126.9 1135.5 1194.6 1202.9 769.7 790.5 799.6 801.0 803.0 18573.8 18922.3 19206.1 19286.2 19304.0 19432.7 19703.2 19704.5 19896.2 20002.0 14859.8 14867.6 14916.0 14992.0 15028.0 3518.5 3541.2 3543.7 3553.9 3556.8 92701.5 115105.0 121820.0 123836.4 127602.0 13954.2 14242.9 14882.6 16557.7 16938.7 29161.0 30658.7 30759.8 30840.8 30947.1 8567.3 8816.3 8886.2 8887.2 8906.9 4248.2 4284.9 4298.9 4314.8 4317.9 5074.1 5148.0 5149.0 5209.2 5295.5 1010.9 1042.8 1051.0 1052.0 1054.4 652.6 660.0 671.9 672.0 695.5 11655.8 13209.6 13459.4 13492.5 13513.7 660.3 666.6 684.2 684.5 689.1 5543.8 6532.6 6598.8 6622.9 6903.5 111480.0 114387.0 117194.4 118078.0 119140.4 99464.0 103176.5 105119.0 105811.5 107274.0 86595.0 94697.0 94983.0 98644.5 99454.5 13207.9 13468.6 13517.2 13634.3 13641.5 44547.9 44634.3 45032.8 45264.5 46192.8 56442.4 57681.7 58115.4 58249.7 59034.7 15975.1 16275.2 16435.2 16565.2 16714.0 17950.6 18686.7 18762.2 18936.1 19153.4 19130.9 19476.4 19923.7 20007.6 20029.9 18811.7 19047.8 19239.3 19932.9 20512.4 18167.5 19031.9 19136.7 19261.2 19785.4 13809.9 14069.4 14442.0 14544.7 14558.1 14687.0 15738.8 15759.6 15842.5 16113.3 05:35:45 INFO - PID 3580 | -------- Summary: end -------- 05:35:45 INFO - PID 3580 | 05:35:45 INFO - TEST-INFO | 3580: exit 0 05:35:45 INFO - TEST-OK | dromaeo_css | took 1112876ms 05:35:45 INFO - TEST-START | kraken 05:35:45 INFO - Initialising browser for kraken test... 05:35:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47143/getInfo.html -profile /tmp/tmp_w_edZ/profile 05:35:45 INFO - TEST-INFO | started process 3988 (/builds/slave/test/build/application/firefox/firefox http://localhost:47143/getInfo.html) 05:35:51 INFO - TEST-INFO | 3988: exit 0 05:35:51 INFO - Browser initialized. 05:35:51 INFO - Running cycle 1/1 for kraken test... 05:35:51 INFO - TEST-INFO | started process 4193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_w_edZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:02 INFO - PID 4193 | RSS: Main: 162099200 05:36:02 INFO - PID 4193 | 05:36:05 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47143/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:05 INFO - PID 4193 | RSS: Main: 166756352 05:36:05 INFO - PID 4193 | 05:36:08 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47143/tests/kraken/driver.html?testName=audio-dft) 05:36:09 INFO - PID 4193 | RSS: Main: 167583744 05:36:09 INFO - PID 4193 | 05:36:11 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47143/tests/kraken/driver.html?testName=audio-fft) 05:36:12 INFO - PID 4193 | RSS: Main: 166019072 05:36:12 INFO - PID 4193 | 05:36:14 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47143/tests/kraken/driver.html?testName=audio-oscillator) 05:36:15 INFO - PID 4193 | RSS: Main: 167247872 05:36:15 INFO - PID 4193 | 05:36:17 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:17 INFO - PID 4193 | RSS: Main: 166903808 05:36:17 INFO - PID 4193 | 05:36:20 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47143/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:21 INFO - PID 4193 | RSS: Main: 166809600 05:36:21 INFO - PID 4193 | 05:36:24 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47143/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:25 INFO - PID 4193 | RSS: Main: 169840640 05:36:25 INFO - PID 4193 | 05:36:28 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47143/tests/kraken/driver.html?testName=json-parse-financial) 05:36:28 INFO - PID 4193 | RSS: Main: 170967040 05:36:28 INFO - PID 4193 | 05:36:30 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:30 INFO - PID 4193 | RSS: Main: 170741760 05:36:30 INFO - PID 4193 | 05:36:32 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:33 INFO - PID 4193 | RSS: Main: 170643456 05:36:33 INFO - PID 4193 | 05:36:35 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:35 INFO - PID 4193 | RSS: Main: 170815488 05:36:35 INFO - PID 4193 | 05:36:38 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:39 INFO - PID 4193 | RSS: Main: 170549248 05:36:39 INFO - PID 4193 | 05:36:41 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:42 INFO - PID 4193 | RSS: Main: 171118592 05:36:42 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | Cycle 1(1): loaded http://localhost:47143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47143/tests/kraken/driver.html?testName=ai-astar) 05:36:44 INFO - PID 4193 | RSS: Main: 171917312 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | __start_tp_report 05:36:44 INFO - PID 4193 | _x_x_mozilla_page_load 05:36:44 INFO - PID 4193 | _x_x_mozilla_page_load_details 05:36:44 INFO - PID 4193 | |i|pagename|runs| 05:36:44 INFO - PID 4193 | |0;ai-astar;106;97;107;106;107;111;106;107;107;108 05:36:44 INFO - PID 4193 | |1;audio-beat-detection;143;117;143;177;118;140;150;115;169;117 05:36:44 INFO - PID 4193 | |2;audio-dft;163;163;161;161;162;167;162;161;161;164 05:36:44 INFO - PID 4193 | |3;audio-fft;73;74;73;157;74;75;74;75;92;73 05:36:44 INFO - PID 4193 | |4;audio-oscillator;80;82;141;80;81;81;144;81;81;140 05:36:44 INFO - PID 4193 | |5;imaging-gaussian-blur;114;114;113;113;114;113;114;114;114;114 05:36:44 INFO - PID 4193 | |6;imaging-darkroom;147;147;147;148;148;148;147;148;148;149 05:36:44 INFO - PID 4193 | |7;imaging-desaturate;94;94;95;94;94;94;94;94;93;94 05:36:44 INFO - PID 4193 | |8;json-parse-financial;49;48;49;46;46;51;53;47;47;46 05:36:44 INFO - PID 4193 | |9;json-stringify-tinderbox;56;55;56;56;56;57;56;58;56;55 05:36:44 INFO - PID 4193 | |10;stanford-crypto-aes;75;75;75;76;75;75;75;83;75;82 05:36:44 INFO - PID 4193 | |11;stanford-crypto-ccm;126;129;125;133;120;120;118;122;122;145 05:36:44 INFO - PID 4193 | |12;stanford-crypto-pbkdf2;178;168;173;174;177;174;174;168;175;167 05:36:44 INFO - PID 4193 | |13;stanford-crypto-sha256-iterative;61;63;62;63;63;63;65;62;63;62 05:36:44 INFO - PID 4193 | __end_tp_report 05:36:44 INFO - PID 4193 | __start_cc_report 05:36:44 INFO - PID 4193 | _x_x_mozilla_cycle_collect,837 05:36:44 INFO - PID 4193 | __end_cc_report 05:36:44 INFO - PID 4193 | __startTimestamp1499258204463__endTimestamp 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | ------- Summary: start ------- 05:36:44 INFO - PID 4193 | Number of tests: 14 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#0] ai-astar Cycles:10 Average:106.20 Median:107.00 stddev:3.55 (3.3%) stddev-sans-first:3.77 05:36:44 INFO - PID 4193 | Values: 106.0 97.0 107.0 106.0 107.0 111.0 106.0 107.0 107.0 108.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:143.00 stddev:22.32 (15.6%) stddev-sans-first:23.62 05:36:44 INFO - PID 4193 | Values: 143.0 117.0 143.0 177.0 118.0 140.0 150.0 115.0 169.0 117.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 05:36:44 INFO - PID 4193 | Values: 163.0 163.0 161.0 161.0 162.0 167.0 162.0 161.0 161.0 164.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#3] audio-fft Cycles:10 Average:84.00 Median:74.00 stddev:26.28 (35.5%) stddev-sans-first:27.58 05:36:44 INFO - PID 4193 | Values: 73.0 74.0 73.0 157.0 74.0 75.0 74.0 75.0 92.0 73.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#4] audio-oscillator Cycles:10 Average:99.10 Median:81.00 stddev:29.40 (36.3%) stddev-sans-first:30.36 05:36:44 INFO - PID 4193 | Values: 80.0 82.0 141.0 80.0 81.0 81.0 144.0 81.0 81.0 140.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 05:36:44 INFO - PID 4193 | Values: 114.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 114.0 114.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 05:36:44 INFO - PID 4193 | Values: 147.0 147.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 149.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:36:44 INFO - PID 4193 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.50 stddev:2.35 (4.8%) stddev-sans-first:2.47 05:36:44 INFO - PID 4193 | Values: 49.0 48.0 49.0 46.0 46.0 51.0 53.0 47.0 47.0 46.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 05:36:44 INFO - PID 4193 | Values: 56.0 55.0 56.0 56.0 56.0 57.0 56.0 58.0 56.0 55.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:75.00 stddev:3.13 (4.2%) stddev-sans-first:3.27 05:36:44 INFO - PID 4193 | Values: 75.0 75.0 75.0 76.0 75.0 75.0 75.0 83.0 75.0 82.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:125.50 stddev:8.08 (6.4%) stddev-sans-first:8.57 05:36:44 INFO - PID 4193 | Values: 126.0 129.0 125.0 133.0 120.0 120.0 118.0 122.0 122.0 145.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:174.00 stddev:3.85 (2.2%) stddev-sans-first:3.60 05:36:44 INFO - PID 4193 | Values: 178.0 168.0 173.0 174.0 177.0 174.0 174.0 168.0 175.0 167.0 05:36:44 INFO - PID 4193 | 05:36:44 INFO - PID 4193 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 05:36:44 INFO - PID 4193 | Values: 61.0 63.0 62.0 63.0 63.0 63.0 65.0 62.0 63.0 62.0 05:36:44 INFO - PID 4193 | -------- Summary: end -------- 05:36:44 INFO - PID 4193 | 05:36:45 INFO - TEST-INFO | 4193: exit 0 05:36:45 INFO - TEST-OK | kraken | took 59507ms 05:36:45 INFO - SUITE-END | took 1172s 05:36:45 INFO - Completed test suite (00:19:32) 05:36:45 INFO - javascript benchmark 05:36:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8663.719056088761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.8850640227597, 3330.816805075721, 3369.696727294543, 3385.1029477188536, 3389.186595217148, 6164.938350616492, 6199.44205021548, 6204.069389591564, 6216.036514340279, 6309.463695585875, 6168.475679567242, 6255.906161407583, 6258.0, 6295.874082518347, 6304.275008374038, 5456.890862182754, 5493.670379777206, 5509.862253443656, 5530.557555395579, 5545.085060964936, 5502.889942201154, 5514.5864060195645, 5529.419410961851, 5554.583406244547, 5565.0, 5553.72231388431, 5560.9712203242325, 5565.582581306398, 5571.192177134313, 5575.2473416088715, 5542.0855558832745, 5542.91685624716, 5544.667319960775, 5568.387477377485, 5570.86072848182, 5473.17902314652, 5481.506664400184, 5498.752556134984, 5551.1118221084835, 5580.246666699984, 6234.719437625317, 6258.843528911813, 6277.905831412532, 6302.747890084391, 6309.779157729457, 6788.9660551696925, 6792.320767923217, 6846.623435711034, 6881.483888708367, 6891.035255064295, 6642.5350225484235, 6667.928023023079, 6728.4617230621925, 6728.629925354104, 6741.258461569223, 6275.058741188813, 6282.308946015934, 6284.4344009039405, 6348.111264422984, 6357.078223657544, 6879.690413931385, 6941.757038503628, 6949.513534052568, 7069.681864316118, 7074.575525468488, 6583.275839657634, 6693.842523063685, 6743.629100399427, 6755.594664320059, 6759.662016899136, 6695.230048544382, 6755.392014718601, 6773.762918297836, 6774.830629234309, 6781.898271525833, 6630.403263706289, 6634.170728658918, 6647.767328143588, 6655.201375834834, 6661.333866613397, 5278.736063196825, 6753.257141714407, 6852.246252912176, 6858.142732158481, 6864.759733409307, 5043.9747801260755, 5053.620978426559, 5125.231215317732, 5129.204973229155, 5133.9743301284, 4456.799444025027, 4459.888502787391, 4580.862574122782, 4589.541045895384, 4595.586397224199, 6214.0, 6215.098810672427, 6217.285012223561, 6218.471429928416, 6229.221347331583, 6627.469802415795, 6668.966655166693, 6675.365840245169, 6676.399124078856, 6682.0, 6150.323464418911, 6189.442950134509, 6212.223472065992, 6220.813375598739, 6230.43926046658, 5560.638558493685, 5572.331320241597, 5613.438656134354, 5624.91562626561, 5656.095024796013, 7072.257412971564, 7087.468439867031, 7120.608366539786, 7155.499115061895, 7178.353948144692, 6796.4562834973085, 6824.0, 6844.315568443116, 6910.827229319308, 6923.411510021705, 6958.547694399847, 7011.368976792113, 7057.470689698396, 7070.222275549789, 7131.82170445743, 6689.431398331197, 6691.464682825265, 6707.765228216989, 6720.428763554957, 6722.495812813961, 6857.348551887562, 6864.073350097673, 6929.89605155913, 6958.0, 6966.825829354307, 6595.670216489252, 6621.33786621334, 6630.403263706289, 6701.32986701326, 6718.160229971254, 6486.772962946275, 6548.869022619616, 6558.737650493927, 6691.46468282546, 6711.731530738716, 6533.509986751108, 6568.343165683585, 6608.140941677551, 6610.8347291318105, 6617.2721000688925, 5407.567394608501, 6546.672666366568, 6624.205095388585, 6625.569337993015, 6658.1344425224415, 6474.741010359533, 6478.546501744832, 6558.409743123142, 6564.081028656087, 6583.177102862142], "value": 6150.344434963154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.2768693514787, 940.3511577011863, 965.8406362950113, 1181.061056460114, 1188.6493484422094, 32051.839740801293, 32615.67384326156, 41104.0, 41913.0, 42041.57958420423, 42425.36361954566, 42802.0, 42804.785976070154, 42806.14387712244, 43003.35494967578, 7207.279272072803, 7309.086364204474, 7317.67070481827, 7317.817054573625, 7331.120265568139, 7220.350168484835, 7251.70993160273, 7281.599512026836, 7317.231690672456, 7363.042804435443, 7370.815729606776, 7406.8888966665545, 7412.851742965137, 7448.180700122982, 7450.14323352816, 7297.854042919165, 7329.120505539343, 7344.192138864721, 7349.779506614784, 7365.484416090876, 7216.530925489827, 7244.601546914971, 7258.0, 7291.963540182318, 7295.744648937261, 39401.60598394008, 39506.60493395058, 39692.007699807444, 39728.00679982995, 39865.60134398677, 3418.9316213675834, 3436.9484457733156, 3448.327576122657, 3455.94816077759, 3472.9826350868084, 29903.252418689488, 29989.550156747668, 30170.69829301701, 30227.0, 30242.54636180459, 4708.576228139484, 4836.298736683161, 4967.105920934267, 5016.423111342206, 5026.52248036436, 203541.0, 207739.0, 208889.0, 209113.0, 211374.0, 44424.3336349955, 50078.749606252466, 50239.24641130386, 50594.241086383736, 50801.74599126981, 53342.46657533375, 53583.0, 53592.19611705827, 53766.19350709742, 53781.1932821008, 16252.918735406483, 16275.186240687919, 16340.18299085041, 16397.180140992903, 16445.0, 13131.212127272394, 13190.076694631283, 13206.207627542186, 13213.33933303331, 13227.272500012592, 14426.927865360816, 14701.338439770023, 14732.484363047242, 14819.0, 14904.254787260594, 5942.346341902387, 6055.72749226277, 6091.08633704939, 6091.543134264948, 6100.298465676504, 1084.9186311026704, 1086.7826434713088, 1102.72431892027, 1107.7618312062946, 1130.141092769501, 23749.525009499714, 24109.638355424682, 24290.51418971611, 24364.390890227885, 24749.381265468506, 1183.6685727996176, 1200.3758045816128, 1202.4588934979295, 1208.528673817212, 1215.5927764199093, 12935.676608084685, 12983.675408114872, 13093.41079651418, 13103.60689179326, 13119.475220991244, 279797.0, 280870.0, 282708.0, 282929.0, 284006.0, 53599.196012059074, 54134.45865541373, 54194.72902635462, 54197.72901135548, 54286.45713542814, 1487.2638044168207, 1566.5926859016738, 1566.8589826915631, 1575.2360105348896, 1593.3148746039083, 24203.87898060569, 28117.297067573476, 28590.57114143248, 29012.709872901843, 29379.0, 52608.210876836114, 52956.0, 53022.0, 53343.46656533385, 53541.0, 248270.0, 248855.0, 249003.75498123118, 252125.0, 252205.0, 35460.82269588635, 35594.822025889705, 36479.0, 36763.816180918926, 37368.0, 45811.3128303069, 47101.528984709716, 47673.76163119162, 48280.0, 48444.273335900696, 34483.482747759306, 34506.482402763475, 34528.48207276843, 34743.82628086843, 35221.0, 33821.661783382835, 33854.322913542084, 33930.321393571496, 34244.82877585596, 35213.11967200738, 38929.221415572094, 39337.606623933396, 39801.0, 39870.20259594734, 40020.0, 32699.34601308008, 32747.181320467178, 33385.49921751127, 33577.49633755447, 33990.15024624404, 24536.877315613307, 24811.0, 25598.488030239663, 25708.0, 25848.741512584635], "value": 18101.543492761433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.6103727390824, 560.99861746782, 564.2298262871182, 584.9298084229893, 586.1852025684299, 22163.335099947006, 23199.420014499647, 23352.766472335272, 23415.531689366202, 23417.0, 24854.875725621347, 25982.090626828063, 27127.728722712767, 27326.180214593594, 27367.178984630442, 6112.358202388741, 6321.0, 6336.619802811846, 6342.048692696109, 6347.39699728525, 6256.468200202989, 6295.118683384329, 6303.086052522404, 6310.905336419957, 6315.021171718391, 5776.104703770922, 6051.848703782397, 6096.786612468564, 6237.220347456568, 6300.495960323163, 6130.1111338855835, 6136.048912418582, 6194.5354098442795, 6195.938040619581, 6199.256089269272, 5740.5981581289325, 5748.770049198027, 5771.307443106812, 5775.740091695884, 5780.421957804228, 28650.283742906384, 29826.40347193066, 29989.400211995857, 30223.0, 30228.09315720532, 2152.440365504964, 2193.111789725164, 2196.3520761375435, 2205.3494219205213, 2205.8125059369972, 19006.61986760257, 19573.608527829507, 19587.90206048975, 19603.31388401399, 19630.116644751022, 2379.559781440422, 2400.2199285232196, 2414.130912871365, 2429.465517586146, 2444.2667199839975, 133950.3302483491, 141651.0, 141790.0, 142016.28991854974, 142084.0, 14372.640683982774, 15193.924030379778, 15213.923930380277, 15468.767968480483, 15715.842841571437, 23837.165699200792, 23959.760402395754, 24038.759612403654, 24043.398915026915, 24105.0, 10375.84436233457, 10415.218858585637, 10463.790724185474, 10655.041046305869, 10689.9465502672, 9756.414615122972, 9796.706098817047, 9807.509624518745, 9850.556724947395, 9859.802803943881, 9163.043748292079, 9364.438133711863, 9421.528923553795, 9481.66814161501, 9666.178374838077, 2674.2378422149595, 2681.9731802682113, 2740.6163137160815, 2811.2269125990106, 2887.9928449727236, 1017.5827910556636, 1030.7680771826429, 1048.5438834107188, 1066.751900276678, 1074.2909679611419, 20556.897215513825, 21215.257465988616, 21355.03902324399, 21369.46576335573, 21384.0, 1117.603250845938, 1136.9602063927723, 1147.2428197389684, 1155.1163360029584, 1158.692946369213, 11488.368139752394, 11500.88499115015, 11766.117541184274, 11904.821427678591, 11974.98212651917, 612460.0, 626960.0, 636551.0, 636907.0, 651303.0, 124745.37627311805, 125332.37333813273, 128951.35524322506, 129018.0, 132085.0, 1254.9623511294676, 1267.3789842976876, 1270.7267937393506, 1293.043148070421, 1296.4554886947317, 17948.282068717628, 18051.187696553425, 18144.27422903122, 18214.544636384195, 19175.424737257905, 53289.20066198933, 53892.730536347066, 53934.0, 54131.72934135304, 55520.167197492876, 71239.0, 71352.28647713664, 75973.62013189899, 79768.0, 82953.58523207346, 18300.176492057624, 18620.16209270559, 18648.720269195703, 18828.152733127317, 18843.811561884206, 16277.186140693155, 16926.40757573479, 17061.744073839152, 20198.99005049771, 21002.47493812667, 13824.0, 16002.8399716006, 16539.75190372121, 16763.32946682119, 16779.748303775697, 14145.858541414455, 14447.205403702897, 14483.637909051937, 14564.708705826037, 15120.621984450478, 16628.916855415646, 16908.15459227009, 16999.575010624834, 17049.40327088546, 17076.91461542734, 18355.08224588792, 18688.719669205246, 18732.344367947055, 19019.619607607492, 19065.90467047656, 15485.148316842231, 15507.457238996582, 15636.92181539085, 15644.0, 16012.199390030219], "value": 12167.17038335659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.450816435672, 1457.701171259892, 1473.410635745702, 1474.9852501474982, 1483.7996870422496, 13065.412056457459, 14678.41286348546, 15192.620184495394, 15254.313555889983, 15286.464973725922, 12807.551735689252, 13022.0, 13040.347982600879, 14805.851941480581, 15146.091234525937, 2614.934626634335, 2663.1078588672817, 2676.8929242830263, 2682.7317268273214, 2684.2484104450787, 2673.5588627876473, 2690.7174746651613, 2695.3665888516184, 2708.8781004854827, 2719.9592006119824, 2576.3559110222445, 2594.195799302213, 2598.3374239568884, 2604.440045390241, 2614.3594819269306, 2568.4734629400928, 2594.7016093149246, 2595.390083330416, 2595.8182927195007, 2596.026490066225, 2399.3881560202212, 2452.411421258885, 2468.90124395024, 2477.6159695247266, 2490.514349701809, 14386.92806535971, 14558.92720536401, 14562.490312839, 14596.197209153492, 14603.853961460356, 7969.0, 8267.255946964802, 8272.751817445485, 8286.70996515119, 8296.336293096538, 4829.951700482985, 4889.559939605452, 5059.16523773577, 5086.593072554187, 5098.59211263098, 1857.7027675571978, 1873.9156737946826, 1946.347973428889, 1980.5444747707963, 1989.1844343818964, 25901.74098259012, 25967.480650386886, 26052.60921086166, 26069.348266293495, 26261.343466413302, 7242.348188663045, 7280.0, 7381.557106573623, 7500.324970752658, 7539.811504712426, 17387.391441299493, 19378.515537111685, 19434.22263109488, 19499.707504387447, 19506.12222449993, 8045.718399856094, 8267.29727973117, 8282.378821588405, 8309.210624990616, 8321.583920803936, 7537.2085930977555, 7594.202608726115, 7638.083429988437, 7669.118051424158, 7828.686852525949, 5251.317328747238, 5459.50864422196, 5462.863428414322, 5468.453154684579, 5512.944870551243, 1570.6701592665668, 1591.172590253062, 1593.6095656564216, 1617.660291338832, 1627.5198816348968, 903.9502827344559, 909.3452714045876, 930.9022552632011, 934.1079269297804, 946.068122898944, 7470.140933792574, 7520.887186692204, 8033.879491807627, 8189.1401402853035, 8194.836103277901, 715.9785206443815, 729.2270193594701, 734.8493558820429, 739.4306384084333, 743.2604558464254, 4539.954600454019, 4744.240921452551, 4860.8784780380065, 4940.20956646942, 4977.527134922177, 19718.211271549266, 20107.29624463137, 20170.69743953842, 20804.687929681066, 20873.68689469659, 21188.576228475344, 21821.67267490989, 21889.562208756055, 21935.451613709785, 22078.558428831333, 11877.465514051888, 11877.58428455, 11972.04223662105, 12099.0, 12101.394930253453, 7902.881456778038, 8148.959255203923, 8226.42415030966, 8243.752687419386, 8252.876206856781, 17877.821221787617, 18370.816291837444, 18560.164792584637, 18956.336528221447, 19167.32914347991, 18351.35770248035, 19016.668833181546, 19646.115924783706, 19771.308004219783, 19992.800071999674, 12352.75294494123, 12640.43118059708, 12642.55751048709, 12643.0, 12696.555620553236, 14028.0, 14029.719405612035, 14060.929695351459, 14078.084924479876, 14099.506517271846, 11171.162162837982, 11188.66434006981, 11689.590864319707, 11907.702307442383, 12070.094742894142, 10570.207234457293, 10899.891001090205, 11027.83458248111, 11133.554657813596, 11457.713557161138, 9649.9035009649, 9713.562889670124, 9717.708468745948, 9727.124558789743, 9740.561674724513, 6575.178102737158, 6881.174259088942, 6940.02839602446, 7014.649267536704, 7025.01649769043, 6753.898691519533, 6916.0, 6953.513254072166, 7000.369966703021, 7019.3682568569075], "value": 6613.4061955598245, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.6858547700425, 516.2050442318829, 519.5609709795223, 524.1168630857006, 537.884354863704, 6082.908756368658, 6084.0873868919625, 6158.6612736299485, 6160.229971253593, 6262.342454042323, 6053.818385448432, 6101.0848372744, 6135.29444113927, 6137.882430561461, 6159.722812473438, 4913.304909806111, 4963.329950456697, 4966.180580204262, 4966.453690094087, 4969.378827646544, 4975.800967961277, 4976.377952755905, 4978.825741099062, 4980.12847751642, 4986.127427700138, 4918.893249018978, 4931.408231012284, 4934.248341838649, 4970.950290497103, 4980.203167493201, 4899.628104130849, 4937.382827146606, 4967.950320496803, 4972.577330926875, 4992.950070499285, 4111.0605916769655, 4254.936175957363, 4283.935740963888, 4500.7299562026055, 4506.121306345264, 5855.121731740273, 5902.468777809975, 5932.822015339547, 5947.4052594740615, 5970.402959704038, 5608.5793565482345, 5636.859078523029, 5662.235598194232, 5685.914711279334, 5706.71466426677, 6514.3811337922825, 6525.575837570543, 6542.836429089263, 6545.639989800559, 6556.213254409454, 4795.400574928134, 4809.0, 4825.734584597846, 4858.562729354375, 4862.902741945141, 6516.0, 6723.831904202385, 6759.512907160417, 6769.424598909099, 6811.352921472452, 4905.460399356068, 4989.426215985208, 5018.698878067255, 5030.622703297267, 5042.520960508746, 5056.317397151338, 5056.469070747592, 5058.898822023539, 5063.670861393997, 5097.592192624581, 5646.096624540054, 5684.8863022739315, 5720.370759216483, 5734.025215713339, 5776.191333213354, 6476.35236476358, 6551.868962620816, 6561.80314590563, 6563.704633291513, 6584.0, 1762.480068379831, 1770.3803668716105, 1777.9644407111784, 1779.8309160629979, 1787.6782179207607, 1180.819180819181, 1238.646985609097, 1239.4732238798474, 1249.000799360508, 1258.8426446694164, 6097.987664070934, 6169.753209871645, 6190.628562286277, 6192.752289908443, 6279.183706118175, 6668.166479190101, 6716.429103526158, 6724.865502690017, 6750.864982700318, 6765.594064356154, 6145.8156255312415, 6161.630302181883, 6224.719887605069, 6233.532485063638, 6262.968685156637, 3550.6626870447267, 3556.541817854719, 3573.2317551726505, 3577.463380492895, 3577.713782897414, 6893.724251030003, 6898.793036208922, 6910.930890691029, 6933.4106600939485, 6979.581225126509, 6799.456043516507, 6837.794866154023, 6842.247352791189, 6889.0, 6958.269381714948, 6386.201724784495, 6890.276520965427, 6939.375456208965, 6944.51388402807, 6997.160340759141, 6610.4050635443045, 6617.900731489128, 6640.734370625314, 6693.0, 6716.462682985447, 6554.868902621825, 6562.228198386504, 6585.670716464062, 6605.339466053356, 6680.3987641112535, 6915.550489218386, 6918.952412838546, 6960.990656354901, 6965.65171741421, 7006.719731210898, 5022.623303252344, 5052.25697134488, 5057.0, 5063.645544811828, 5091.363579552556, 6526.379993900572, 6671.499637527302, 6721.966390168213, 6745.3591908768585, 6754.93245067543, 6376.521760868046, 6507.0, 6558.540902136995, 6569.605823650596, 6617.470602351704, 6464.612123272619, 6499.870002599827, 6517.7067031984625, 6520.0, 6543.443807276244, 6408.212427594011, 6487.253965793994, 6538.509611779041, 6541.92529511129, 6556.737730490918, 6568.573042752206, 6577.638229897401, 6606.471482281502, 6613.768518102036, 6632.568883022588, 6427.232511059496, 6444.613323200623, 6457.61254324742, 6504.284528701934, 6520.836979075371], "value": 5089.805039024679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.2478017585929, 954.2509130332691, 955.8422860228063, 961.5048250151178, 982.4743762087282, 17726.290948362068, 18691.439256822316, 18701.81298187018, 18702.251909923605, 18708.345207917726, 16299.348026078942, 16601.335946562154, 16658.83341166588, 19524.41426757196, 20678.689819652718, 1062.6015244283374, 1080.1952545353722, 1084.696285040186, 1094.3051162511822, 1094.6934858239665, 1069.9144068474543, 1070.3952266969138, 1071.2661826648732, 1076.3219171921678, 1076.7792602516504, 1125.6397952655154, 1130.4347826086957, 1134.1437214902778, 1139.641013080877, 1140.7091191746135, 1122.6688127002553, 1126.9492872820701, 1135.5401062569672, 1194.552042983881, 1202.8977536909285, 769.730594291999, 790.5059337913804, 799.6121880887765, 800.9627532345627, 803.0323460230409, 18573.814261857344, 18922.337718179937, 19206.135723892457, 19286.228550857948, 19304.0, 19432.70850937237, 19703.211871525124, 19704.507387315287, 19896.20415183391, 20002.0, 14859.777103343351, 14867.628309292246, 14916.030458020303, 14992.025518341274, 15028.0, 3518.5249991251108, 3541.1501239702543, 3543.698785603227, 3553.9111522211892, 3556.78659280444, 92701.5364923171, 115105.0, 121820.0, 123836.38081809624, 127602.0, 13954.162750235018, 14242.928785356007, 14882.553523394316, 16557.668846623, 16938.661226775643, 29161.0, 30658.69341306603, 30759.8462007693, 30840.845795770878, 30947.0715878524, 8567.314614830799, 8816.294696424398, 8886.24466920319, 8887.15572020657, 8906.910930890608, 4248.214080395137, 4284.871453856389, 4298.871033868989, 4314.784260786948, 4317.892052698645, 5074.13739664258, 5147.974260128675, 5149.021685879671, 5209.218617207373, 5295.549878260314, 1010.8938561451089, 1042.781015986636, 1051.0277992856577, 1051.9579216831394, 1054.4095306628312, 652.5856081388258, 659.970301336441, 671.8689855478135, 671.9563228390236, 695.4992405468055, 11655.76688466243, 13209.603711888658, 13459.3943272551, 13492.460301587827, 13513.662158446117, 660.2967839251278, 666.6366830077619, 684.1960696182066, 684.4934748286232, 689.1489011071322, 5543.7782488700805, 6532.5753826001155, 6598.802035938929, 6622.867542649216, 6903.516753827284, 111480.0, 114387.0, 117194.41402792932, 118078.0, 119140.4042979797, 99464.0, 103176.48411757893, 105119.0, 105811.4709426448, 107274.0, 86595.0, 94697.0, 94983.0, 98644.50677746709, 99454.50272748734, 13207.933960330136, 13468.595942121752, 13517.188968661912, 13634.250116243702, 13641.454341826613, 44547.88630284139, 44634.3304850434, 45032.77483612692, 45264.54735452735, 46192.76903615595, 56442.43557564536, 57681.711591443454, 58115.418845812696, 58249.70875145597, 59034.704826475594, 15975.121368324853, 16275.18624068768, 16435.17824108766, 16565.17174141264, 16713.997160170427, 17950.640987180446, 18686.719699204794, 18762.15570299367, 18936.147873346006, 19153.425397238105, 19130.904345478182, 19476.4157075288, 19923.701144482555, 20007.59984800325, 20029.899850500653, 18811.71782423292, 19047.809521905157, 19239.326623568108, 19932.90033549823, 20512.38462846117, 18167.45497635073, 19031.90484047571, 19136.71294930605, 19261.22955081781, 19785.40643780689, 13809.930950345184, 14069.437222511395, 14441.989060766065, 14544.709105817612, 14558.12651240929, 14687.0, 15738.842611573738, 15759.606009849387, 15842.52472425829, 16113.274902629644], "value": 9274.015847589899, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 97.0, 107.0, 106.0, 107.0, 111.0, 106.0, 107.0, 107.0, 108.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 143.0, 177.0, 118.0, 140.0, 150.0, 115.0, 169.0, 117.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 167.0, 162.0, 161.0, 161.0, 164.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 157.0, 74.0, 75.0, 74.0, 75.0, 92.0, 73.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 82.0, 141.0, 80.0, 81.0, 81.0, 144.0, 81.0, 81.0, 140.0], "value": 99.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 49.0, 46.0, 46.0, 51.0, 53.0, 47.0, 47.0, 46.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 75.0, 75.0, 75.0, 83.0, 75.0, 82.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 125.0, 133.0, 120.0, 120.0, 118.0, 122.0, 122.0, 145.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 168.0, 173.0, 174.0, 177.0, 174.0, 174.0, 168.0, 175.0, 167.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 63.0, 63.0, 65.0, 62.0, 63.0, 62.0], "value": 62.7, "unit": "score"}]}]} 05:36:45 INFO - Return code: 0 05:36:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:45 INFO - # TBPL SUCCESS # 05:36:45 INFO - Running post-action listener: _package_coverage_data 05:36:45 INFO - Running post-action listener: _resource_record_post_action 05:36:45 INFO - [mozharness: 2017-07-05 12:36:45.295835Z] Finished run-tests step (success) 05:36:45 INFO - Running post-run listener: _resource_record_post_run 05:36:45 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 5791744; Write bytes: 439668736; Read time: 1744; Write time: 421776 05:36:45 INFO - TinderboxPrint: CPU usage
13.1% 05:36:45 INFO - TinderboxPrint: I/O read bytes / time
5,791,744 / 1,744 05:36:45 INFO - TinderboxPrint: I/O write bytes / time
439,668,736 / 421,776 05:36:45 INFO - TinderboxPrint: CPU idle
8,257.2 (86.9%) 05:36:45 INFO - TinderboxPrint: CPU user
1,190.0 (12.5%) 05:36:45 INFO - TinderboxPrint: Swap in / out
0 / 0 05:36:45 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 40960; Write bytes: 114962432; Read time: 260; Write time: 124296 05:36:45 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:36:45 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 3383296; Write bytes: 324706304; Read time: 1064; Write time: 297480 05:36:45 INFO - Running post-run listener: _upload_blobber_files 05:36:45 INFO - Blob upload gear active. 05:36:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:45 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:36:45 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:36:45 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:36:46 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:50 INFO - (blobuploader) - INFO - Done attempting. 05:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:36:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:50 INFO - (blobuploader) - INFO - Done attempting. 05:36:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:36:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:36:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:51 INFO - (blobuploader) - INFO - Done attempting. 05:36:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:36:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:52 INFO - (blobuploader) - INFO - Done attempting. 05:36:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:52 INFO - Return code: 0 05:36:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3aa28025ac6b54a6cfdd6eb8af4607b015d2f9ee94167c5361e2b644b9e37e11a6c8ac4c13d9084585da48cda38dbfc42d4ce59b2086f53929deae7bdf4ba36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d7299c16dc511c14a9e0bca13730b8b348144fc803f6fa073f51a046e96822ee2229b05f8e184d385fb050d1e882b6b2e71d7e402ffceb9f1614883d42ec7f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ddbdca4169d097c8dba7e3a5c8b430cd0f7a5c163af236c74af25cfb352c1e26ecae5e33a2e698a6c4559483bd3b5ecbfc9212890edbc4656957bb3a0415818", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3316415c50acbaa4a0aa26551098ef1d3b700749c0fb0b7144e12750bd1d140d537fd31901486376ec8c04e643a0a6ce3580d20e843198ef1d1b8e0d15a596a"} 05:36:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:52 INFO - Contents: 05:36:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3aa28025ac6b54a6cfdd6eb8af4607b015d2f9ee94167c5361e2b644b9e37e11a6c8ac4c13d9084585da48cda38dbfc42d4ce59b2086f53929deae7bdf4ba36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d7299c16dc511c14a9e0bca13730b8b348144fc803f6fa073f51a046e96822ee2229b05f8e184d385fb050d1e882b6b2e71d7e402ffceb9f1614883d42ec7f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ddbdca4169d097c8dba7e3a5c8b430cd0f7a5c163af236c74af25cfb352c1e26ecae5e33a2e698a6c4559483bd3b5ecbfc9212890edbc4656957bb3a0415818", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3316415c50acbaa4a0aa26551098ef1d3b700749c0fb0b7144e12750bd1d140d537fd31901486376ec8c04e643a0a6ce3580d20e843198ef1d1b8e0d15a596a"} 05:36:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:52 INFO - Copying logs to upload dir... 05:36:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.066239 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-07-05 05:36:52.332533) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-05 05:36:52.336865) ========= 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=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3aa28025ac6b54a6cfdd6eb8af4607b015d2f9ee94167c5361e2b644b9e37e11a6c8ac4c13d9084585da48cda38dbfc42d4ce59b2086f53929deae7bdf4ba36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d7299c16dc511c14a9e0bca13730b8b348144fc803f6fa073f51a046e96822ee2229b05f8e184d385fb050d1e882b6b2e71d7e402ffceb9f1614883d42ec7f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ddbdca4169d097c8dba7e3a5c8b430cd0f7a5c163af236c74af25cfb352c1e26ecae5e33a2e698a6c4559483bd3b5ecbfc9212890edbc4656957bb3a0415818", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3316415c50acbaa4a0aa26551098ef1d3b700749c0fb0b7144e12750bd1d140d537fd31901486376ec8c04e643a0a6ce3580d20e843198ef1d1b8e0d15a596a"} build_url:https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/V7W_LOs0SyCVuX49DYd0eQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3aa28025ac6b54a6cfdd6eb8af4607b015d2f9ee94167c5361e2b644b9e37e11a6c8ac4c13d9084585da48cda38dbfc42d4ce59b2086f53929deae7bdf4ba36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d7299c16dc511c14a9e0bca13730b8b348144fc803f6fa073f51a046e96822ee2229b05f8e184d385fb050d1e882b6b2e71d7e402ffceb9f1614883d42ec7f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ddbdca4169d097c8dba7e3a5c8b430cd0f7a5c163af236c74af25cfb352c1e26ecae5e33a2e698a6c4559483bd3b5ecbfc9212890edbc4656957bb3a0415818", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3316415c50acbaa4a0aa26551098ef1d3b700749c0fb0b7144e12750bd1d140d537fd31901486376ec8c04e643a0a6ce3580d20e843198ef1d1b8e0d15a596a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-05 05:36:52.360406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:36:52.363707) ========= 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=03627c79f6bb3d1578c4a402000001ba-1499255696.761484-657875746 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-05 05:36:52.444154) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-05 05:36:52.444444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-05 05:36:52.447722) ========= ========= Total master_lag: 0.07 =========