builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1496655902.09 results: success (0) revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.093753) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.094212) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.094486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.110142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.110418) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 02:45:03-- 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% 37.6M=0s 2017-06-05 02:45:03 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076667 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.200436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.200765) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019968 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:02.252786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:45:02.253223) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 --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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 02:45:03,583 truncating revision to first 12 chars 2017-06-05 02:45:03,583 Setting DEBUG logging. 2017-06-05 02:45:03,583 attempt 1/10 2017-06-05 02:45:03,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7d5df2dead2c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 02:45:04,396 unpacking tar archive at: mozilla-central-7d5df2dead2c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.116188 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:45:03.382943) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:03.383309) ========= script_repo_revision: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:03.383736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:03.384008) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:45:03.395201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-06-05 02:45:03.395537) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:45:04 INFO - MultiFileLogger online at 20170605 02:45:04 in /builds/slave/test 02:45:04 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 02:45:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:45:04 INFO - {'append_to_log': False, 02:45:04 INFO - 'base_work_dir': '/builds/slave/test', 02:45:04 INFO - 'blob_upload_branch': 'Firefox', 02:45:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:45:04 INFO - 'branch': 'Firefox', 02:45:04 INFO - 'buildbot_json_path': 'buildprops.json', 02:45:04 INFO - 'config_files': ('talos/linux_config.py',), 02:45:04 INFO - 'default_actions': ('clobber', 02:45:04 INFO - 'read-buildbot-config', 02:45:04 INFO - 'download-and-extract', 02:45:04 INFO - 'populate-webroot', 02:45:04 INFO - 'create-virtualenv', 02:45:04 INFO - 'install', 02:45:04 INFO - 'setup-mitmproxy', 02:45:04 INFO - 'run-tests'), 02:45:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:45:04 INFO - 'download_minidump_stackwalk': True, 02:45:04 INFO - 'download_symbols': 'ondemand', 02:45:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:45:04 INFO - 'tooltool.py': '/tools/tooltool.py', 02:45:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:45:04 INFO - '/tools/misc-python/virtualenv.py')}, 02:45:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:45:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:45:04 INFO - 'gecko_profile': False, 02:45:04 INFO - 'gecko_profile_interval': 0, 02:45:04 INFO - 'installer_path': 'installer.exe', 02:45:04 INFO - 'log_level': 'info', 02:45:04 INFO - 'log_name': 'talos', 02:45:04 INFO - 'log_to_console': True, 02:45:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:45:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:45:04 INFO - 'opt_config_files': (), 02:45:04 INFO - 'pip_index': False, 02:45:04 INFO - 'suite': 'dromaeojs-e10s', 02:45:04 INFO - 'system_bits': '32', 02:45:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:45:04 INFO - 'title': 'talos-linux64-ix-051', 02:45:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:45:04 INFO - 'use_talos_json': True, 02:45:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:45:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:45:04 INFO - 'work_dir': 'build'} 02:45:04 INFO - [mozharness: 2017-06-05 09:45:04.817920Z] Running clobber step. 02:45:04 INFO - Running pre-action listener: _resource_record_pre_action 02:45:04 INFO - Running main action method: clobber 02:45:04 INFO - rmtree: /builds/slave/test/build 02:45:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:45:05 INFO - Running post-action listener: _resource_record_post_action 02:45:05 INFO - [mozharness: 2017-06-05 09:45:05.866551Z] Finished clobber step (success) 02:45:05 INFO - [mozharness: 2017-06-05 09:45:05.866653Z] Running read-buildbot-config step. 02:45:05 INFO - Running pre-action listener: _resource_record_pre_action 02:45:05 INFO - Running main action method: read_buildbot_config 02:45:05 INFO - Using buildbot properties: 02:45:05 INFO - { 02:45:05 INFO - "project": "", 02:45:05 INFO - "product": "firefox", 02:45:05 INFO - "who": "archaeopteryx@coole-files.de", 02:45:05 INFO - "installer_path": "public/build/target.tar.bz2", 02:45:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:45:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:45:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:45:05 INFO - "stage_platform": "linux64-stylosequential", 02:45:05 INFO - "basedir": "/builds/slave/test", 02:45:05 INFO - "buildnumber": 42, 02:45:05 INFO - "platform": "ubuntu64_hw_styloseq", 02:45:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:45:05 INFO - "slavebuilddir": "test", 02:45:05 INFO - "taskId": "Ynup9J12TS22Yaa6SBJ2zw", 02:45:05 INFO - "branch": "mozilla-central", 02:45:05 INFO - "script_repo_revision": "production", 02:45:05 INFO - "revision": "7d5df2dead2c9edaa41688a82d9d9dcc86529ef2", 02:45:05 INFO - "slavename": "talos-linux64-ix-051", 02:45:05 INFO - "repo_path": "mozilla-central" 02:45:05 INFO - } 02:45:05 INFO - Finding installer, test and symbols from parent task. 02:45:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ynup9J12TS22Yaa6SBJ2zw'}, attempt #1 02:45:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ynup9J12TS22Yaa6SBJ2zw'}, attempt #1 02:45:06 INFO - Task dependencies: NVsSSnvXTZSfWgd9XpcK7A 02:45:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A'}, attempt #1 02:45:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:45:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/test_packages.json 02:45:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip 02:45:07 INFO - Running post-action listener: _resource_record_post_action 02:45:07 INFO - [mozharness: 2017-06-05 09:45:07.213771Z] Finished read-buildbot-config step (success) 02:45:07 INFO - [mozharness: 2017-06-05 09:45:07.213990Z] Running download-and-extract step. 02:45:07 INFO - Running pre-action listener: _resource_record_pre_action 02:45:07 INFO - Running main action method: download_and_extract 02:45:07 INFO - mkdir: /builds/slave/test/build/tests 02:45:07 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')]} 02:45:07 INFO - trying https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json 02:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:45:07 INFO - Downloaded 989 bytes. 02:45:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:45:07 INFO - Using the following test package requirements: 02:45:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:45:07 INFO - u'common': [u'target.common.tests.zip'], 02:45:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:45:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:45:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:45:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:45:07 INFO - u'mozbase': [u'target.common.tests.zip'], 02:45:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:45:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:45:07 INFO - u'web-platform': [u'target.common.tests.zip', 02:45:07 INFO - u'target.web-platform.tests.tar.gz'], 02:45:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:45:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip 02:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip into memory 02:45:08 INFO - Content-Length response header: 65102564 02:45:08 INFO - Bytes received: 65102564 02:45:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:45:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip 02:45:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:45:19 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.common.tests.zip into memory 02:45:21 INFO - Content-Length response header: 65102564 02:45:21 INFO - Bytes received: 65102564 02:45:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip 02:45:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:45:32 INFO - Fetch https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.talos.tests.zip into memory 02:45:33 INFO - Content-Length response header: 14447425 02:45:33 INFO - Bytes received: 14447425 02:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:45:34 INFO - trying https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:45:34 INFO - Downloading https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:45:35 INFO - Downloaded 60348594 bytes. 02:45:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:45:35 INFO - mkdir: /builds/slave/test/properties 02:45:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:45:35 INFO - Writing to file /builds/slave/test/properties/build_url 02:45:35 INFO - Contents: 02:45:35 INFO - build_url:https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 02:45:35 INFO - Running post-action listener: _resource_record_post_action 02:45:35 INFO - Running post-action listener: set_extra_try_arguments 02:45:35 INFO - [mozharness: 2017-06-05 09:45:35.130900Z] Finished download-and-extract step (success) 02:45:35 INFO - [mozharness: 2017-06-05 09:45:35.130997Z] Running populate-webroot step. 02:45:35 INFO - Running pre-action listener: _resource_record_pre_action 02:45:35 INFO - Running main action method: populate_webroot 02:45:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:45:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:45:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:45:35 INFO - '--tppagecycles', 02:45:35 INFO - '7'], 02:45:35 INFO - 'tests': ['tsvgm']}}, 02:45:35 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:45:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:45:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:45:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:45:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['damp', 'tps']}, 02:45:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'tests': ['damp', 'tps']}, 02:45:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['dromaeo_dom']}, 02:45:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:45:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:45:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:45:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:45:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'other-e10s': {'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['a11yr', 02:45:35 INFO - 'ts_paint', 02:45:35 INFO - 'tpaint', 02:45:35 INFO - 'sessionrestore', 02:45:35 INFO - 'sessionrestore_no_auto_restore', 02:45:35 INFO - 'tabpaint']}, 02:45:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:45:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:45:35 INFO - 'bloom_basic_ref']}, 02:45:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:45:35 INFO - 'talos_options': ['--mitmproxy', 02:45:35 INFO - 'mitmproxy-recording-1.mp', 02:45:35 INFO - '--firstNonBlankPaint'], 02:45:35 INFO - 'tests': ['Quantum_1']}, 02:45:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['tsvgx', 02:45:35 INFO - 'tsvgr_opacity', 02:45:35 INFO - 'tart', 02:45:35 INFO - 'tscrollx', 02:45:35 INFO - 'cart', 02:45:35 INFO - 'tsvg_static']}, 02:45:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:45:35 INFO - 'tsvgr_opacity', 02:45:35 INFO - 'tart', 02:45:35 INFO - 'tscrollx', 02:45:35 INFO - 'cart', 02:45:35 INFO - 'tsvg_static']}, 02:45:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'talos_options': ['--disable-e10s'], 02:45:35 INFO - 'tests': ['tp5o']}, 02:45:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:45:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'talos_options': ['--disable-e10s', 02:45:35 INFO - '--xperf_path', 02:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:35 INFO - 'tests': ['tp5n']}, 02:45:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:45:35 INFO - 'talos_options': ['--xperf_path', 02:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:45:35 INFO - 'tests': ['tp5n']}}, 02:45:35 INFO - 'talos.zip': {'path': '', 02:45:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:45:35 INFO - Running post-action listener: _resource_record_post_action 02:45:35 INFO - [mozharness: 2017-06-05 09:45:35.145835Z] Finished populate-webroot step (success) 02:45:35 INFO - [mozharness: 2017-06-05 09:45:35.145926Z] Running create-virtualenv step. 02:45:35 INFO - Running pre-action listener: _resource_record_pre_action 02:45:35 INFO - Running main action method: create_virtualenv 02:45:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:45:35 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 02:45:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:45:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:45:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:45:35 INFO - Using real prefix '/usr' 02:45:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:45:35 INFO - Installing distribute.............................................................................................................................................................................................done. 02:45:37 INFO - Installing pip.................done. 02:45:37 INFO - Return code: 0 02:45:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:45:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:45:37 INFO - Reading from file tmpfile_stdout 02:45:37 INFO - Output received: 02:45:37 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) 02:45:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:45:37 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')]} 02:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:37 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')]} 02:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:37 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:37 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 02:45:37 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 02:45:37 INFO - Using env: {'DISPLAY': ':0', 02:45:37 INFO - 'HOME': '/home/cltbld', 02:45:37 INFO - 'LANG': 'en_US.UTF-8', 02:45:37 INFO - 'LANGUAGE': 'en_US:en', 02:45:37 INFO - 'LOGNAME': 'cltbld', 02:45:37 INFO - 'MAIL': '/var/mail/cltbld', 02:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:37 INFO - 'MOZ_NO_REMOTE': '1', 02:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:37 INFO - 'NO_EM_RESTART': '1', 02:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:37 INFO - 'PWD': '/builds/slave/test', 02:45:37 INFO - 'SHELL': '/bin/bash', 02:45:37 INFO - 'SHLVL': '1', 02:45:37 INFO - 'TERM': 'linux', 02:45:37 INFO - 'TMOUT': '86400', 02:45:37 INFO - 'USER': 'cltbld', 02:45:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:37 INFO - '_': '/tools/buildbot/bin/python'} 02:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:38 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 02:45:38 INFO - Cleaning up... 02:45:38 INFO - Return code: 0 02:45:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45: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')]} 02:45:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45: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', '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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:45: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 psutil>=3.1.1 02:45:38 INFO - Using env: {'DISPLAY': ':0', 02:45:38 INFO - 'HOME': '/home/cltbld', 02:45:38 INFO - 'LANG': 'en_US.UTF-8', 02:45:38 INFO - 'LANGUAGE': 'en_US:en', 02:45:38 INFO - 'LOGNAME': 'cltbld', 02:45:38 INFO - 'MAIL': '/var/mail/cltbld', 02:45:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:38 INFO - 'MOZ_NO_REMOTE': '1', 02:45:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:38 INFO - 'NO_EM_RESTART': '1', 02:45:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:38 INFO - 'PWD': '/builds/slave/test', 02:45:38 INFO - 'SHELL': '/bin/bash', 02:45:38 INFO - 'SHLVL': '1', 02:45:38 INFO - 'TERM': 'linux', 02:45:38 INFO - 'TMOUT': '86400', 02:45:38 INFO - 'USER': 'cltbld', 02:45:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:38 INFO - '_': '/tools/buildbot/bin/python'} 02:45:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:38 INFO - Downloading/unpacking psutil>=3.1.1 02:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:45:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:39 INFO - Installing collected packages: psutil 02:45:39 INFO - Running setup.py install for psutil 02:45:39 INFO - building 'psutil._psutil_linux' extension 02:45:39 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 02:45:39 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 02:45:39 INFO - building 'psutil._psutil_posix' extension 02:45:39 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 02:45:39 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 02:45:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:45:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:45:40 INFO - Successfully installed psutil 02:45:40 INFO - Cleaning up... 02:45:40 INFO - Return code: 0 02:45:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45: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')]} 02:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:45: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 mozsystemmonitor==0.3 02:45:40 INFO - Using env: {'DISPLAY': ':0', 02:45:40 INFO - 'HOME': '/home/cltbld', 02:45:40 INFO - 'LANG': 'en_US.UTF-8', 02:45:40 INFO - 'LANGUAGE': 'en_US:en', 02:45:40 INFO - 'LOGNAME': 'cltbld', 02:45:40 INFO - 'MAIL': '/var/mail/cltbld', 02:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:40 INFO - 'MOZ_NO_REMOTE': '1', 02:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:40 INFO - 'NO_EM_RESTART': '1', 02:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:40 INFO - 'PWD': '/builds/slave/test', 02:45:40 INFO - 'SHELL': '/bin/bash', 02:45:40 INFO - 'SHLVL': '1', 02:45:40 INFO - 'TERM': 'linux', 02:45:40 INFO - 'TMOUT': '86400', 02:45:40 INFO - 'USER': 'cltbld', 02:45:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:40 INFO - '_': '/tools/buildbot/bin/python'} 02:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:45: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 02:45: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 02:45: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 02:45: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 02:45:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:45:41 INFO - Installing collected packages: mozsystemmonitor 02:45:41 INFO - Running setup.py install for mozsystemmonitor 02:45:41 INFO - Successfully installed mozsystemmonitor 02:45:41 INFO - Cleaning up... 02:45:41 INFO - Return code: 0 02:45:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:45:41 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')]} 02:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:41 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')]} 02:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:41 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:41 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 02:45:41 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 02:45:41 INFO - Using env: {'DISPLAY': ':0', 02:45:41 INFO - 'HOME': '/home/cltbld', 02:45:41 INFO - 'LANG': 'en_US.UTF-8', 02:45:41 INFO - 'LANGUAGE': 'en_US:en', 02:45:41 INFO - 'LOGNAME': 'cltbld', 02:45:41 INFO - 'MAIL': '/var/mail/cltbld', 02:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:41 INFO - 'MOZ_NO_REMOTE': '1', 02:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:41 INFO - 'NO_EM_RESTART': '1', 02:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:41 INFO - 'PWD': '/builds/slave/test', 02:45:41 INFO - 'SHELL': '/bin/bash', 02:45:41 INFO - 'SHLVL': '1', 02:45:41 INFO - 'TERM': 'linux', 02:45:41 INFO - 'TMOUT': '86400', 02:45:41 INFO - 'USER': 'cltbld', 02:45:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:41 INFO - '_': '/tools/buildbot/bin/python'} 02:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:41 INFO - Downloading/unpacking jsonschema==2.5.1 02:45: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 02:45: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 02:45: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 02:45: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 02:45:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:45:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:45: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 02:45: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 02:45: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 02:45: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 02:45:43 INFO - Downloading functools32-3.2.3-2.tar.gz 02:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:45:43 INFO - warning: no files found matching '*.txt' 02:45:43 INFO - no previously-included directories found matching 'build' 02:45:43 INFO - no previously-included directories found matching 'dist' 02:45:43 INFO - no previously-included directories found matching '.git*' 02:45:43 INFO - Installing collected packages: jsonschema, functools32 02:45:43 INFO - Running setup.py install for functools32 02:45:43 INFO - warning: no files found matching '*.txt' 02:45:43 INFO - no previously-included directories found matching 'build' 02:45:43 INFO - no previously-included directories found matching 'dist' 02:45:43 INFO - no previously-included directories found matching '.git*' 02:45:43 INFO - Successfully installed jsonschema functools32 02:45:43 INFO - Cleaning up... 02:45:43 INFO - Return code: 0 02:45:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:45:43 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')]} 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:43 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')]} 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:43 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:43 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 02:45:43 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 02:45:43 INFO - Using env: {'DISPLAY': ':0', 02:45:43 INFO - 'HOME': '/home/cltbld', 02:45:43 INFO - 'LANG': 'en_US.UTF-8', 02:45:43 INFO - 'LANGUAGE': 'en_US:en', 02:45:43 INFO - 'LOGNAME': 'cltbld', 02:45:43 INFO - 'MAIL': '/var/mail/cltbld', 02:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:43 INFO - 'MOZ_NO_REMOTE': '1', 02:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:43 INFO - 'NO_EM_RESTART': '1', 02:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:43 INFO - 'PWD': '/builds/slave/test', 02:45:43 INFO - 'SHELL': '/bin/bash', 02:45:43 INFO - 'SHLVL': '1', 02:45:43 INFO - 'TERM': 'linux', 02:45:43 INFO - 'TMOUT': '86400', 02:45:43 INFO - 'USER': 'cltbld', 02:45:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:43 INFO - '_': '/tools/buildbot/bin/python'} 02:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:45:43 INFO - Cleaning up... 02:45:43 INFO - Return code: 0 02:45:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:45:43 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')]} 02:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:43 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')]} 02:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:43 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:43 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 02:45:43 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 02:45:43 INFO - Using env: {'DISPLAY': ':0', 02:45:43 INFO - 'HOME': '/home/cltbld', 02:45:43 INFO - 'LANG': 'en_US.UTF-8', 02:45:43 INFO - 'LANGUAGE': 'en_US:en', 02:45:43 INFO - 'LOGNAME': 'cltbld', 02:45:43 INFO - 'MAIL': '/var/mail/cltbld', 02:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:43 INFO - 'MOZ_NO_REMOTE': '1', 02:45:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:43 INFO - 'NO_EM_RESTART': '1', 02:45:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:43 INFO - 'PWD': '/builds/slave/test', 02:45:43 INFO - 'SHELL': '/bin/bash', 02:45:43 INFO - 'SHLVL': '1', 02:45:43 INFO - 'TERM': 'linux', 02:45:43 INFO - 'TMOUT': '86400', 02:45:43 INFO - 'USER': 'cltbld', 02:45:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:43 INFO - '_': '/tools/buildbot/bin/python'} 02:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:43 INFO - Downloading/unpacking blobuploader==1.2.4 02:45: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 02:45: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 02:45: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 02:45: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 02:45:44 INFO - Downloading blobuploader-1.2.4.tar.gz 02:45:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:45:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:45: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 02:45: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 02:45: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 02:45: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 02:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:45:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:45:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:45:45 INFO - Downloading docopt-0.6.1.tar.gz 02:45:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:45:45 INFO - Installing collected packages: blobuploader, requests, docopt 02:45:45 INFO - Running setup.py install for blobuploader 02:45:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:45:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:45:45 INFO - Running setup.py install for requests 02:45:45 INFO - Running setup.py install for docopt 02:45:46 INFO - Successfully installed blobuploader requests docopt 02:45:46 INFO - Cleaning up... 02:45:46 INFO - Return code: 0 02:45:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:46 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')]} 02:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:46 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')]} 02:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:46 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:46 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 02:45:46 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 02:45:46 INFO - Using env: {'DISPLAY': ':0', 02:45:46 INFO - 'HOME': '/home/cltbld', 02:45:46 INFO - 'LANG': 'en_US.UTF-8', 02:45:46 INFO - 'LANGUAGE': 'en_US:en', 02:45:46 INFO - 'LOGNAME': 'cltbld', 02:45:46 INFO - 'MAIL': '/var/mail/cltbld', 02:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:46 INFO - 'MOZ_NO_REMOTE': '1', 02:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:46 INFO - 'NO_EM_RESTART': '1', 02:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:46 INFO - 'PWD': '/builds/slave/test', 02:45:46 INFO - 'SHELL': '/bin/bash', 02:45:46 INFO - 'SHLVL': '1', 02:45:46 INFO - 'TERM': 'linux', 02:45:46 INFO - 'TMOUT': '86400', 02:45:46 INFO - 'USER': 'cltbld', 02:45:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:46 INFO - '_': '/tools/buildbot/bin/python'} 02:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:46 INFO - Running setup.py (path:/tmp/pip-ph2J8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:46 INFO - Running setup.py (path:/tmp/pip-hHVhsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:46 INFO - Running setup.py (path:/tmp/pip-rnrBoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:46 INFO - Running setup.py (path:/tmp/pip-IvGZ3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:46 INFO - Running setup.py (path:/tmp/pip-_LP5mT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:46 INFO - Running setup.py (path:/tmp/pip-5RcpsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:46 INFO - Running setup.py (path:/tmp/pip-9J_NpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:46 INFO - Running setup.py (path:/tmp/pip-UxjwOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:46 INFO - Running setup.py (path:/tmp/pip-zOU2hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:46 INFO - Running setup.py (path:/tmp/pip-ac9Q1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:47 INFO - Running setup.py (path:/tmp/pip-YiU9de-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:47 INFO - Running setup.py (path:/tmp/pip-tyqB3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:47 INFO - Running setup.py (path:/tmp/pip-moXqwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:47 INFO - Running setup.py (path:/tmp/pip-uPzrn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:47 INFO - Running setup.py (path:/tmp/pip-fVKPCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:47 INFO - Running setup.py (path:/tmp/pip-UNZ1gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:47 INFO - Running setup.py (path:/tmp/pip-Qk7PPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:45:47 INFO - Running setup.py install for manifestparser 02:45:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:45:47 INFO - Running setup.py install for mozcrash 02:45:47 INFO - Running setup.py install for mozdebug 02:45:47 INFO - Running setup.py install for mozdevice 02:45:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:45:47 INFO - Running setup.py install for mozfile 02:45:48 INFO - Running setup.py install for mozhttpd 02:45:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozinfo 02:45:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozInstall 02:45:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozleak 02:45:48 INFO - Running setup.py install for mozlog 02:45:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for moznetwork 02:45:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozprocess 02:45:48 INFO - Running setup.py install for mozprofile 02:45:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:45:48 INFO - Running setup.py install for mozrunner 02:45:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Running setup.py install for mozscreenshot 02:45:49 INFO - Running setup.py install for moztest 02:45:49 INFO - Running setup.py install for mozversion 02:45:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:45:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:45:49 INFO - Cleaning up... 02:45:49 INFO - Return code: 0 02:45:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:49 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')]} 02:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:49 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')]} 02:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:49 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:49 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 02:45:49 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 02:45:49 INFO - Using env: {'DISPLAY': ':0', 02:45:49 INFO - 'HOME': '/home/cltbld', 02:45:49 INFO - 'LANG': 'en_US.UTF-8', 02:45:49 INFO - 'LANGUAGE': 'en_US:en', 02:45:49 INFO - 'LOGNAME': 'cltbld', 02:45:49 INFO - 'MAIL': '/var/mail/cltbld', 02:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:49 INFO - 'MOZ_NO_REMOTE': '1', 02:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:49 INFO - 'NO_EM_RESTART': '1', 02:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:49 INFO - 'PWD': '/builds/slave/test', 02:45:49 INFO - 'SHELL': '/bin/bash', 02:45:49 INFO - 'SHLVL': '1', 02:45:49 INFO - 'TERM': 'linux', 02:45:49 INFO - 'TMOUT': '86400', 02:45:49 INFO - 'USER': 'cltbld', 02:45:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:49 INFO - '_': '/tools/buildbot/bin/python'} 02:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:45:49 INFO - Running setup.py (path:/tmp/pip-gjQb7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:45:49 INFO - Running setup.py (path:/tmp/pip-bJa28S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:45:49 INFO - Running setup.py (path:/tmp/pip-FsJKue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:45:49 INFO - Running setup.py (path:/tmp/pip-FAcFl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:45:49 INFO - Running setup.py (path:/tmp/pip-Epg9CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:45:49 INFO - Running setup.py (path:/tmp/pip-WHKSsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:45:49 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)) 02:45:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:45:49 INFO - Running setup.py (path:/tmp/pip-1KAkUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:45:50 INFO - Running setup.py (path:/tmp/pip-cgto78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:45:50 INFO - Running setup.py (path:/tmp/pip-YaVbGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:45:50 INFO - Running setup.py (path:/tmp/pip-MdCCB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:45:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:45:50 INFO - Running setup.py (path:/tmp/pip-mUIVlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:45:50 INFO - Running setup.py (path:/tmp/pip-VPhGwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:45:50 INFO - Running setup.py (path:/tmp/pip-MYfYC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:45:50 INFO - Running setup.py (path:/tmp/pip-ALfg7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:50 INFO - Running setup.py (path:/tmp/pip-hMVV1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:45:50 INFO - Running setup.py (path:/tmp/pip-gCY8Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:45:50 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)) 02:45:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:45:50 INFO - Running setup.py (path:/tmp/pip-WMdk26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:45:50 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)) 02:45:50 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)) 02:45:50 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)) 02:45:50 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)) 02:45:50 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)) 02:45:50 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)) 02:45:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:45:50 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 02:45:50 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 02:45:50 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 02:45:50 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 02:45:51 INFO - Downloading blessings-1.6.tar.gz 02:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:45:51 INFO - Installing collected packages: blessings 02:45:51 INFO - Running setup.py install for blessings 02:45:52 INFO - Successfully installed blessings 02:45:52 INFO - Cleaning up... 02:45:52 INFO - Return code: 0 02:45:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:52 INFO - Reading from file tmpfile_stdout 02:45:52 INFO - Current package versions: 02:45:52 INFO - argparse == 1.2.1 02:45:52 INFO - blessings == 1.6 02:45:52 INFO - blobuploader == 1.2.4 02:45:52 INFO - docopt == 0.6.1 02:45:52 INFO - functools32 == 3.2.3-2 02:45:52 INFO - jsonschema == 2.5.1 02:45:52 INFO - manifestparser == 1.1 02:45:52 INFO - mozInstall == 1.12 02:45:52 INFO - mozcrash == 1.0 02:45:52 INFO - mozdebug == 0.1 02:45:52 INFO - mozdevice == 0.51 02:45:52 INFO - mozfile == 1.2 02:45:52 INFO - mozhttpd == 0.7 02:45:52 INFO - mozinfo == 0.9 02:45:52 INFO - mozleak == 0.1 02:45:52 INFO - mozlog == 3.4 02:45:52 INFO - moznetwork == 0.27 02:45:52 INFO - mozprocess == 0.25 02:45:52 INFO - mozprofile == 0.28 02:45:52 INFO - mozrunner == 6.13 02:45:52 INFO - mozscreenshot == 0.1 02:45:52 INFO - mozsystemmonitor == 0.3 02:45:52 INFO - moztest == 0.8 02:45:52 INFO - mozversion == 1.4 02:45:52 INFO - psutil == 3.1.1 02:45:52 INFO - requests == 1.2.3 02:45:52 INFO - wsgiref == 0.1.2 02:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:45:52 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')]} 02:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45:52 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')]} 02:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45:52 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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45:52 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 02:45:52 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 02:45:52 INFO - Using env: {'DISPLAY': ':0', 02:45:52 INFO - 'HOME': '/home/cltbld', 02:45:52 INFO - 'LANG': 'en_US.UTF-8', 02:45:52 INFO - 'LANGUAGE': 'en_US:en', 02:45:52 INFO - 'LOGNAME': 'cltbld', 02:45:52 INFO - 'MAIL': '/var/mail/cltbld', 02:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:52 INFO - 'MOZ_NO_REMOTE': '1', 02:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:52 INFO - 'NO_EM_RESTART': '1', 02:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:52 INFO - 'PWD': '/builds/slave/test', 02:45:52 INFO - 'SHELL': '/bin/bash', 02:45:52 INFO - 'SHLVL': '1', 02:45:52 INFO - 'TERM': 'linux', 02:45:52 INFO - 'TMOUT': '86400', 02:45:52 INFO - 'USER': 'cltbld', 02:45:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:52 INFO - '_': '/tools/buildbot/bin/python'} 02:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 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)) 02:45:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:45: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 02:45: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 02:45: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 02:45: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 02:45:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:45:53 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)) 02:45:53 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)) 02:45:53 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)) 02:45:53 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)) 02:45:53 INFO - Installing collected packages: marionette-driver 02:45:53 INFO - Running setup.py install for marionette-driver 02:45:53 INFO - Successfully installed marionette-driver 02:45:53 INFO - Cleaning up... 02:45:53 INFO - Return code: 0 02:45:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:45: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')]} 02:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:45: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')]} 02:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:45: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 0x24be3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2698a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x283cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', '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 02:45: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 02:45: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 02:45:53 INFO - Using env: {'DISPLAY': ':0', 02:45:53 INFO - 'HOME': '/home/cltbld', 02:45:53 INFO - 'LANG': 'en_US.UTF-8', 02:45:53 INFO - 'LANGUAGE': 'en_US:en', 02:45:53 INFO - 'LOGNAME': 'cltbld', 02:45:53 INFO - 'MAIL': '/var/mail/cltbld', 02:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:45:53 INFO - 'MOZ_NO_REMOTE': '1', 02:45:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:45:53 INFO - 'NO_EM_RESTART': '1', 02:45:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:45:53 INFO - 'PWD': '/builds/slave/test', 02:45:53 INFO - 'SHELL': '/bin/bash', 02:45:53 INFO - 'SHLVL': '1', 02:45:53 INFO - 'TERM': 'linux', 02:45:53 INFO - 'TMOUT': '86400', 02:45:53 INFO - 'USER': 'cltbld', 02:45:53 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:45:53 INFO - '_': '/tools/buildbot/bin/python'} 02:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:45:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:45:54 INFO - Cleaning up... 02:45:54 INFO - Return code: 0 02:45:54 INFO - Running post-action listener: _resource_record_post_action 02:45:54 INFO - Running post-action listener: _start_resource_monitoring 02:45:54 INFO - Starting resource monitoring. 02:45:54 INFO - [mozharness: 2017-06-05 09:45:54.130996Z] Finished create-virtualenv step (success) 02:45:54 INFO - [mozharness: 2017-06-05 09:45:54.131517Z] Running install step. 02:45:54 INFO - Running pre-action listener: _resource_record_pre_action 02:45:54 INFO - Running main action method: install 02:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:45:54 INFO - Reading from file tmpfile_stdout 02:45:54 INFO - Detecting whether we're running mozinstall >=1.0... 02:45:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:45:54 INFO - Reading from file tmpfile_stdout 02:45:54 INFO - Output received: 02:45:54 INFO - Usage: mozinstall [options] installer 02:45:54 INFO - Options: 02:45:54 INFO - -h, --help show this help message and exit 02:45:54 INFO - -d DEST, --destination=DEST 02:45:54 INFO - Directory to install application into. [default: 02:45:54 INFO - "/builds/slave/test"] 02:45:54 INFO - --app=APP Application being installed. [default: firefox] 02:45:54 INFO - mkdir: /builds/slave/test/build/application 02:45: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'] 02:45:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:46:11 INFO - Reading from file tmpfile_stdout 02:46:11 INFO - Output received: 02:46:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:46:11 INFO - Running post-action listener: _resource_record_post_action 02:46:11 INFO - [mozharness: 2017-06-05 09:46:11.880428Z] Finished install step (success) 02:46:11 INFO - [mozharness: 2017-06-05 09:46:11.880665Z] Running setup-mitmproxy step. 02:46:11 INFO - Running pre-action listener: _resource_record_pre_action 02:46:11 INFO - Running main action method: setup_mitmproxy 02:46:11 INFO - Skipping: mitmproxy is not required 02:46:11 INFO - Running post-action listener: _resource_record_post_action 02:46:11 INFO - [mozharness: 2017-06-05 09:46:11.881234Z] Finished setup-mitmproxy step (success) 02:46:11 INFO - [mozharness: 2017-06-05 09:46:11.881480Z] Running run-tests step. 02:46:11 INFO - Running pre-action listener: _resource_record_pre_action 02:46:11 INFO - Running main action method: run_tests 02:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:46:11 INFO - Python 2.7.3 02:46:11 INFO - Return code: 0 02:46:11 INFO - grabbing minidump binary from tooltool 02:46:11 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')]} 02:46:11 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 0x2839840>, '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 0x283a740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283abd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:46:11 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 02:46:11 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 02:46:11 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 02:46:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:46:11 INFO - Return code: 0 02:46:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:46:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:46:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:46:11 INFO - ENV: RUST_BACKTRACE is now 1 02:46:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:46:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:46:11 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:46:11 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 02:46:11 INFO - Using env: {'DISPLAY': ':0', 02:46:11 INFO - 'HOME': '/home/cltbld', 02:46:11 INFO - 'LANG': 'en_US.UTF-8', 02:46:11 INFO - 'LANGUAGE': 'en_US:en', 02:46:11 INFO - 'LOGNAME': 'cltbld', 02:46:11 INFO - 'MAIL': '/var/mail/cltbld', 02:46:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:46:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:46:11 INFO - 'MOZ_NO_REMOTE': '1', 02:46:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:46:11 INFO - 'NO_EM_RESTART': '1', 02:46:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:46:11 INFO - 'PWD': '/builds/slave/test', 02:46:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:46:11 INFO - 'RUST_BACKTRACE': '1', 02:46:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:46:11 INFO - 'SHELL': '/bin/bash', 02:46:11 INFO - 'SHLVL': '1', 02:46:11 INFO - 'TERM': 'linux', 02:46:11 INFO - 'TMOUT': '86400', 02:46:11 INFO - 'USER': 'cltbld', 02:46:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805', 02:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:46:11 INFO - '_': '/tools/buildbot/bin/python'} 02:46:11 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/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 02:46:12 INFO - mozversion application_buildid: 20170605090212 02:46:12 INFO - mozversion application_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:46:12 INFO - mozversion application_display_name: Nightly 02:46:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:46:12 INFO - mozversion application_name: Firefox 02:46:12 INFO - mozversion application_remotingname: firefox 02:46:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:46:12 INFO - mozversion application_vendor: Mozilla 02:46:12 INFO - mozversion application_version: 55.0a1 02:46:12 INFO - mozversion platform_buildid: 20170605090212 02:46:12 INFO - mozversion platform_changeset: 7d5df2dead2c9edaa41688a82d9d9dcc86529ef2 02:46:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:46:12 INFO - mozversion platform_version: 55.0a1 02:46:12 INFO - using testdate: 1496655972 02:46:12 INFO - actual date: 1496655972 02:46:12 INFO - starting webserver on 'localhost:41126' 02:46:12 INFO - SUITE-START | Running 2 tests 02:46:12 INFO - TEST-START | dromaeo_css 02:46:12 INFO - operating with platform_type : linux_ 02:46:12 INFO - Initialising browser for dromaeo_css test... 02:46:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41126/getInfo.html -profile /tmp/tmp0HH9Pu/profile 02:46:12 INFO - TEST-INFO | started process 25467 (/builds/slave/test/build/application/firefox/firefox http://localhost:41126/getInfo.html) 02:46:47 INFO - TEST-INFO | 25467: killed by SIGTERM 02:46:47 INFO - Browser initialized. 02:46:47 INFO - Running cycle 1/1 for dromaeo_css test... 02:46:47 INFO - TEST-INFO | started process 25698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0HH9Pu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:58 INFO - PID 25698 | RSS: Main: 192106496 02:46:58 INFO - PID 25698 | 02:50:00 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41126/tests/dromaeo/cssquery-ext.html) 02:50:01 INFO - PID 25698 | RSS: Main: 186494976 02:50:01 INFO - PID 25698 | 02:53:03 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-ext.html (next: http://localhost:41126/tests/dromaeo/cssquery-jquery.html) 02:53:04 INFO - PID 25698 | RSS: Main: 194666496 02:53:04 INFO - PID 25698 | 02:56:06 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41126/tests/dromaeo/cssquery-mootools.html) 02:56:06 INFO - PID 25698 | RSS: Main: 191500288 02:56:06 INFO - PID 25698 | 02:59:08 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41126/tests/dromaeo/cssquery-prototype.html) 02:59:09 INFO - PID 25698 | RSS: Main: 195698688 02:59:09 INFO - PID 25698 | 03:02:11 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41126/tests/dromaeo/cssquery-yui.html) 03:02:12 INFO - PID 25698 | RSS: Main: 192561152 03:02:12 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | Cycle 1(1): loaded http://localhost:41126/tests/dromaeo/cssquery-yui.html (next: http://localhost:41126/tests/dromaeo/cssquery-dojo.html) 03:05:14 INFO - PID 25698 | RSS: Main: 193691648 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | __start_tp_report 03:05:14 INFO - PID 25698 | _x_x_mozilla_page_load 03:05:14 INFO - PID 25698 | _x_x_mozilla_page_load_details 03:05:14 INFO - PID 25698 | |i|pagename|runs| 03:05:14 INFO - PID 25698 | |0;dojo.html;3097.6437709663387;3103.115612050566;3103.456895043367;3126.7029632184936;3138.3095718941827;5797;5941.6435013899145;5942.5840191186635;5952.404759524051;5953.315368732597;5915.645061296325;5926.377730338317;5930.318013428457;5934.228550288467;5995.820125396234;5467;5542.889142217154;5552.888942221153;5579.581531385142;5583.5254003409755;5334.093204155283;5453.427390124039;5522.22688823563;5540.445955404468;5551.444855514436;5440.047991601454;5534.806281780138;5568.721563921808;5596.804111856086;5619.719014049301;5327.600429967768;5376.784928602851;5408.918866216971;5458.099413596791;5539.778408863641;5481.205225242317;5492.697901615409;5516.200150978126;5553.278073850373;5558.666480011212;5928.110783382484;5942.673152976585;5949.8215053548465;5953.702314884282;5978.970105149447;6202;6216.627002379826;6285.842853928642;6466.094746735461;6512.641804700739;6500.4799616030605;6555.934440655627;6560.770373036921;6566.212054553436;6585.539012269143;5990.790322338741;6086.878262434727;6088.482478989247;6091.238595175603;6098.14625952367;6300.747970081237;6402.6158430494315;6645.634490102994;6651.567648102858;6666.166729158856;6166.1983942087245;6266.624002559861;6279.529035322369;6290.402411770874;6300.527460440394;6207.193064901534;6216.627002379872;6317.210348706411;6366.490680745529;6393.1369265148605;6468.902966455507;6484.416402523795;6496.512761542903;6496.707648155844;6511.511636627272;6131.774283661862;6466.967665161644;6491.188601424822;6503;6506.3818937200895;5182.404023537266;5195.7142357170715;5251.789928402821;5269.973650131725;5272;4484.0583477469445;4489.528599497071;4495.775211239425;4537.4328208973875;4588.931166032512;5631.887362252732;5638.774449021993;5643.40744221859;5652.3217213934595;5652.491275785199;6185.288691800411;6266.811995640138;6435.22777266731;6480.708368123445;6516.837079072966;5663.886722265532;5664.2636457261115;5675.3757086720425;5689.829305120853;5719.342275638355;5690.7439165237665;5732.684702341411;5734.6845923473775;5738.483536481654;5742.655440673573;6070.726817293233;6113.202667687823;6122.794608433986;6206;6310.652914089769;6478.384553467413;6532.8366790830605;6536.542442029012;6538.934610653832;6540.803775886731;6302.275238347649;6319.368063193644;6321.178246828067;6323.114763932961;6338.556301058881;6073.757049718139;6133.76314253068;6281.528885333527;6368.044793281045;6368.87262254743;6532.05285233648;6568.146141001639;6572.967135164294;6593.901091483535;6594.769183078569;6257.061440783918;6277.027060805583;6341.651209183539;6343.746250149942;6350.682465876595;6102.176206212104;6125.601746185282;6133.426475724836;6204.813855584159;6318.08387783778;6228.314885362516;6254.186955695731;6265.49876009909;6289.591176573508;6304.275008374096;6398.072279519351;6414.134091897534;6428.646424446513;6433.453156481752;6433.903491447726;5954.821355359346;6100.1154832548145;6201.162843016135;6233.719482623203;6234 03:05:14 INFO - PID 25698 | |1;ext.html;705.8164877131948;728.1371574684;752.270297811123;1117.8099723047087;1135.125953016178;34737.30525389494;35354;35391.33738601824;35491.2901741965;35511.82244088782;37716.62283377165;38040.80979595098;38173.23653526928;38197;38271.61728382715;7050.9776082468015;7235.240299768528;7249.818754531127;7323.743668971574;7456.664450099758;7132.465065120111;7186.425085993108;7193.172785129698;7193.928060719404;7238.927610723905;7189.89215161773;7210.675519601605;7268.491205615609;7272.272772722712;7288.781336559911;7190.604516751577;7211.387032102251;7248.565086094851;7249.202587715347;7254.78235652926;7096.6451677416435;7141.035960145417;7141.60721160336;7183.6408179591335;7193.820154496179;34533.82733086344;34883.30233395318;34910.12724681878;34913.4762978553;34934.30131397358;3452.223249768782;3479.2867462170193;3505.7370697197557;3506.544149260605;3507.5966263879727;27638;27705.307367315778;27706;27734.722652773416;27841.164765056878;3706;3712.5173727415263;3712.7586706863967;3731.9813400933094;3738.02811269072;143748;144181;157411;165928;166382;41401.79299103546;41498.37752433716;41762;41864.58135418607;42044.69329600584;42658.360124598155;43125.56874431216;43305;49073.5092649069;49833.50166498288;14773;14987.475438359605;15029.549113526611;15039.398424062914;15042.924785376223;12132.69668258283;12232.633021009384;12253.387330633434;12267.631971040882;12279.93860030712;13552.186868787905;13578.333849860483;13583.320833958263;13601.727965440636;13839;5615.859603509945;5706.771729130788;5776.220210271644;5838.211841401441;5889.146073819272;945.7777422305753;986.5905649155663;994.5773046455372;1001.1290177545436;1001.62439085343;22190.556188876453;22211;23078.96144673494;23479.41301467477;23662.881685591463;1074.3983369313053;1074.9247552671395;1088.4217884068132;1096.9670909872716;1123.7640095579857;11772.411379430994;11880.643580692593;11980.341081240442;12035;12584.307863067435;203905;204189;204652;204877;205083;46377.53622463732;46743.29885051727;46820.531794681614;46836.53163468322;47128.5287147131;1386.6741315790782;1411.710599327156;1433.548432243819;1440.9207493587744;1441.5242969819935;21145.577088458453;21583.2445864394;22971.081156753542;23062.538749225256;23145.652815208123;34204.82897585496;34352.82823585866;34411.65588344084;34442.65557344495;34503;169434;169739;169833.15083424503;169974;170696;32428.35143297168;33224.66775332313;34047.48928766021;34097.82951085229;34165.65834341724;39588.60411395964;39899.40150897681;40055.198896021335;40376.79811600923;40431.79784101061;29540.704592953796;30415.54376684307;30747;31326;31975.200619984687;29830.25424364408;29872.701272987862;30405;30780.84609576938;31679.36641267208;32691.836540817145;33916.152096197795;34466;34495.827520862236;34503.654963451045;27460;28531.28671783222;29029.274268143465;29903.252418689706;30862.228444289074;21559.24542641;23906.76093239115;24224.87887560551;24263.272101836974;24440.75559244456 03:05:14 INFO - PID 25698 | |2;jquery.html;405.31097134870726;409.89137878462196;425.6190709315163;428.47297823676877;442.7011767057236;14406;15164.620884477894;20117.497062573424;21036.263730769428;21125.471863203427;20788.8960555197;21686.674699879513;21799.6730049049;21811.67282490764;21845.235416760417;5642.407547207556;5803.6517808931385;5806.854828629297;5812.331581868097;5828.562857785661;5697.8005769798065;5760.8271751847515;5772.595918285721;5815.447532484428;5823.621464604787;5493.533049690781;5690.886182276352;5721.227634269362;5755.597108202427;5769.971150144243;5607.214989901417;5614.691191984439;5618.073017952053;5632.324121105453;5632.5212356949705;5043.495650434964;5061.8734531637;5078.162103252959;5079.6952182869145;5092.567131793802;23752.168674096498;24005.759942400702;24034.399140021465;24143.75856241433;24252.1511747088;1888.8205620466172;1931.4205738278602;1941.825235728777;1949.892755898425;1954.921803127873;15995.520134395987;16017.439389621424;16477.258523366356;16611;16666.333346666117;2172.576347612216;2189.8686078835162;2239.9104035838545;2241.12596087526;2250.504888924434;107168;108967;108982;109395;109530.45234773775;10759.515821788038;11489.42552872353;11571.247868888495;11629.709257268467;11630.6510804676;16292.185390730416;16339.509814705578;16360.918195408947;16423.343066277215;16454.670906581803;8686.262747450535;8757.430767000125;8772.517511536798;8839.734807955772;8874.645014199488;8212.63043163059;8261.628226729812;8309.418340716093;8406.369522285731;8457.746267611981;7285.890711639329;7431.591262480615;7497.812554686067;7512.737054203186;7596.658150383136;2041.275347251734;2066.1528773203213;2093.8010888965523;2134.1676746069047;2173.228503881131;938.938968967015;959.5250351076122;975.2338041528931;985.8126955878361;993.3543196921914;18144.637107258044;18770.343037993604;19021.42935711931;20787;22977.425564360692;969.9224062075017;990.5195979949718;996.9513091725396;999.7250756042001;1012.5696578953915;9979;10088.596456141671;10128.645497407555;10464.790704185874;10754.623588174532;491218;494588;495007;508247;509198;102415;103232;106919.46540267405;107071;107616;1190.7261329894172;1192.284629222477;1214.3503225774168;1223.3271700564653;1227.8342423772676;15992.600184995003;16095.366621682786;16580.336786528886;16784.16079196011;18002.09989500546;50630.493695064055;51305.23042154296;52068.479315206365;52399.73800130975;54173.45826541684;64895.675521623976;65145.34854651393;65423.672881635284;65513.344866550724;65597.67201164155;9863.901360986298;10116.494175291353;10133.949330253301;10144.644937427154;10165.695029149138;16393.09837958924;17503.38738144159;18004.099795009934;18075.096245187426;18238.270469181614;14627.488037918622;14752.114873107648;14840.62898427548;14850.702985940005;14998.175100369148;12873.420696068886;12878.35608219604;13102.541411050568;13300.600981970556;13640.727185456037;13877.375518101508;13907.51323703706;13957.092788968685;14013.859861401255;14049.578512644637;10104.292699510963;14994.325255363317;15929.681406371576;16074.196290185679;16245.756313655069;13863.584092477242;13881.236531990837;14311.212883291519;14548.563543093724;14558.41766329335 03:05:14 INFO - PID 25698 | |3;mootools.html;1244.6390546741445;1313.678148853531;1326.4296352568404;1330.62742432119;1336.0514035035121;10748.355098694074;11238.381888996102;11330.546778128886;11354.091672666187;11570.884291157086;11276.097912167028;11364;11395.886041139607;11459.140564457657;11470.082393408527;2337.2170322941834;2351.200591798788;2361.3624321433203;2370.419247284418;2378.678878351426;2310.8844557772127;2360.2565191964563;2364.586197415454;2365.2431222008963;2366.3847399676124;2321.6401457774073;2341.84777989431;2350.1421980976907;2352.0356653771955;2360.8701521416315;2273.0453209651987;2296.666983287422;2308.676785250066;2311.976880231193;2314.5370925814905;2240.88795560223;2269.375921621551;2295.5064661097776;2351.7883390494767;2354.976450235493;11157.051650609708;11282.323060616307;11283.774324513464;11283.943580282128;11295.830562541569;6127.693615319216;6287.9056814147825;6346.6509341986175;6352.6823658816875;6365.236171659384;3594.1733401317583;3722.3858063419502;3753.7372383933134;3795.8671446499516;3914.5498267699295;1294.4951468927127;1311.5344052861192;1316.2957817567556;1346.966325841852;1355.5458921261388;16033.599160020976;16370.099644519547;16487.587810304718;16558.254878530493;16642.916785415997;5193.844184674465;5214.739263036833;5402.810901618424;5433.347998240237;5460.6996615186545;12301.630951071482;12365.876341236473;12393.132480726443;12427.130100892851;12438.378081095909;6066.150738896558;6143.354947730513;6172.629642221481;6173.043178307369;6205.472534834499;5661.858453538612;5732.484076433141;5767.740451679684;5772.9711351442975;5803.8549036274435;4159.584041595816;4217.936730949038;4226.323788193874;4290.2706539888295;4292.205941900758;1187.588362229329;1199.5082016373244;1211.6122840690894;1216.6410908781932;1223.1193540650718;793.8967934168521;809.8461292354434;816.9959150204211;820.1142765812908;862.9827403451895;6848.9657551711925;7070.540414873017;7076.0280682113635;7286.599237042014;7501.437392195608;964.6720115160879;967.5984466446346;978.6525783346809;994.6021591363512;1000.4147573669339;4162.979185104055;4337.587929146726;4365.192439398721;4421.115776844644;4660.603848672833;13932.721345573234;14676.779848302283;14683.48607798722;14701.411943522353;14716.558503244705;12927.224366538037;13343.599692009062;14311.499097531536;14657.706845863024;14702.411903523953;7679.577623230664;8807.295416366675;8967.730968070968;8991.730248092437;9004.36969412135;6691.866162676622;6877.862442751217;6900.965495172492;6908.620025898423;6930.965345173242;12043.518259269531;12583.370831458573;12625.431855566705;12911.677208069874;13145;13105.868941310466;13127.212367257995;13157.407916643582;13273.469061237442;13279.468821247043;10254;10458.581656733646;10502.947485262524;10509.894901051197;10556.208284378548;10300;10477.790444191225;10601;10613.522391492555;10659.09397701204;8198.631061602124;8386.454880432751;8468.153184681729;8704.60829262672;8907.866382004404;8345.95827020861;8445.493270403795;8470.661173553235;8485.703000394957;8505.87241191395;7642.312191902755;7800.141984381827;7896.84206315882;7929.405294602812;7929.444938854225;5691.345495267931;5788.247527821524;5860.970695146497;5871.7651293947765;6181.876362472815;6076;6125.785597504066;6169.5064394849205;6510.31641677636;6550.541462097607 03:05:14 INFO - PID 25698 | |4;prototype.html;398.98803035908924;402.8157611539487;403.8731937893278;405.12493015087415;410.5607000509454;6285.617164223875;6305.216869878071;6336.271328797184;6374.490040796737;6382.521310901683;5836.649801011942;6102.958071509207;6149.354317796634;6149.385061493848;6155.815325540229;4752.59602933751;4770.475247722757;4802.471728109905;4802.663813533054;4823.348847905523;4782.13921494131;4796.3045358423005;4815.686980346266;4818.5422384873555;4850.854474365775;4738.620910327183;4764.711170600631;4769.52304769522;4772.57046865782;4775.403074615673;4770.141374552579;4778.25936979767;4779.856604301876;4785.9521404785855;4800.687955282895;4214.578542145791;4214.7471151731;4221.55673654265;4221.873343799691;4231.322988321854;6030.487408570277;6031.577789554733;6037.54718396122;6049.788257411014;6120.714649923521;5486.972565137149;5488.158289197538;5502.614816962814;5502.669839809624;5503.284573005483;6486.6053798433095;6489.35106489352;6492.772752953671;6493.467547656418;6503.869922601569;4582.770861456914;4589.655775816827;4590.104929538741;4596.287575425815;4599.977000115012;6559.409033431815;6804.319568043205;6832.726690932357;6942;6942.514024018321;4537.137943790669;4641.883952901137;4660.161170989254;4661.673682842168;4679.789409476582;4721.244600863845;4725.637181409295;4726;4738.099761045391;4749.453812811502;5275.235090911873;5395.73021348931;5426.472792684786;5434.885848401068;5440.238366628675;6512.837179070561;6538.803835884836;6573.342665733484;6580.40776330123;6581.6709164542535;1602.7275363188053;1606.068480281434;1606.329417405908;1606.8232494425604;1610.549046267047;1064.685917654294;1082.924195306321;1106.1427393769893;1106.5006915629367;1110.566878917223;5804.129380592861;5829;5849.298084229919;5867.853303667357;5872.7357268923;6732.192136943598;6753.696083676246;6762.647470505918;6767.661616919135;6772.492063095189;5780.393058728857;5784.855378615484;5802.65184088956;5810.099434587646;5810.389909059572;3603.3694103532303;3621.058524783575;3624.347617428888;3648.1426864686778;3655.415133578668;6503.642299673469;6539.50953678476;6539.705713242915;6546.509011824132;6557.393438607476;6907.13660792401;6907.827304317432;6909.585424874524;6920.9653951729915;6940.375366217065;6480.189976252968;6481.282460148064;6530.281669016499;6536.542442029107;6557.147570815859;6737.494687898526;6742.6291553965;6758.8648227036165;6766.594004359754;6777.762778302933;6729.52893297484;6736.4947628929;6761.594304341756;6761.628110453776;6775.762848300285;6151.231096112986;6506.674666266573;6535.379138981789;6556.147700799056;6577;4621.537846215351;4653.255479123324;4665.976670116627;4673.813047478063;4674.392328997209;6740.854054810792;6742.831429214309;6745.853204955071;6777.661116944231;6784.491163162684;6337.271213810471;6394.712237949397;6451.806445806634;6486.254080780771;6496.837579060372;6502.642354670538;6511.9348806511325;6518.641474718936;6518.771842985662;6551.672416379257;6396.456301214263;6406.5334846085525;6423.389777971272;6438.935610643834;6443.806685799434;6515.403726087139;6515.54391192612;6540.542162048611;6542.182227221598;6553.951367781132;6291.591046581958;6367.80896573085;6396.648184349905;6417.133686952202;6430.549861509649 03:05:14 INFO - PID 25698 | |5;yui.html;807.6728924785464;827.735124760077;833.4832403909576;836.3727204596548;854.2439940652524;14533.418663253484;15265.08409495431;17128.057956812372;17502.737458938125;17547.298108075676;15837.84162158378;16524.339026438927;16585.91707041466;16627.334906603723;16655.33378664852;934.7709811096291;963.4845357733614;965.2037069417723;965.4931161140387;971.8833739951216;683.3439897698215;746.8692978728728;913.995430022849;935.9766005849874;936.6159874451477;986.2159583131428;989.1789814454022;990.4552496127101;990.7027891632517;990.8018396320729;979.5836769373059;980;984.9606015759362;990.282045516998;991.6380521109816;727.538013361514;728.7412968396196;729.1505396213405;731.3454458259828;733.8385555177853;16808.74786878198;16866.156692165343;17038.574035649082;17109.23008464622;17997.460076197734;18304.908475457538;18419.35532256378;18736.812631873778;18753.249870005184;18800.24799008038;14974.101553906801;15167;15212.46756363522;15263.160526171056;15285.388584456608;3409.1647546351055;3448.896533104011;3501.142220156078;3540.9114772130647;3546.131197856516;85998;87055;87328.56335718345;87346.5632671839;87499;14293.78559321611;14524.273786310641;14609;14766.48317308889;15131.697366052616;26247.868760656074;26599.601005984925;26794.598081028802;26806.195814125607;27039.324016899736;7983;7985.72049978248;8004.759857204293;8055.7583272501915;8088.797780055545;3371.9494207586904;3490.3891818931584;3766.0961369271176;3866.8259928303296;3916.5691773904846;4480.529544397857;4639.652026098056;4644.814207431732;4670.369500117508;4685.297205419214;826.2935190412111;830.9044459887069;854.692310768123;854.9401541892132;855.4995327733221;655.8721049395322;678.4436761855231;679.8844196486609;687.7627218609572;696.0394655375651;10785.62250321235;11087.667369978913;11808.645740627795;13204.537841175512;13361.599152025456;644.6196743921015;665.4077870695086;669.926308106108;677.7289084366292;679.9388055075067;4998.475160108136;5183.50756678115;5269.209618557247;5393.892122157614;5463.699496527729;97600.51199743956;98023;99302;99336.50331748294;99989;81205.59397203094;81797;81882;82193;82555.17444825594;68423.65788171127;72391;74270;74573.62713186399;74980.3756868507;10345;11021.614243501439;11740.58907938218;11860.822087668865;12005.39973001329;28588.42823143567;28949.7105028947;29211;29427.264318391353;30392;52659.73670131625;52827;54509.72745136249;54886.176707348626;55096.72451637716;16588.50234492967;16794.664106718043;16823.7476437856;17012.06433646161;17071.146442678066;18423.355182568546;18622.81377186265;18917.810821892155;18950.905245473685;19334.323298684478;16827.326906923587;16885.493435196473;16955;17163.31346746116;17252.741208881627;16673.666526669156;16927.238274277934;17125;17608;17664.823351766318;16964.74552881683;17254.137293135544;17299.827001730326;17658.5585360367;17912.641747164722;10369.769419492242;11351.432428378714;11560.595379161688;12106.818397724217;12492.25046497213;12259.448324825225;12396.752064958831;12590.307533085403;12671.30307833078;12942.158759680968 03:05:14 INFO - PID 25698 | __end_tp_report 03:05:14 INFO - PID 25698 | __start_cc_report 03:05:14 INFO - PID 25698 | _x_x_mozilla_cycle_collect,371 03:05:14 INFO - PID 25698 | __end_cc_report 03:05:14 INFO - PID 25698 | __startTimestamp1496657114598__endTimestamp 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | ------- Summary: start ------- 03:05:14 INFO - PID 25698 | Number of tests: 6 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#0] dojo.html Cycles:165 Average:5931.78 Median:6125.60 stddev:682.80 (11.1%) stddev-sans-first:647.69 03:05:14 INFO - PID 25698 | Values: 3097.6 3103.1 3103.5 3126.7 3138.3 5797.0 5941.6 5942.6 5952.4 5953.3 5915.6 5926.4 5930.3 5934.2 5995.8 5467.0 5542.9 5552.9 5579.6 5583.5 5334.1 5453.4 5522.2 5540.4 5551.4 5440.0 5534.8 5568.7 5596.8 5619.7 5327.6 5376.8 5408.9 5458.1 5539.8 5481.2 5492.7 5516.2 5553.3 5558.7 5928.1 5942.7 5949.8 5953.7 5979.0 6202.0 6216.6 6285.8 6466.1 6512.6 6500.5 6555.9 6560.8 6566.2 6585.5 5990.8 6086.9 6088.5 6091.2 6098.1 6300.7 6402.6 6645.6 6651.6 6666.2 6166.2 6266.6 6279.5 6290.4 6300.5 6207.2 6216.6 6317.2 6366.5 6393.1 6468.9 6484.4 6496.5 6496.7 6511.5 6131.8 6467.0 6491.2 6503.0 6506.4 5182.4 5195.7 5251.8 5270.0 5272.0 4484.1 4489.5 4495.8 4537.4 4588.9 5631.9 5638.8 5643.4 5652.3 5652.5 6185.3 6266.8 6435.2 6480.7 6516.8 5663.9 5664.3 5675.4 5689.8 5719.3 5690.7 5732.7 5734.7 5738.5 5742.7 6070.7 6113.2 6122.8 6206.0 6310.7 6478.4 6532.8 6536.5 6538.9 6540.8 6302.3 6319.4 6321.2 6323.1 6338.6 6073.8 6133.8 6281.5 6368.0 6368.9 6532.1 6568.1 6573.0 6593.9 6594.8 6257.1 6277.0 6341.7 6343.7 6350.7 6102.2 6125.6 6133.4 6204.8 6318.1 6228.3 6254.2 6265.5 6289.6 6304.3 6398.1 6414.1 6428.6 6433.5 6433.9 5954.8 6100.1 6201.2 6233.7 6234.0 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#1] ext.html Cycles:180 Average:33552.50 Median:34185.24 stddev:45953.23 (134.4%) stddev-sans-first:46015.95 03:05:14 INFO - PID 25698 | Values: 705.8 728.1 752.3 1117.8 1135.1 34737.3 35354.0 35391.3 35491.3 35511.8 37716.6 38040.8 38173.2 38197.0 38271.6 7051.0 7235.2 7249.8 7323.7 7456.7 7132.5 7186.4 7193.2 7193.9 7238.9 7189.9 7210.7 7268.5 7272.3 7288.8 7190.6 7211.4 7248.6 7249.2 7254.8 7096.6 7141.0 7141.6 7183.6 7193.8 34533.8 34883.3 34910.1 34913.5 34934.3 3452.2 3479.3 3505.7 3506.5 3507.6 27638.0 27705.3 27706.0 27734.7 27841.2 3706.0 3712.5 3712.8 3732.0 3738.0 143748.0 144181.0 157411.0 165928.0 166382.0 41401.8 41498.4 41762.0 41864.6 42044.7 42658.4 43125.6 43305.0 49073.5 49833.5 14773.0 14987.5 15029.5 15039.4 15042.9 12132.7 12232.6 12253.4 12267.6 12279.9 13552.2 13578.3 13583.3 13601.7 13839.0 5615.9 5706.8 5776.2 5838.2 5889.1 945.8 986.6 994.6 1001.1 1001.6 22190.6 22211.0 23079.0 23479.4 23662.9 1074.4 1074.9 1088.4 1097.0 1123.8 11772.4 11880.6 11980.3 12035.0 12584.3 203905.0 204189.0 204652.0 204877.0 205083.0 46377.5 46743.3 46820.5 46836.5 47128.5 1386.7 1411.7 1433.5 1440.9 1441.5 21145.6 21583.2 22971.1 23062.5 23145.7 34204.8 34352.8 34411.7 34442.7 34503.0 169434.0 169739.0 169833.2 169974.0 170696.0 32428.4 33224.7 34047.5 34097.8 34165.7 39588.6 39899.4 40055.2 40376.8 40431.8 29540.7 30415.5 30747.0 31326.0 31975.2 29830.3 29872.7 30405.0 30780.8 31679.4 32691.8 33916.2 34466.0 34495.8 34503.7 27460.0 28531.3 29029.3 29903.3 30862.2 21559.2 23906.8 24224.9 24263.3 24440.8 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#2] jquery.html Cycles:180 Average:31869.99 Median:21080.87 stddev:83186.04 (394.6%) stddev-sans-first:83385.85 03:05:14 INFO - PID 25698 | Values: 405.3 409.9 425.6 428.5 442.7 14406.0 15164.6 20117.5 21036.3 21125.5 20788.9 21686.7 21799.7 21811.7 21845.2 5642.4 5803.7 5806.9 5812.3 5828.6 5697.8 5760.8 5772.6 5815.4 5823.6 5493.5 5690.9 5721.2 5755.6 5770.0 5607.2 5614.7 5618.1 5632.3 5632.5 5043.5 5061.9 5078.2 5079.7 5092.6 23752.2 24005.8 24034.4 24143.8 24252.2 1888.8 1931.4 1941.8 1949.9 1954.9 15995.5 16017.4 16477.3 16611.0 16666.3 2172.6 2189.9 2239.9 2241.1 2250.5 107168.0 108967.0 108982.0 109395.0 109530.5 10759.5 11489.4 11571.2 11629.7 11630.7 16292.2 16339.5 16360.9 16423.3 16454.7 8686.3 8757.4 8772.5 8839.7 8874.6 8212.6 8261.6 8309.4 8406.4 8457.7 7285.9 7431.6 7497.8 7512.7 7596.7 2041.3 2066.2 2093.8 2134.2 2173.2 938.9 959.5 975.2 985.8 993.4 18144.6 18770.3 19021.4 20787.0 22977.4 969.9 990.5 997.0 999.7 1012.6 9979.0 10088.6 10128.6 10464.8 10754.6 491218.0 494588.0 495007.0 508247.0 509198.0 102415.0 103232.0 106919.5 107071.0 107616.0 1190.7 1192.3 1214.4 1223.3 1227.8 15992.6 16095.4 16580.3 16784.2 18002.1 50630.5 51305.2 52068.5 52399.7 54173.5 64895.7 65145.3 65423.7 65513.3 65597.7 9863.9 10116.5 10133.9 10144.6 10165.7 16393.1 17503.4 18004.1 18075.1 18238.3 14627.5 14752.1 14840.6 14850.7 14998.2 12873.4 12878.4 13102.5 13300.6 13640.7 13877.4 13907.5 13957.1 14013.9 14049.6 10104.3 14994.3 15929.7 16074.2 16245.8 13863.6 13881.2 14311.2 14548.6 14558.4 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#3] mootools.html Cycles:180 Average:6972.17 Median:2362.97 stddev:4412.15 (186.7%) stddev-sans-first:4403.53 03:05:14 INFO - PID 25698 | Values: 1244.6 1313.7 1326.4 1330.6 1336.1 10748.4 11238.4 11330.5 11354.1 11570.9 11276.1 11364.0 11395.9 11459.1 11470.1 2337.2 2351.2 2361.4 2370.4 2378.7 2310.9 2360.3 2364.6 2365.2 2366.4 2321.6 2341.8 2350.1 2352.0 2360.9 2273.0 2296.7 2308.7 2312.0 2314.5 2240.9 2269.4 2295.5 2351.8 2355.0 11157.1 11282.3 11283.8 11283.9 11295.8 6127.7 6287.9 6346.7 6352.7 6365.2 3594.2 3722.4 3753.7 3795.9 3914.5 1294.5 1311.5 1316.3 1347.0 1355.5 16033.6 16370.1 16487.6 16558.3 16642.9 5193.8 5214.7 5402.8 5433.3 5460.7 12301.6 12365.9 12393.1 12427.1 12438.4 6066.2 6143.4 6172.6 6173.0 6205.5 5661.9 5732.5 5767.7 5773.0 5803.9 4159.6 4217.9 4226.3 4290.3 4292.2 1187.6 1199.5 1211.6 1216.6 1223.1 793.9 809.8 817.0 820.1 863.0 6849.0 7070.5 7076.0 7286.6 7501.4 964.7 967.6 978.7 994.6 1000.4 4163.0 4337.6 4365.2 4421.1 4660.6 13932.7 14676.8 14683.5 14701.4 14716.6 12927.2 13343.6 14311.5 14657.7 14702.4 7679.6 8807.3 8967.7 8991.7 9004.4 6691.9 6877.9 6901.0 6908.6 6931.0 12043.5 12583.4 12625.4 12911.7 13145.0 13105.9 13127.2 13157.4 13273.5 13279.5 10254.0 10458.6 10502.9 10509.9 10556.2 10300.0 10477.8 10601.0 10613.5 10659.1 8198.6 8386.5 8468.2 8704.6 8907.9 8346.0 8445.5 8470.7 8485.7 8505.9 7642.3 7800.1 7896.8 7929.4 7929.4 5691.3 5788.2 5861.0 5871.8 6181.9 6076.0 6125.8 6169.5 6510.3 6550.5 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#4] prototype.html Cycles:180 Average:5426.31 Median:6111.84 stddev:1601.56 (26.2%) stddev-sans-first:1560.97 03:05:14 INFO - PID 25698 | Values: 399.0 402.8 403.9 405.1 410.6 6285.6 6305.2 6336.3 6374.5 6382.5 5836.6 6103.0 6149.4 6149.4 6155.8 4752.6 4770.5 4802.5 4802.7 4823.3 4782.1 4796.3 4815.7 4818.5 4850.9 4738.6 4764.7 4769.5 4772.6 4775.4 4770.1 4778.3 4779.9 4786.0 4800.7 4214.6 4214.7 4221.6 4221.9 4231.3 6030.5 6031.6 6037.5 6049.8 6120.7 5487.0 5488.2 5502.6 5502.7 5503.3 6486.6 6489.4 6492.8 6493.5 6503.9 4582.8 4589.7 4590.1 4596.3 4600.0 6559.4 6804.3 6832.7 6942.0 6942.5 4537.1 4641.9 4660.2 4661.7 4679.8 4721.2 4725.6 4726.0 4738.1 4749.5 5275.2 5395.7 5426.5 5434.9 5440.2 6512.8 6538.8 6573.3 6580.4 6581.7 1602.7 1606.1 1606.3 1606.8 1610.5 1064.7 1082.9 1106.1 1106.5 1110.6 5804.1 5829.0 5849.3 5867.9 5872.7 6732.2 6753.7 6762.6 6767.7 6772.5 5780.4 5784.9 5802.7 5810.1 5810.4 3603.4 3621.1 3624.3 3648.1 3655.4 6503.6 6539.5 6539.7 6546.5 6557.4 6907.1 6907.8 6909.6 6921.0 6940.4 6480.2 6481.3 6530.3 6536.5 6557.1 6737.5 6742.6 6758.9 6766.6 6777.8 6729.5 6736.5 6761.6 6761.6 6775.8 6151.2 6506.7 6535.4 6556.1 6577.0 4621.5 4653.3 4666.0 4673.8 4674.4 6740.9 6742.8 6745.9 6777.7 6784.5 6337.3 6394.7 6451.8 6486.3 6496.8 6502.6 6511.9 6518.6 6518.8 6551.7 6396.5 6406.5 6423.4 6438.9 6443.8 6515.4 6515.5 6540.5 6542.2 6554.0 6291.6 6367.8 6396.6 6417.1 6430.5 03:05:14 INFO - PID 25698 | 03:05:14 INFO - PID 25698 | [#5] yui.html Cycles:180 Average:19909.96 Median:3543.52 stddev:25607.35 (722.7%) stddev-sans-first:25639.01 03:05:14 INFO - PID 25698 | Values: 807.7 827.7 833.5 836.4 854.2 14533.4 15265.1 17128.1 17502.7 17547.3 15837.8 16524.3 16585.9 16627.3 16655.3 934.8 963.5 965.2 965.5 971.9 683.3 746.9 914.0 936.0 936.6 986.2 989.2 990.5 990.7 990.8 979.6 980.0 985.0 990.3 991.6 727.5 728.7 729.2 731.3 733.8 16808.7 16866.2 17038.6 17109.2 17997.5 18304.9 18419.4 18736.8 18753.2 18800.2 14974.1 15167.0 15212.5 15263.2 15285.4 3409.2 3448.9 3501.1 3540.9 3546.1 85998.0 87055.0 87328.6 87346.6 87499.0 14293.8 14524.3 14609.0 14766.5 15131.7 26247.9 26599.6 26794.6 26806.2 27039.3 7983.0 7985.7 8004.8 8055.8 8088.8 3371.9 3490.4 3766.1 3866.8 3916.6 4480.5 4639.7 4644.8 4670.4 4685.3 826.3 830.9 854.7 854.9 855.5 655.9 678.4 679.9 687.8 696.0 10785.6 11087.7 11808.6 13204.5 13361.6 644.6 665.4 669.9 677.7 679.9 4998.5 5183.5 5269.2 5393.9 5463.7 97600.5 98023.0 99302.0 99336.5 99989.0 81205.6 81797.0 81882.0 82193.0 82555.2 68423.7 72391.0 74270.0 74573.6 74980.4 10345.0 11021.6 11740.6 11860.8 12005.4 28588.4 28949.7 29211.0 29427.3 30392.0 52659.7 52827.0 54509.7 54886.2 55096.7 16588.5 16794.7 16823.7 17012.1 17071.1 18423.4 18622.8 18917.8 18950.9 19334.3 16827.3 16885.5 16955.0 17163.3 17252.7 16673.7 16927.2 17125.0 17608.0 17664.8 16964.7 17254.1 17299.8 17658.6 17912.6 10369.8 11351.4 11560.6 12106.8 12492.3 12259.4 12396.8 12590.3 12671.3 12942.2 03:05:14 INFO - PID 25698 | -------- Summary: end -------- 03:05:14 INFO - PID 25698 | 03:05:15 INFO - TEST-INFO | 25698: exit 0 03:05:15 INFO - TEST-OK | dromaeo_css | took 1143336ms 03:05:15 INFO - TEST-START | kraken 03:05:15 INFO - operating with platform_type : linux_ 03:05:15 INFO - Initialising browser for kraken test... 03:05:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41126/getInfo.html -profile /tmp/tmpBMMytj/profile 03:05:15 INFO - TEST-INFO | started process 26120 (/builds/slave/test/build/application/firefox/firefox http://localhost:41126/getInfo.html) 03:05:50 INFO - TEST-INFO | 26120: killed by SIGTERM 03:05:50 INFO - Browser initialized. 03:05:50 INFO - Running cycle 1/1 for kraken test... 03:05:50 INFO - TEST-INFO | started process 26348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMMytj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:02 INFO - PID 26348 | RSS: Main: 192208896 03:06:02 INFO - PID 26348 | 03:06:04 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41126/tests/kraken/driver.html?testName=audio-beat-detection) 03:06:05 INFO - PID 26348 | RSS: Main: 196456448 03:06:05 INFO - PID 26348 | 03:06:08 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41126/tests/kraken/driver.html?testName=audio-dft) 03:06:08 INFO - PID 26348 | RSS: Main: 194371584 03:06:08 INFO - PID 26348 | 03:06:11 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41126/tests/kraken/driver.html?testName=audio-fft) 03:06:12 INFO - PID 26348 | RSS: Main: 190005248 03:06:12 INFO - PID 26348 | 03:06:14 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41126/tests/kraken/driver.html?testName=audio-oscillator) 03:06:15 INFO - PID 26348 | RSS: Main: 190922752 03:06:15 INFO - PID 26348 | 03:06:17 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:06:17 INFO - PID 26348 | RSS: Main: 190570496 03:06:17 INFO - PID 26348 | 03:06:21 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41126/tests/kraken/driver.html?testName=imaging-darkroom) 03:06:21 INFO - PID 26348 | RSS: Main: 191778816 03:06:21 INFO - PID 26348 | 03:06:25 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41126/tests/kraken/driver.html?testName=imaging-desaturate) 03:06:25 INFO - PID 26348 | RSS: Main: 191127552 03:06:25 INFO - PID 26348 | 03:06:28 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41126/tests/kraken/driver.html?testName=json-parse-financial) 03:06:29 INFO - PID 26348 | RSS: Main: 191954944 03:06:29 INFO - PID 26348 | 03:06:31 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:06:31 INFO - PID 26348 | RSS: Main: 192036864 03:06:31 INFO - PID 26348 | 03:06:33 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:06:34 INFO - PID 26348 | RSS: Main: 191209472 03:06:34 INFO - PID 26348 | 03:06:36 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:06:37 INFO - PID 26348 | RSS: Main: 192126976 03:06:37 INFO - PID 26348 | 03:06:39 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:06:40 INFO - PID 26348 | RSS: Main: 192061440 03:06:40 INFO - PID 26348 | 03:06:43 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:06:44 INFO - PID 26348 | RSS: Main: 192204800 03:06:44 INFO - PID 26348 | 03:06:45 INFO - PID 26348 | Cycle 1(1): loaded http://localhost:41126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41126/tests/kraken/driver.html?testName=ai-astar) 03:06:46 INFO - PID 26348 | RSS: Main: 193556480 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | __start_tp_report 03:06:46 INFO - PID 26348 | _x_x_mozilla_page_load 03:06:46 INFO - PID 26348 | _x_x_mozilla_page_load_details 03:06:46 INFO - PID 26348 | |i|pagename|runs| 03:06:46 INFO - PID 26348 | |0;ai-astar;103;110;111;109;111;114;110;111;111;112 03:06:46 INFO - PID 26348 | |1;audio-beat-detection;147;122;122;173;121;121;122;121;145;126 03:06:46 INFO - PID 26348 | |2;audio-dft;166;166;166;166;166;167;172;171;167;163 03:06:46 INFO - PID 26348 | |3;audio-fft;72;73;77;118;74;73;74;74;99;78 03:06:46 INFO - PID 26348 | |4;audio-oscillator;82;81;105;83;83;83;98;83;83;103 03:06:46 INFO - PID 26348 | |5;imaging-gaussian-blur;115;114;113;114;113;114;113;113;114;117 03:06:46 INFO - PID 26348 | |6;imaging-darkroom;150;151;150;150;151;150;149;150;149;151 03:06:46 INFO - PID 26348 | |7;imaging-desaturate;95;95;95;99;95;94;94;102;99;95 03:06:46 INFO - PID 26348 | |8;json-parse-financial;55;59;58;62;56;57;57;59;63;55 03:06:46 INFO - PID 26348 | |9;json-stringify-tinderbox;56;55;55;55;55;56;56;55;58;57 03:06:46 INFO - PID 26348 | |10;stanford-crypto-aes;86;89;86;90;89;87;88;87;123;102 03:06:46 INFO - PID 26348 | |11;stanford-crypto-ccm;131;130;131;143;130;134;133;128;128;140 03:06:46 INFO - PID 26348 | |12;stanford-crypto-pbkdf2;185;197;196;193;189;191;187;194;186;188 03:06:46 INFO - PID 26348 | |13;stanford-crypto-sha256-iterative;72;72;75;73;75;71;71;71;71;72 03:06:46 INFO - PID 26348 | __end_tp_report 03:06:46 INFO - PID 26348 | __start_cc_report 03:06:46 INFO - PID 26348 | _x_x_mozilla_cycle_collect,1025 03:06:46 INFO - PID 26348 | __end_cc_report 03:06:46 INFO - PID 26348 | __startTimestamp1496657206130__endTimestamp 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | ------- Summary: start ------- 03:06:46 INFO - PID 26348 | Number of tests: 14 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.86 (2.6%) stddev-sans-first:1.41 03:06:46 INFO - PID 26348 | Values: 103.0 110.0 111.0 109.0 111.0 114.0 110.0 111.0 111.0 112.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:124.00 stddev:17.56 (14.2%) stddev-sans-first:17.76 03:06:46 INFO - PID 26348 | Values: 147.0 122.0 122.0 173.0 121.0 121.0 122.0 121.0 145.0 126.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:2.62 (1.6%) stddev-sans-first:2.76 03:06:46 INFO - PID 26348 | Values: 166.0 166.0 166.0 166.0 166.0 167.0 172.0 171.0 167.0 163.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#3] audio-fft Cycles:10 Average:81.20 Median:74.00 stddev:15.18 (20.5%) stddev-sans-first:15.73 03:06:46 INFO - PID 26348 | Values: 72.0 73.0 77.0 118.0 74.0 73.0 74.0 74.0 99.0 78.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:83.00 stddev:9.56 (11.5%) stddev-sans-first:9.85 03:06:46 INFO - PID 26348 | Values: 82.0 81.0 105.0 83.0 83.0 83.0 98.0 83.0 83.0 103.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.27 03:06:46 INFO - PID 26348 | Values: 115.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 117.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 03:06:46 INFO - PID 26348 | Values: 150.0 151.0 150.0 150.0 151.0 150.0 149.0 150.0 149.0 151.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:95.00 stddev:2.71 (2.9%) stddev-sans-first:2.83 03:06:46 INFO - PID 26348 | Values: 95.0 95.0 95.0 99.0 95.0 94.0 94.0 102.0 99.0 95.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:2.73 (4.7%) stddev-sans-first:2.65 03:06:46 INFO - PID 26348 | Values: 55.0 59.0 58.0 62.0 56.0 57.0 57.0 59.0 63.0 55.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 03:06:46 INFO - PID 26348 | Values: 56.0 55.0 55.0 55.0 55.0 56.0 56.0 55.0 58.0 57.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:87.50 stddev:11.62 (13.3%) stddev-sans-first:12.07 03:06:46 INFO - PID 26348 | Values: 86.0 89.0 86.0 90.0 89.0 87.0 88.0 87.0 123.0 102.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:132.00 stddev:5.01 (3.8%) stddev-sans-first:5.27 03:06:46 INFO - PID 26348 | Values: 131.0 130.0 131.0 143.0 130.0 134.0 133.0 128.0 128.0 140.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:192.00 stddev:4.25 (2.2%) stddev-sans-first:3.99 03:06:46 INFO - PID 26348 | Values: 185.0 197.0 196.0 193.0 189.0 191.0 187.0 194.0 186.0 188.0 03:06:46 INFO - PID 26348 | 03:06:46 INFO - PID 26348 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.57 (2.2%) stddev-sans-first:1.66 03:06:46 INFO - PID 26348 | Values: 72.0 72.0 75.0 73.0 75.0 71.0 71.0 71.0 71.0 72.0 03:06:46 INFO - PID 26348 | -------- Summary: end -------- 03:06:46 INFO - PID 26348 | 03:06:47 INFO - TEST-INFO | 26348: exit 0 03:06:47 INFO - TEST-OK | kraken | took 91811ms 03:06:47 INFO - SUITE-END | took 1235s 03:06:47 INFO - Completed test suite (00:20:35) 03:06:47 INFO - javascript benchmark 03:06:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7668.742177333057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.6437709663387, 3103.115612050566, 3103.456895043367, 3126.7029632184936, 3138.3095718941827, 5797.0, 5941.6435013899145, 5942.5840191186635, 5952.404759524051, 5953.315368732597, 5915.645061296325, 5926.377730338317, 5930.318013428457, 5934.228550288467, 5995.820125396234, 5467.0, 5542.889142217154, 5552.888942221153, 5579.581531385142, 5583.5254003409755, 5334.093204155283, 5453.427390124039, 5522.22688823563, 5540.445955404468, 5551.444855514436, 5440.047991601454, 5534.806281780138, 5568.721563921808, 5596.804111856086, 5619.719014049301, 5327.600429967768, 5376.784928602851, 5408.918866216971, 5458.099413596791, 5539.778408863641, 5481.205225242317, 5492.697901615409, 5516.200150978126, 5553.278073850373, 5558.666480011212, 5928.110783382484, 5942.673152976585, 5949.8215053548465, 5953.702314884282, 5978.970105149447, 6202.0, 6216.627002379826, 6285.842853928642, 6466.094746735461, 6512.641804700739, 6500.4799616030605, 6555.934440655627, 6560.770373036921, 6566.212054553436, 6585.539012269143, 5990.790322338741, 6086.878262434727, 6088.482478989247, 6091.238595175603, 6098.14625952367, 6300.747970081237, 6402.6158430494315, 6645.634490102994, 6651.567648102858, 6666.166729158856, 6166.1983942087245, 6266.624002559861, 6279.529035322369, 6290.402411770874, 6300.527460440394, 6207.193064901534, 6216.627002379872, 6317.210348706411, 6366.490680745529, 6393.1369265148605, 6468.902966455507, 6484.416402523795, 6496.512761542903, 6496.707648155844, 6511.511636627272, 6131.774283661862, 6466.967665161644, 6491.188601424822, 6503.0, 6506.3818937200895, 5182.404023537266, 5195.7142357170715, 5251.789928402821, 5269.973650131725, 5272.0, 4484.0583477469445, 4489.528599497071, 4495.775211239425, 4537.4328208973875, 4588.931166032512, 5631.887362252732, 5638.774449021993, 5643.40744221859, 5652.3217213934595, 5652.491275785199, 6185.288691800411, 6266.811995640138, 6435.22777266731, 6480.708368123445, 6516.837079072966, 5663.886722265532, 5664.2636457261115, 5675.3757086720425, 5689.829305120853, 5719.342275638355, 5690.7439165237665, 5732.684702341411, 5734.6845923473775, 5738.483536481654, 5742.655440673573, 6070.726817293233, 6113.202667687823, 6122.794608433986, 6206.0, 6310.652914089769, 6478.384553467413, 6532.8366790830605, 6536.542442029012, 6538.934610653832, 6540.803775886731, 6302.275238347649, 6319.368063193644, 6321.178246828067, 6323.114763932961, 6338.556301058881, 6073.757049718139, 6133.76314253068, 6281.528885333527, 6368.044793281045, 6368.87262254743, 6532.05285233648, 6568.146141001639, 6572.967135164294, 6593.901091483535, 6594.769183078569, 6257.061440783918, 6277.027060805583, 6341.651209183539, 6343.746250149942, 6350.682465876595, 6102.176206212104, 6125.601746185282, 6133.426475724836, 6204.813855584159, 6318.08387783778, 6228.314885362516, 6254.186955695731, 6265.49876009909, 6289.591176573508, 6304.275008374096, 6398.072279519351, 6414.134091897534, 6428.646424446513, 6433.453156481752, 6433.903491447726, 5954.821355359346, 6100.1154832548145, 6201.162843016135, 6233.719482623203, 6234.0], "value": 5882.4222591694415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8164877131948, 728.1371574684, 752.270297811123, 1117.8099723047087, 1135.125953016178, 34737.30525389494, 35354.0, 35391.33738601824, 35491.2901741965, 35511.82244088782, 37716.62283377165, 38040.80979595098, 38173.23653526928, 38197.0, 38271.61728382715, 7050.9776082468015, 7235.240299768528, 7249.818754531127, 7323.743668971574, 7456.664450099758, 7132.465065120111, 7186.425085993108, 7193.172785129698, 7193.928060719404, 7238.927610723905, 7189.89215161773, 7210.675519601605, 7268.491205615609, 7272.272772722712, 7288.781336559911, 7190.604516751577, 7211.387032102251, 7248.565086094851, 7249.202587715347, 7254.78235652926, 7096.6451677416435, 7141.035960145417, 7141.60721160336, 7183.6408179591335, 7193.820154496179, 34533.82733086344, 34883.30233395318, 34910.12724681878, 34913.4762978553, 34934.30131397358, 3452.223249768782, 3479.2867462170193, 3505.7370697197557, 3506.544149260605, 3507.5966263879727, 27638.0, 27705.307367315778, 27706.0, 27734.722652773416, 27841.164765056878, 3706.0, 3712.5173727415263, 3712.7586706863967, 3731.9813400933094, 3738.02811269072, 143748.0, 144181.0, 157411.0, 165928.0, 166382.0, 41401.79299103546, 41498.37752433716, 41762.0, 41864.58135418607, 42044.69329600584, 42658.360124598155, 43125.56874431216, 43305.0, 49073.5092649069, 49833.50166498288, 14773.0, 14987.475438359605, 15029.549113526611, 15039.398424062914, 15042.924785376223, 12132.69668258283, 12232.633021009384, 12253.387330633434, 12267.631971040882, 12279.93860030712, 13552.186868787905, 13578.333849860483, 13583.320833958263, 13601.727965440636, 13839.0, 5615.859603509945, 5706.771729130788, 5776.220210271644, 5838.211841401441, 5889.146073819272, 945.7777422305753, 986.5905649155663, 994.5773046455372, 1001.1290177545436, 1001.62439085343, 22190.556188876453, 22211.0, 23078.96144673494, 23479.41301467477, 23662.881685591463, 1074.3983369313053, 1074.9247552671395, 1088.4217884068132, 1096.9670909872716, 1123.7640095579857, 11772.411379430994, 11880.643580692593, 11980.341081240442, 12035.0, 12584.307863067435, 203905.0, 204189.0, 204652.0, 204877.0, 205083.0, 46377.53622463732, 46743.29885051727, 46820.531794681614, 46836.53163468322, 47128.5287147131, 1386.6741315790782, 1411.710599327156, 1433.548432243819, 1440.9207493587744, 1441.5242969819935, 21145.577088458453, 21583.2445864394, 22971.081156753542, 23062.538749225256, 23145.652815208123, 34204.82897585496, 34352.82823585866, 34411.65588344084, 34442.65557344495, 34503.0, 169434.0, 169739.0, 169833.15083424503, 169974.0, 170696.0, 32428.35143297168, 33224.66775332313, 34047.48928766021, 34097.82951085229, 34165.65834341724, 39588.60411395964, 39899.40150897681, 40055.198896021335, 40376.79811600923, 40431.79784101061, 29540.704592953796, 30415.54376684307, 30747.0, 31326.0, 31975.200619984687, 29830.25424364408, 29872.701272987862, 30405.0, 30780.84609576938, 31679.36641267208, 32691.836540817145, 33916.152096197795, 34466.0, 34495.827520862236, 34503.654963451045, 27460.0, 28531.28671783222, 29029.274268143465, 29903.252418689706, 30862.228444289074, 21559.24542641, 23906.76093239115, 24224.87887560551, 24263.272101836974, 24440.75559244456], "value": 15944.710673669559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.31097134870726, 409.89137878462196, 425.6190709315163, 428.47297823676877, 442.7011767057236, 14406.0, 15164.620884477894, 20117.497062573424, 21036.263730769428, 21125.471863203427, 20788.8960555197, 21686.674699879513, 21799.6730049049, 21811.67282490764, 21845.235416760417, 5642.407547207556, 5803.6517808931385, 5806.854828629297, 5812.331581868097, 5828.562857785661, 5697.8005769798065, 5760.8271751847515, 5772.595918285721, 5815.447532484428, 5823.621464604787, 5493.533049690781, 5690.886182276352, 5721.227634269362, 5755.597108202427, 5769.971150144243, 5607.214989901417, 5614.691191984439, 5618.073017952053, 5632.324121105453, 5632.5212356949705, 5043.495650434964, 5061.8734531637, 5078.162103252959, 5079.6952182869145, 5092.567131793802, 23752.168674096498, 24005.759942400702, 24034.399140021465, 24143.75856241433, 24252.1511747088, 1888.8205620466172, 1931.4205738278602, 1941.825235728777, 1949.892755898425, 1954.921803127873, 15995.520134395987, 16017.439389621424, 16477.258523366356, 16611.0, 16666.333346666117, 2172.576347612216, 2189.8686078835162, 2239.9104035838545, 2241.12596087526, 2250.504888924434, 107168.0, 108967.0, 108982.0, 109395.0, 109530.45234773775, 10759.515821788038, 11489.42552872353, 11571.247868888495, 11629.709257268467, 11630.6510804676, 16292.185390730416, 16339.509814705578, 16360.918195408947, 16423.343066277215, 16454.670906581803, 8686.262747450535, 8757.430767000125, 8772.517511536798, 8839.734807955772, 8874.645014199488, 8212.63043163059, 8261.628226729812, 8309.418340716093, 8406.369522285731, 8457.746267611981, 7285.890711639329, 7431.591262480615, 7497.812554686067, 7512.737054203186, 7596.658150383136, 2041.275347251734, 2066.1528773203213, 2093.8010888965523, 2134.1676746069047, 2173.228503881131, 938.938968967015, 959.5250351076122, 975.2338041528931, 985.8126955878361, 993.3543196921914, 18144.637107258044, 18770.343037993604, 19021.42935711931, 20787.0, 22977.425564360692, 969.9224062075017, 990.5195979949718, 996.9513091725396, 999.7250756042001, 1012.5696578953915, 9979.0, 10088.596456141671, 10128.645497407555, 10464.790704185874, 10754.623588174532, 491218.0, 494588.0, 495007.0, 508247.0, 509198.0, 102415.0, 103232.0, 106919.46540267405, 107071.0, 107616.0, 1190.7261329894172, 1192.284629222477, 1214.3503225774168, 1223.3271700564653, 1227.8342423772676, 15992.600184995003, 16095.366621682786, 16580.336786528886, 16784.16079196011, 18002.09989500546, 50630.493695064055, 51305.23042154296, 52068.479315206365, 52399.73800130975, 54173.45826541684, 64895.675521623976, 65145.34854651393, 65423.672881635284, 65513.344866550724, 65597.67201164155, 9863.901360986298, 10116.494175291353, 10133.949330253301, 10144.644937427154, 10165.695029149138, 16393.09837958924, 17503.38738144159, 18004.099795009934, 18075.096245187426, 18238.270469181614, 14627.488037918622, 14752.114873107648, 14840.62898427548, 14850.702985940005, 14998.175100369148, 12873.420696068886, 12878.35608219604, 13102.541411050568, 13300.600981970556, 13640.727185456037, 13877.375518101508, 13907.51323703706, 13957.092788968685, 14013.859861401255, 14049.578512644637, 10104.292699510963, 14994.325255363317, 15929.681406371576, 16074.196290185679, 16245.756313655069, 13863.584092477242, 13881.236531990837, 14311.212883291519, 14548.563543093724, 14558.41766329335], "value": 10268.752496672856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.6390546741445, 1313.678148853531, 1326.4296352568404, 1330.62742432119, 1336.0514035035121, 10748.355098694074, 11238.381888996102, 11330.546778128886, 11354.091672666187, 11570.884291157086, 11276.097912167028, 11364.0, 11395.886041139607, 11459.140564457657, 11470.082393408527, 2337.2170322941834, 2351.200591798788, 2361.3624321433203, 2370.419247284418, 2378.678878351426, 2310.8844557772127, 2360.2565191964563, 2364.586197415454, 2365.2431222008963, 2366.3847399676124, 2321.6401457774073, 2341.84777989431, 2350.1421980976907, 2352.0356653771955, 2360.8701521416315, 2273.0453209651987, 2296.666983287422, 2308.676785250066, 2311.976880231193, 2314.5370925814905, 2240.88795560223, 2269.375921621551, 2295.5064661097776, 2351.7883390494767, 2354.976450235493, 11157.051650609708, 11282.323060616307, 11283.774324513464, 11283.943580282128, 11295.830562541569, 6127.693615319216, 6287.9056814147825, 6346.6509341986175, 6352.6823658816875, 6365.236171659384, 3594.1733401317583, 3722.3858063419502, 3753.7372383933134, 3795.8671446499516, 3914.5498267699295, 1294.4951468927127, 1311.5344052861192, 1316.2957817567556, 1346.966325841852, 1355.5458921261388, 16033.599160020976, 16370.099644519547, 16487.587810304718, 16558.254878530493, 16642.916785415997, 5193.844184674465, 5214.739263036833, 5402.810901618424, 5433.347998240237, 5460.6996615186545, 12301.630951071482, 12365.876341236473, 12393.132480726443, 12427.130100892851, 12438.378081095909, 6066.150738896558, 6143.354947730513, 6172.629642221481, 6173.043178307369, 6205.472534834499, 5661.858453538612, 5732.484076433141, 5767.740451679684, 5772.9711351442975, 5803.8549036274435, 4159.584041595816, 4217.936730949038, 4226.323788193874, 4290.2706539888295, 4292.205941900758, 1187.588362229329, 1199.5082016373244, 1211.6122840690894, 1216.6410908781932, 1223.1193540650718, 793.8967934168521, 809.8461292354434, 816.9959150204211, 820.1142765812908, 862.9827403451895, 6848.9657551711925, 7070.540414873017, 7076.0280682113635, 7286.599237042014, 7501.437392195608, 964.6720115160879, 967.5984466446346, 978.6525783346809, 994.6021591363512, 1000.4147573669339, 4162.979185104055, 4337.587929146726, 4365.192439398721, 4421.115776844644, 4660.603848672833, 13932.721345573234, 14676.779848302283, 14683.48607798722, 14701.411943522353, 14716.558503244705, 12927.224366538037, 13343.599692009062, 14311.499097531536, 14657.706845863024, 14702.411903523953, 7679.577623230664, 8807.295416366675, 8967.730968070968, 8991.730248092437, 9004.36969412135, 6691.866162676622, 6877.862442751217, 6900.965495172492, 6908.620025898423, 6930.965345173242, 12043.518259269531, 12583.370831458573, 12625.431855566705, 12911.677208069874, 13145.0, 13105.868941310466, 13127.212367257995, 13157.407916643582, 13273.469061237442, 13279.468821247043, 10254.0, 10458.581656733646, 10502.947485262524, 10509.894901051197, 10556.208284378548, 10300.0, 10477.790444191225, 10601.0, 10613.522391492555, 10659.09397701204, 8198.631061602124, 8386.454880432751, 8468.153184681729, 8704.60829262672, 8907.866382004404, 8345.95827020861, 8445.493270403795, 8470.661173553235, 8485.703000394957, 8505.87241191395, 7642.312191902755, 7800.141984381827, 7896.84206315882, 7929.405294602812, 7929.444938854225, 5691.345495267931, 5788.247527821524, 5860.970695146497, 5871.7651293947765, 6181.876362472815, 6076.0, 6125.785597504066, 6169.5064394849205, 6510.31641677636, 6550.541462097607], "value": 5267.553952206496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.98803035908924, 402.8157611539487, 403.8731937893278, 405.12493015087415, 410.5607000509454, 6285.617164223875, 6305.216869878071, 6336.271328797184, 6374.490040796737, 6382.521310901683, 5836.649801011942, 6102.958071509207, 6149.354317796634, 6149.385061493848, 6155.815325540229, 4752.59602933751, 4770.475247722757, 4802.471728109905, 4802.663813533054, 4823.348847905523, 4782.13921494131, 4796.3045358423005, 4815.686980346266, 4818.5422384873555, 4850.854474365775, 4738.620910327183, 4764.711170600631, 4769.52304769522, 4772.57046865782, 4775.403074615673, 4770.141374552579, 4778.25936979767, 4779.856604301876, 4785.9521404785855, 4800.687955282895, 4214.578542145791, 4214.7471151731, 4221.55673654265, 4221.873343799691, 4231.322988321854, 6030.487408570277, 6031.577789554733, 6037.54718396122, 6049.788257411014, 6120.714649923521, 5486.972565137149, 5488.158289197538, 5502.614816962814, 5502.669839809624, 5503.284573005483, 6486.6053798433095, 6489.35106489352, 6492.772752953671, 6493.467547656418, 6503.869922601569, 4582.770861456914, 4589.655775816827, 4590.104929538741, 4596.287575425815, 4599.977000115012, 6559.409033431815, 6804.319568043205, 6832.726690932357, 6942.0, 6942.514024018321, 4537.137943790669, 4641.883952901137, 4660.161170989254, 4661.673682842168, 4679.789409476582, 4721.244600863845, 4725.637181409295, 4726.0, 4738.099761045391, 4749.453812811502, 5275.235090911873, 5395.73021348931, 5426.472792684786, 5434.885848401068, 5440.238366628675, 6512.837179070561, 6538.803835884836, 6573.342665733484, 6580.40776330123, 6581.6709164542535, 1602.7275363188053, 1606.068480281434, 1606.329417405908, 1606.8232494425604, 1610.549046267047, 1064.685917654294, 1082.924195306321, 1106.1427393769893, 1106.5006915629367, 1110.566878917223, 5804.129380592861, 5829.0, 5849.298084229919, 5867.853303667357, 5872.7357268923, 6732.192136943598, 6753.696083676246, 6762.647470505918, 6767.661616919135, 6772.492063095189, 5780.393058728857, 5784.855378615484, 5802.65184088956, 5810.099434587646, 5810.389909059572, 3603.3694103532303, 3621.058524783575, 3624.347617428888, 3648.1426864686778, 3655.415133578668, 6503.642299673469, 6539.50953678476, 6539.705713242915, 6546.509011824132, 6557.393438607476, 6907.13660792401, 6907.827304317432, 6909.585424874524, 6920.9653951729915, 6940.375366217065, 6480.189976252968, 6481.282460148064, 6530.281669016499, 6536.542442029107, 6557.147570815859, 6737.494687898526, 6742.6291553965, 6758.8648227036165, 6766.594004359754, 6777.762778302933, 6729.52893297484, 6736.4947628929, 6761.594304341756, 6761.628110453776, 6775.762848300285, 6151.231096112986, 6506.674666266573, 6535.379138981789, 6556.147700799056, 6577.0, 4621.537846215351, 4653.255479123324, 4665.976670116627, 4673.813047478063, 4674.392328997209, 6740.854054810792, 6742.831429214309, 6745.853204955071, 6777.661116944231, 6784.491163162684, 6337.271213810471, 6394.712237949397, 6451.806445806634, 6486.254080780771, 6496.837579060372, 6502.642354670538, 6511.9348806511325, 6518.641474718936, 6518.771842985662, 6551.672416379257, 6396.456301214263, 6406.5334846085525, 6423.389777971272, 6438.935610643834, 6443.806685799434, 6515.403726087139, 6515.54391192612, 6540.542162048611, 6542.182227221598, 6553.951367781132, 6291.591046581958, 6367.80896573085, 6396.648184349905, 6417.133686952202, 6430.549861509649], "value": 4920.29758865189, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6728924785464, 827.735124760077, 833.4832403909576, 836.3727204596548, 854.2439940652524, 14533.418663253484, 15265.08409495431, 17128.057956812372, 17502.737458938125, 17547.298108075676, 15837.84162158378, 16524.339026438927, 16585.91707041466, 16627.334906603723, 16655.33378664852, 934.7709811096291, 963.4845357733614, 965.2037069417723, 965.4931161140387, 971.8833739951216, 683.3439897698215, 746.8692978728728, 913.995430022849, 935.9766005849874, 936.6159874451477, 986.2159583131428, 989.1789814454022, 990.4552496127101, 990.7027891632517, 990.8018396320729, 979.5836769373059, 980.0, 984.9606015759362, 990.282045516998, 991.6380521109816, 727.538013361514, 728.7412968396196, 729.1505396213405, 731.3454458259828, 733.8385555177853, 16808.74786878198, 16866.156692165343, 17038.574035649082, 17109.23008464622, 17997.460076197734, 18304.908475457538, 18419.35532256378, 18736.812631873778, 18753.249870005184, 18800.24799008038, 14974.101553906801, 15167.0, 15212.46756363522, 15263.160526171056, 15285.388584456608, 3409.1647546351055, 3448.896533104011, 3501.142220156078, 3540.9114772130647, 3546.131197856516, 85998.0, 87055.0, 87328.56335718345, 87346.5632671839, 87499.0, 14293.78559321611, 14524.273786310641, 14609.0, 14766.48317308889, 15131.697366052616, 26247.868760656074, 26599.601005984925, 26794.598081028802, 26806.195814125607, 27039.324016899736, 7983.0, 7985.72049978248, 8004.759857204293, 8055.7583272501915, 8088.797780055545, 3371.9494207586904, 3490.3891818931584, 3766.0961369271176, 3866.8259928303296, 3916.5691773904846, 4480.529544397857, 4639.652026098056, 4644.814207431732, 4670.369500117508, 4685.297205419214, 826.2935190412111, 830.9044459887069, 854.692310768123, 854.9401541892132, 855.4995327733221, 655.8721049395322, 678.4436761855231, 679.8844196486609, 687.7627218609572, 696.0394655375651, 10785.62250321235, 11087.667369978913, 11808.645740627795, 13204.537841175512, 13361.599152025456, 644.6196743921015, 665.4077870695086, 669.926308106108, 677.7289084366292, 679.9388055075067, 4998.475160108136, 5183.50756678115, 5269.209618557247, 5393.892122157614, 5463.699496527729, 97600.51199743956, 98023.0, 99302.0, 99336.50331748294, 99989.0, 81205.59397203094, 81797.0, 81882.0, 82193.0, 82555.17444825594, 68423.65788171127, 72391.0, 74270.0, 74573.62713186399, 74980.3756868507, 10345.0, 11021.614243501439, 11740.58907938218, 11860.822087668865, 12005.39973001329, 28588.42823143567, 28949.7105028947, 29211.0, 29427.264318391353, 30392.0, 52659.73670131625, 52827.0, 54509.72745136249, 54886.176707348626, 55096.72451637716, 16588.50234492967, 16794.664106718043, 16823.7476437856, 17012.06433646161, 17071.146442678066, 18423.355182568546, 18622.81377186265, 18917.810821892155, 18950.905245473685, 19334.323298684478, 16827.326906923587, 16885.493435196473, 16955.0, 17163.31346746116, 17252.741208881627, 16673.666526669156, 16927.238274277934, 17125.0, 17608.0, 17664.823351766318, 16964.74552881683, 17254.137293135544, 17299.827001730326, 17658.5585360367, 17912.641747164722, 10369.769419492242, 11351.432428378714, 11560.595379161688, 12106.818397724217, 12492.25046497213, 12259.448324825225, 12396.752064958831, 12590.307533085403, 12671.30307833078, 12942.158759680968], "value": 8147.537255239945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 109.0, 111.0, 114.0, 110.0, 111.0, 111.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 122.0, 173.0, 121.0, 121.0, 122.0, 121.0, 145.0, 126.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 166.0, 166.0, 167.0, 172.0, 171.0, 167.0, 163.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 77.0, 118.0, 74.0, 73.0, 74.0, 74.0, 99.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 105.0, 83.0, 83.0, 83.0, 98.0, 83.0, 83.0, 103.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 117.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 151.0, 150.0, 149.0, 150.0, 149.0, 151.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 99.0, 95.0, 94.0, 94.0, 102.0, 99.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 59.0, 58.0, 62.0, 56.0, 57.0, 57.0, 59.0, 63.0, 55.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 58.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 86.0, 90.0, 89.0, 87.0, 88.0, 87.0, 123.0, 102.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 131.0, 143.0, 130.0, 134.0, 133.0, 128.0, 128.0, 140.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 197.0, 196.0, 193.0, 189.0, 191.0, 187.0, 194.0, 186.0, 188.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 75.0, 73.0, 75.0, 71.0, 71.0, 71.0, 71.0, 72.0], "value": 72.3, "unit": "score"}]}]} 03:06:47 INFO - Return code: 0 03:06:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:06:47 INFO - # TBPL SUCCESS # 03:06:47 INFO - Running post-action listener: _resource_record_post_action 03:06:47 INFO - [mozharness: 2017-06-05 10:06:47.552917Z] Finished run-tests step (success) 03:06:47 INFO - Running post-run listener: _resource_record_post_run 03:06:47 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434049024; Read time: 216; Write time: 246096 03:06:47 INFO - TinderboxPrint: CPU usage
12.7% 03:06:47 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 216 03:06:47 INFO - TinderboxPrint: I/O write bytes / time
434,049,024 / 246,096 03:06:47 INFO - TinderboxPrint: CPU idle
8,732.4 (87.3%) 03:06:47 INFO - TinderboxPrint: CPU user
1,213.2 (12.1%) 03:06:47 INFO - TinderboxPrint: Swap in / out
0 / 0 03:06:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103305216; Read time: 0; Write time: 86688 03:06:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:06:47 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 12288; Write bytes: 330354688; Read time: 216; Write time: 159384 03:06:48 INFO - Running post-run listener: _upload_blobber_files 03:06:48 INFO - Blob upload gear active. 03:06:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:06:48 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 03:06:48 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'] 03:06:48 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 03:06:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:06:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:06:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:06:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:49 INFO - (blobuploader) - INFO - Done attempting. 03:06:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:06:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:06:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:50 INFO - (blobuploader) - INFO - Done attempting. 03:06:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:06:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:57 INFO - (blobuploader) - INFO - Done attempting. 03:06:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:06:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:06:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:06:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:06:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:06:57 INFO - (blobuploader) - INFO - Done attempting. 03:06:57 INFO - (blobuploader) - INFO - Iteration through files over. 03:06:57 INFO - Return code: 0 03:06:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:06:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:06:57 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9cd8c854c2cbdcb84dba05d429a10232a9d26950825afa489f2e5b5df9ec8a4059d5552fc960d67bf035b5522e065ff62d1cbae3c75e8e4ba1effff7b40013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e924fa1eff6c4fb9ff1095a80c68e3c34a174d39167f5e16c3a4701994eb2ac4c2b80bb255c9636521f7ab4d1e77ecacd6fa7193d82518a2246503f3a7f1e549", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6d58563206f60785d8b37cd3bef22d17cf898652b12f03a83db094836d405d0e8090d57eb21061d8ed00bc7afcebdcb223673f95ac3389cafde00d479194fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecb03c64f0c47da04c77310e34f990cbdd27a5b507ce67eb43b7b4eb688b0a555fee1d8f05252687a542676b83fa65774be666d2f98ec879e54b933131adae96"} 03:06:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:06:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:06:57 INFO - Contents: 03:06:57 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9cd8c854c2cbdcb84dba05d429a10232a9d26950825afa489f2e5b5df9ec8a4059d5552fc960d67bf035b5522e065ff62d1cbae3c75e8e4ba1effff7b40013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e924fa1eff6c4fb9ff1095a80c68e3c34a174d39167f5e16c3a4701994eb2ac4c2b80bb255c9636521f7ab4d1e77ecacd6fa7193d82518a2246503f3a7f1e549", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6d58563206f60785d8b37cd3bef22d17cf898652b12f03a83db094836d405d0e8090d57eb21061d8ed00bc7afcebdcb223673f95ac3389cafde00d479194fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecb03c64f0c47da04c77310e34f990cbdd27a5b507ce67eb43b7b4eb688b0a555fee1d8f05252687a542676b83fa65774be666d2f98ec879e54b933131adae96"} 03:06:57 INFO - Running post-run listener: copy_logs_to_upload_dir 03:06:57 INFO - Copying logs to upload dir... 03:06:57 INFO - mkdir: /builds/slave/test/build/upload/logs 03:06:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.358499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-06-05 03:06:56.794204) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:06:56.798137) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9cd8c854c2cbdcb84dba05d429a10232a9d26950825afa489f2e5b5df9ec8a4059d5552fc960d67bf035b5522e065ff62d1cbae3c75e8e4ba1effff7b40013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e924fa1eff6c4fb9ff1095a80c68e3c34a174d39167f5e16c3a4701994eb2ac4c2b80bb255c9636521f7ab4d1e77ecacd6fa7193d82518a2246503f3a7f1e549", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6d58563206f60785d8b37cd3bef22d17cf898652b12f03a83db094836d405d0e8090d57eb21061d8ed00bc7afcebdcb223673f95ac3389cafde00d479194fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecb03c64f0c47da04c77310e34f990cbdd27a5b507ce67eb43b7b4eb688b0a555fee1d8f05252687a542676b83fa65774be666d2f98ec879e54b933131adae96"} build_url:https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/NVsSSnvXTZSfWgd9XpcK7A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9cd8c854c2cbdcb84dba05d429a10232a9d26950825afa489f2e5b5df9ec8a4059d5552fc960d67bf035b5522e065ff62d1cbae3c75e8e4ba1effff7b40013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e924fa1eff6c4fb9ff1095a80c68e3c34a174d39167f5e16c3a4701994eb2ac4c2b80bb255c9636521f7ab4d1e77ecacd6fa7193d82518a2246503f3a7f1e549", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a6d58563206f60785d8b37cd3bef22d17cf898652b12f03a83db094836d405d0e8090d57eb21061d8ed00bc7afcebdcb223673f95ac3389cafde00d479194fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecb03c64f0c47da04c77310e34f990cbdd27a5b507ce67eb43b7b4eb688b0a555fee1d8f05252687a542676b83fa65774be666d2f98ec879e54b933131adae96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:06:56.822647) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:06:56.822971) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1496655902.854626-1251747805 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:06:56.908978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:06:56.909321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:06:56.909730) ========= ========= Total master_lag: 0.19 =========