builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1496656372.22 results: success (0) revision: 275588f4d852d7dc183a9dcc70a311413dc7a063 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.223834) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.224328) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.224645) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.240944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.241283) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-05 02:52:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.8M=0s 2017-06-05 02:52:52 (31.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.192938 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.476260) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.476583) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:52.526945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:52:52.527302) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 275588f4d852d7dc183a9dcc70a311413dc7a063 --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 275588f4d852d7dc183a9dcc70a311413dc7a063 --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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-05 02:52:52,580 truncating revision to first 12 chars 2017-06-05 02:52:52,580 Setting DEBUG logging. 2017-06-05 02:52:52,580 attempt 1/10 2017-06-05 02:52:52,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/275588f4d852?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-05 02:52:53,608 unpacking tar archive at: mozilla-central-275588f4d852/testing/mozharness/ program finished with exit code 0 elapsedTime=1.370120 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-05 02:52:53.909500) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:53.909853) ========= script_repo_revision: 275588f4d852d7dc183a9dcc70a311413dc7a063 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:53.910265) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:53.910534) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-05 02:52:53.920502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-05 02:52:53.920795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:52:54 INFO - MultiFileLogger online at 20170605 02:52:54 in /builds/slave/test 02:52:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:52:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:54 INFO - {'append_to_log': False, 02:52:54 INFO - 'base_work_dir': '/builds/slave/test', 02:52:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:52:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:54 INFO - 'branch': 'Firefox-Non-PGO', 02:52:54 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:54 INFO - 'config_files': ('talos/linux_config.py',), 02:52:54 INFO - 'default_actions': ('clobber', 02:52:54 INFO - 'read-buildbot-config', 02:52:54 INFO - 'download-and-extract', 02:52:54 INFO - 'populate-webroot', 02:52:54 INFO - 'create-virtualenv', 02:52:54 INFO - 'install', 02:52:54 INFO - 'setup-mitmproxy', 02:52:54 INFO - 'run-tests'), 02:52:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:54 INFO - 'download_minidump_stackwalk': True, 02:52:54 INFO - 'download_symbols': 'ondemand', 02:52:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:54 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:54 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:54 INFO - 'gecko_profile': False, 02:52:54 INFO - 'gecko_profile_interval': 0, 02:52:54 INFO - 'installer_path': 'installer.exe', 02:52:54 INFO - 'log_level': 'info', 02:52:54 INFO - 'log_name': 'talos', 02:52:54 INFO - 'log_to_console': True, 02:52:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:52:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:52:54 INFO - 'opt_config_files': (), 02:52:54 INFO - 'pip_index': False, 02:52:54 INFO - 'suite': 'dromaeojs-e10s', 02:52:54 INFO - 'system_bits': '32', 02:52:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:54 INFO - 'title': 'talos-linux64-ix-068', 02:52:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:54 INFO - 'use_talos_json': True, 02:52:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:54 INFO - 'work_dir': 'build'} 02:52:54 INFO - [mozharness: 2017-06-05 09:52:54.200616Z] Running clobber step. 02:52:54 INFO - Running pre-action listener: _resource_record_pre_action 02:52:54 INFO - Running main action method: clobber 02:52:54 INFO - rmtree: /builds/slave/test/build 02:52:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:55 INFO - Running post-action listener: _resource_record_post_action 02:52:55 INFO - [mozharness: 2017-06-05 09:52:55.188014Z] Finished clobber step (success) 02:52:55 INFO - [mozharness: 2017-06-05 09:52:55.188116Z] Running read-buildbot-config step. 02:52:55 INFO - Running pre-action listener: _resource_record_pre_action 02:52:55 INFO - Running main action method: read_buildbot_config 02:52:55 INFO - Using buildbot properties: 02:52:55 INFO - { 02:52:55 INFO - "project": "", 02:52:55 INFO - "product": "firefox", 02:52:55 INFO - "who": "archaeopteryx@coole-files.de", 02:52:55 INFO - "installer_path": "public/build/target.tar.bz2", 02:52:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:52:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:52:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:52:55 INFO - "stage_platform": "linux64", 02:52:55 INFO - "basedir": "/builds/slave/test", 02:52:55 INFO - "buildnumber": 932, 02:52:55 INFO - "platform": "ubuntu64_hw", 02:52:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:52:55 INFO - "slavebuilddir": "test", 02:52:55 INFO - "taskId": "dgAN92cwQIKaZCnfrat4NQ", 02:52:55 INFO - "branch": "mozilla-central", 02:52:55 INFO - "script_repo_revision": "production", 02:52:55 INFO - "revision": "275588f4d852d7dc183a9dcc70a311413dc7a063", 02:52:55 INFO - "slavename": "talos-linux64-ix-068", 02:52:55 INFO - "repo_path": "mozilla-central" 02:52:55 INFO - } 02:52:55 INFO - Finding installer, test and symbols from parent task. 02:52:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgAN92cwQIKaZCnfrat4NQ'}, attempt #1 02:52:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgAN92cwQIKaZCnfrat4NQ'}, attempt #1 02:52:56 INFO - Task dependencies: GGIj7gUQTUKYCybQRx4diQ 02:52:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ'}, attempt #1 02:52:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 02:52:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/test_packages.json 02:52:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.crashreporter-symbols.zip 02:52:56 INFO - Running post-action listener: _resource_record_post_action 02:52:56 INFO - [mozharness: 2017-06-05 09:52:56.568564Z] Finished read-buildbot-config step (success) 02:52:56 INFO - [mozharness: 2017-06-05 09:52:56.568785Z] Running download-and-extract step. 02:52:56 INFO - Running pre-action listener: _resource_record_pre_action 02:52:56 INFO - Running main action method: download_and_extract 02:52:56 INFO - mkdir: /builds/slave/test/build/tests 02:52:56 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:52:56 INFO - trying https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.test_packages.json 02:52:56 INFO - Downloading https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:52:57 INFO - Downloaded 989 bytes. 02:52:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:52:57 INFO - Using the following test package requirements: 02:52:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:52:57 INFO - u'common': [u'target.common.tests.zip'], 02:52:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:52:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:52:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:52:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:52:57 INFO - u'mozbase': [u'target.common.tests.zip'], 02:52:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:52:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:52:57 INFO - u'web-platform': [u'target.common.tests.zip', 02:52:57 INFO - u'target.web-platform.tests.tar.gz'], 02:52:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:52:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:52:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip 02:52:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:52:57 INFO - Fetch https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip into memory 02:52:58 INFO - Content-Length response header: 65103157 02:52:58 INFO - Bytes received: 65103157 02:53:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:53:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip 02:53:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:53:09 INFO - Fetch https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.common.tests.zip into memory 02:53:10 INFO - Content-Length response header: 65103157 02:53:10 INFO - Bytes received: 65103157 02:53:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.talos.tests.zip 02:53:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:53:22 INFO - Fetch https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.talos.tests.zip into memory 02:53:23 INFO - Content-Length response header: 14447425 02:53:23 INFO - Bytes received: 14447425 02:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:23 INFO - trying https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 02:53:23 INFO - Downloading https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:53:24 INFO - Downloaded 58680172 bytes. 02:53:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 02:53:24 INFO - mkdir: /builds/slave/test/properties 02:53:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:53:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:53:24 INFO - Contents: 02:53:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 02:53:24 INFO - Running post-action listener: _resource_record_post_action 02:53:24 INFO - Running post-action listener: set_extra_try_arguments 02:53:24 INFO - [mozharness: 2017-06-05 09:53:24.741177Z] Finished download-and-extract step (success) 02:53:24 INFO - [mozharness: 2017-06-05 09:53:24.741349Z] Running populate-webroot step. 02:53:24 INFO - Running pre-action listener: _resource_record_pre_action 02:53:24 INFO - Running main action method: populate_webroot 02:53:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:53:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:53:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:53:24 INFO - '--tppagecycles', 02:53:24 INFO - '7'], 02:53:24 INFO - 'tests': ['tsvgm']}}, 02:53:24 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:53:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:53:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:53:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:53:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['damp', 'tps']}, 02:53:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'tests': ['damp', 'tps']}, 02:53:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['dromaeo_dom']}, 02:53:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:53:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:53:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:53:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:53:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['a11yr', 02:53:24 INFO - 'ts_paint', 02:53:24 INFO - 'tpaint', 02:53:24 INFO - 'sessionrestore', 02:53:24 INFO - 'sessionrestore_no_auto_restore', 02:53:24 INFO - 'tabpaint']}, 02:53:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:53:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:53:24 INFO - 'bloom_basic_ref']}, 02:53:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:53:24 INFO - 'talos_options': ['--mitmproxy', 02:53:24 INFO - 'mitmproxy-recording-1.mp', 02:53:24 INFO - '--firstNonBlankPaint'], 02:53:24 INFO - 'tests': ['Quantum_1']}, 02:53:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['tsvgx', 02:53:24 INFO - 'tsvgr_opacity', 02:53:24 INFO - 'tart', 02:53:24 INFO - 'tscrollx', 02:53:24 INFO - 'cart', 02:53:24 INFO - 'tsvg_static']}, 02:53:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:53:24 INFO - 'tsvgr_opacity', 02:53:24 INFO - 'tart', 02:53:24 INFO - 'tscrollx', 02:53:24 INFO - 'cart', 02:53:24 INFO - 'tsvg_static']}, 02:53:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'talos_options': ['--disable-e10s'], 02:53:24 INFO - 'tests': ['tp5o']}, 02:53:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:53:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'talos_options': ['--disable-e10s', 02:53:24 INFO - '--xperf_path', 02:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:24 INFO - 'tests': ['tp5n']}, 02:53:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:53:24 INFO - 'talos_options': ['--xperf_path', 02:53:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:53:24 INFO - 'tests': ['tp5n']}}, 02:53:24 INFO - 'talos.zip': {'path': '', 02:53:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:53:24 INFO - Running post-action listener: _resource_record_post_action 02:53:24 INFO - [mozharness: 2017-06-05 09:53:24.763626Z] Finished populate-webroot step (success) 02:53:24 INFO - [mozharness: 2017-06-05 09:53:24.763778Z] Running create-virtualenv step. 02:53:24 INFO - Running pre-action listener: _resource_record_pre_action 02:53:24 INFO - Running main action method: create_virtualenv 02:53:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:53:24 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:53:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:53:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:53:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:53:25 INFO - Using real prefix '/usr' 02:53:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:28 INFO - Installing pip.................done. 02:53:28 INFO - Return code: 0 02:53:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:53:28 INFO - Reading from file tmpfile_stdout 02:53:28 INFO - Output received: 02:53:28 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:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:28 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:28 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:53:28 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:53:28 INFO - Using env: {'DISPLAY': ':0', 02:53:28 INFO - 'HOME': '/home/cltbld', 02:53:28 INFO - 'LANG': 'en_US.UTF-8', 02:53:28 INFO - 'LANGUAGE': 'en_US:en', 02:53:28 INFO - 'LOGNAME': 'cltbld', 02:53:28 INFO - 'MAIL': '/var/mail/cltbld', 02:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:28 INFO - 'MOZ_NO_REMOTE': '1', 02:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:28 INFO - 'NO_EM_RESTART': '1', 02:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:28 INFO - 'PWD': '/builds/slave/test', 02:53:28 INFO - 'SHELL': '/bin/bash', 02:53:28 INFO - 'SHLVL': '1', 02:53:28 INFO - 'TERM': 'linux', 02:53:28 INFO - 'TMOUT': '86400', 02:53:28 INFO - 'USER': 'cltbld', 02:53:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:28 INFO - '_': '/tools/buildbot/bin/python'} 02:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:28 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:53:28 INFO - Cleaning up... 02:53:28 INFO - Return code: 0 02:53:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:28 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:28 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:53:28 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:53:28 INFO - Using env: {'DISPLAY': ':0', 02:53:28 INFO - 'HOME': '/home/cltbld', 02:53:28 INFO - 'LANG': 'en_US.UTF-8', 02:53:28 INFO - 'LANGUAGE': 'en_US:en', 02:53:28 INFO - 'LOGNAME': 'cltbld', 02:53:28 INFO - 'MAIL': '/var/mail/cltbld', 02:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:28 INFO - 'MOZ_NO_REMOTE': '1', 02:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:28 INFO - 'NO_EM_RESTART': '1', 02:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:28 INFO - 'PWD': '/builds/slave/test', 02:53:28 INFO - 'SHELL': '/bin/bash', 02:53:28 INFO - 'SHLVL': '1', 02:53:28 INFO - 'TERM': 'linux', 02:53:28 INFO - 'TMOUT': '86400', 02:53:28 INFO - 'USER': 'cltbld', 02:53:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:28 INFO - '_': '/tools/buildbot/bin/python'} 02:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:28 INFO - Downloading/unpacking psutil>=3.1.1 02:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:30 INFO - Installing collected packages: psutil 02:53:30 INFO - Running setup.py install for psutil 02:53:30 INFO - building 'psutil._psutil_linux' extension 02:53:30 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:53:31 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:53:31 INFO - building 'psutil._psutil_posix' extension 02:53:31 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:53:31 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:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:31 INFO - Successfully installed psutil 02:53:31 INFO - Cleaning up... 02:53:31 INFO - Return code: 0 02:53:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:53:31 INFO - Using env: {'DISPLAY': ':0', 02:53:31 INFO - 'HOME': '/home/cltbld', 02:53:31 INFO - 'LANG': 'en_US.UTF-8', 02:53:31 INFO - 'LANGUAGE': 'en_US:en', 02:53:31 INFO - 'LOGNAME': 'cltbld', 02:53:31 INFO - 'MAIL': '/var/mail/cltbld', 02:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:31 INFO - 'MOZ_NO_REMOTE': '1', 02:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:31 INFO - 'NO_EM_RESTART': '1', 02:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:31 INFO - 'PWD': '/builds/slave/test', 02:53:31 INFO - 'SHELL': '/bin/bash', 02:53:31 INFO - 'SHLVL': '1', 02:53:31 INFO - 'TERM': 'linux', 02:53:31 INFO - 'TMOUT': '86400', 02:53:31 INFO - 'USER': 'cltbld', 02:53:31 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:31 INFO - '_': '/tools/buildbot/bin/python'} 02:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:34 INFO - Installing collected packages: mozsystemmonitor 02:53:34 INFO - Running setup.py install for mozsystemmonitor 02:53:34 INFO - Successfully installed mozsystemmonitor 02:53:34 INFO - Cleaning up... 02:53:34 INFO - Return code: 0 02:53:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53: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:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53: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:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:53:34 INFO - Using env: {'DISPLAY': ':0', 02:53:34 INFO - 'HOME': '/home/cltbld', 02:53:34 INFO - 'LANG': 'en_US.UTF-8', 02:53:34 INFO - 'LANGUAGE': 'en_US:en', 02:53:34 INFO - 'LOGNAME': 'cltbld', 02:53:34 INFO - 'MAIL': '/var/mail/cltbld', 02:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:34 INFO - 'MOZ_NO_REMOTE': '1', 02:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:34 INFO - 'NO_EM_RESTART': '1', 02:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:34 INFO - 'PWD': '/builds/slave/test', 02:53:34 INFO - 'SHELL': '/bin/bash', 02:53:34 INFO - 'SHLVL': '1', 02:53:34 INFO - 'TERM': 'linux', 02:53:34 INFO - 'TMOUT': '86400', 02:53:34 INFO - 'USER': 'cltbld', 02:53:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:34 INFO - '_': '/tools/buildbot/bin/python'} 02:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:35 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:53:35 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:53:35 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:53:35 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:53:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:35 INFO - warning: no files found matching '*.txt' 02:53:35 INFO - no previously-included directories found matching 'build' 02:53:35 INFO - no previously-included directories found matching 'dist' 02:53:35 INFO - no previously-included directories found matching '.git*' 02:53:35 INFO - Installing collected packages: jsonschema, functools32 02:53:35 INFO - Running setup.py install for functools32 02:53:35 INFO - warning: no files found matching '*.txt' 02:53:35 INFO - no previously-included directories found matching 'build' 02:53:35 INFO - no previously-included directories found matching 'dist' 02:53:35 INFO - no previously-included directories found matching '.git*' 02:53:35 INFO - Successfully installed jsonschema functools32 02:53:35 INFO - Cleaning up... 02:53:35 INFO - Return code: 0 02:53:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:53:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:53:35 INFO - Using env: {'DISPLAY': ':0', 02:53:35 INFO - 'HOME': '/home/cltbld', 02:53:35 INFO - 'LANG': 'en_US.UTF-8', 02:53:35 INFO - 'LANGUAGE': 'en_US:en', 02:53:35 INFO - 'LOGNAME': 'cltbld', 02:53:35 INFO - 'MAIL': '/var/mail/cltbld', 02:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:35 INFO - 'MOZ_NO_REMOTE': '1', 02:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:35 INFO - 'NO_EM_RESTART': '1', 02:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:35 INFO - 'PWD': '/builds/slave/test', 02:53:35 INFO - 'SHELL': '/bin/bash', 02:53:35 INFO - 'SHLVL': '1', 02:53:35 INFO - 'TERM': 'linux', 02:53:35 INFO - 'TMOUT': '86400', 02:53:35 INFO - 'USER': 'cltbld', 02:53:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:35 INFO - '_': '/tools/buildbot/bin/python'} 02:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:36 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:36 INFO - Cleaning up... 02:53:36 INFO - Return code: 0 02:53:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:53:36 INFO - Using env: {'DISPLAY': ':0', 02:53:36 INFO - 'HOME': '/home/cltbld', 02:53:36 INFO - 'LANG': 'en_US.UTF-8', 02:53:36 INFO - 'LANGUAGE': 'en_US:en', 02:53:36 INFO - 'LOGNAME': 'cltbld', 02:53:36 INFO - 'MAIL': '/var/mail/cltbld', 02:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:36 INFO - 'MOZ_NO_REMOTE': '1', 02:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:36 INFO - 'NO_EM_RESTART': '1', 02:53:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:36 INFO - 'PWD': '/builds/slave/test', 02:53:36 INFO - 'SHELL': '/bin/bash', 02:53:36 INFO - 'SHLVL': '1', 02:53:36 INFO - 'TERM': 'linux', 02:53:36 INFO - 'TMOUT': '86400', 02:53:36 INFO - 'USER': 'cltbld', 02:53:36 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:36 INFO - '_': '/tools/buildbot/bin/python'} 02:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:36 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:37 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:53:37 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:53:37 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:53:37 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:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:37 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:53:37 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:53:37 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:53:37 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:53:37 INFO - Downloading docopt-0.6.1.tar.gz 02:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:38 INFO - Running setup.py install for blobuploader 02:53:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:38 INFO - Running setup.py install for requests 02:53:38 INFO - Running setup.py install for docopt 02:53:38 INFO - Successfully installed blobuploader requests docopt 02:53:38 INFO - Cleaning up... 02:53:38 INFO - Return code: 0 02:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53: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:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:38 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:38 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:53:38 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:53:38 INFO - Using env: {'DISPLAY': ':0', 02:53:38 INFO - 'HOME': '/home/cltbld', 02:53:38 INFO - 'LANG': 'en_US.UTF-8', 02:53:38 INFO - 'LANGUAGE': 'en_US:en', 02:53:38 INFO - 'LOGNAME': 'cltbld', 02:53:38 INFO - 'MAIL': '/var/mail/cltbld', 02:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:38 INFO - 'MOZ_NO_REMOTE': '1', 02:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:38 INFO - 'NO_EM_RESTART': '1', 02:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:38 INFO - 'PWD': '/builds/slave/test', 02:53:38 INFO - 'SHELL': '/bin/bash', 02:53:38 INFO - 'SHLVL': '1', 02:53:38 INFO - 'TERM': 'linux', 02:53:38 INFO - 'TMOUT': '86400', 02:53:38 INFO - 'USER': 'cltbld', 02:53:38 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:38 INFO - '_': '/tools/buildbot/bin/python'} 02:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:38 INFO - Running setup.py (path:/tmp/pip-5huEtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:38 INFO - Running setup.py (path:/tmp/pip-ayb6zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:38 INFO - Running setup.py (path:/tmp/pip-p2vjBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:39 INFO - Running setup.py (path:/tmp/pip-7XOg1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:39 INFO - Running setup.py (path:/tmp/pip-bxj5Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:39 INFO - Running setup.py (path:/tmp/pip-YyS2fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:39 INFO - Running setup.py (path:/tmp/pip-VnzUkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:39 INFO - Running setup.py (path:/tmp/pip-q8Znki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:39 INFO - Running setup.py (path:/tmp/pip-4Y5A2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:39 INFO - Running setup.py (path:/tmp/pip-vCKf4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:39 INFO - Running setup.py (path:/tmp/pip-Q9ZoCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:39 INFO - Running setup.py (path:/tmp/pip-HsdJd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:39 INFO - Running setup.py (path:/tmp/pip-lamsSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:39 INFO - Running setup.py (path:/tmp/pip-BNBVxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:39 INFO - Running setup.py (path:/tmp/pip-aOryuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:39 INFO - Running setup.py (path:/tmp/pip-b9ls4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:39 INFO - Running setup.py (path:/tmp/pip-VcxAVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:40 INFO - Running setup.py install for manifestparser 02:53:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozcrash 02:53:40 INFO - Running setup.py install for mozdebug 02:53:40 INFO - Running setup.py install for mozdevice 02:53:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozfile 02:53:40 INFO - Running setup.py install for mozhttpd 02:53:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozinfo 02:53:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozInstall 02:53:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:40 INFO - Running setup.py install for mozleak 02:53:40 INFO - Running setup.py install for mozlog 02:53:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for moznetwork 02:53:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for mozprocess 02:53:41 INFO - Running setup.py install for mozprofile 02:53:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for mozrunner 02:53:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Running setup.py install for mozscreenshot 02:53:41 INFO - Running setup.py install for moztest 02:53:41 INFO - Running setup.py install for mozversion 02:53:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:41 INFO - Cleaning up... 02:53:41 INFO - Return code: 0 02:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53: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:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53: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:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:41 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:41 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:53:41 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:53:41 INFO - Using env: {'DISPLAY': ':0', 02:53:41 INFO - 'HOME': '/home/cltbld', 02:53:41 INFO - 'LANG': 'en_US.UTF-8', 02:53:41 INFO - 'LANGUAGE': 'en_US:en', 02:53:41 INFO - 'LOGNAME': 'cltbld', 02:53:41 INFO - 'MAIL': '/var/mail/cltbld', 02:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:41 INFO - 'MOZ_NO_REMOTE': '1', 02:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:41 INFO - 'NO_EM_RESTART': '1', 02:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:41 INFO - 'PWD': '/builds/slave/test', 02:53:41 INFO - 'SHELL': '/bin/bash', 02:53:41 INFO - 'SHLVL': '1', 02:53:41 INFO - 'TERM': 'linux', 02:53:41 INFO - 'TMOUT': '86400', 02:53:41 INFO - 'USER': 'cltbld', 02:53:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:41 INFO - '_': '/tools/buildbot/bin/python'} 02:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:42 INFO - Running setup.py (path:/tmp/pip-LjMn7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:42 INFO - Running setup.py (path:/tmp/pip-duc80x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:42 INFO - Running setup.py (path:/tmp/pip-XQhRUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:42 INFO - Running setup.py (path:/tmp/pip-TnI42w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:42 INFO - Running setup.py (path:/tmp/pip-jFn5ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:42 INFO - Running setup.py (path:/tmp/pip-GNUnOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:42 INFO - Running setup.py (path:/tmp/pip-lRugOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:42 INFO - Running setup.py (path:/tmp/pip-QC53Bm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:42 INFO - Running setup.py (path:/tmp/pip-3wZb3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:42 INFO - Running setup.py (path:/tmp/pip-ymb_lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:42 INFO - Running setup.py (path:/tmp/pip-Aj6Xi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:42 INFO - Running setup.py (path:/tmp/pip-hneAIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:42 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:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:42 INFO - Running setup.py (path:/tmp/pip-XGdJeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:43 INFO - Running setup.py (path:/tmp/pip-WzEMBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:43 INFO - Running setup.py (path:/tmp/pip-yl5wqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:43 INFO - Running setup.py (path:/tmp/pip-f5Z152-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:53:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:43 INFO - Running setup.py (path:/tmp/pip-dhkiZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53: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:53: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:53: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:53: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:53:44 INFO - Downloading blessings-1.6.tar.gz 02:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:44 INFO - Installing collected packages: blessings 02:53:44 INFO - Running setup.py install for blessings 02:53:44 INFO - Successfully installed blessings 02:53:44 INFO - Cleaning up... 02:53:44 INFO - Return code: 0 02:53:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:44 INFO - Reading from file tmpfile_stdout 02:53:44 INFO - Current package versions: 02:53:44 INFO - argparse == 1.2.1 02:53:44 INFO - blessings == 1.6 02:53:44 INFO - blobuploader == 1.2.4 02:53:44 INFO - docopt == 0.6.1 02:53:44 INFO - functools32 == 3.2.3-2 02:53:44 INFO - jsonschema == 2.5.1 02:53:44 INFO - manifestparser == 1.1 02:53:44 INFO - mozInstall == 1.12 02:53:44 INFO - mozcrash == 1.0 02:53:44 INFO - mozdebug == 0.1 02:53:44 INFO - mozdevice == 0.51 02:53:44 INFO - mozfile == 1.2 02:53:44 INFO - mozhttpd == 0.7 02:53:44 INFO - mozinfo == 0.9 02:53:44 INFO - mozleak == 0.1 02:53:44 INFO - mozlog == 3.4 02:53:44 INFO - moznetwork == 0.27 02:53:44 INFO - mozprocess == 0.25 02:53:44 INFO - mozprofile == 0.28 02:53:44 INFO - mozrunner == 6.13 02:53:44 INFO - mozscreenshot == 0.1 02:53:44 INFO - mozsystemmonitor == 0.3 02:53:44 INFO - moztest == 0.8 02:53:44 INFO - mozversion == 1.4 02:53:44 INFO - psutil == 3.1.1 02:53:44 INFO - requests == 1.2.3 02:53:44 INFO - wsgiref == 0.1.2 02:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:44 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:44 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:53:44 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:53:44 INFO - Using env: {'DISPLAY': ':0', 02:53:44 INFO - 'HOME': '/home/cltbld', 02:53:44 INFO - 'LANG': 'en_US.UTF-8', 02:53:44 INFO - 'LANGUAGE': 'en_US:en', 02:53:44 INFO - 'LOGNAME': 'cltbld', 02:53:44 INFO - 'MAIL': '/var/mail/cltbld', 02:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:44 INFO - 'MOZ_NO_REMOTE': '1', 02:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:44 INFO - 'NO_EM_RESTART': '1', 02:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:44 INFO - 'PWD': '/builds/slave/test', 02:53:44 INFO - 'SHELL': '/bin/bash', 02:53:44 INFO - 'SHLVL': '1', 02:53:44 INFO - 'TERM': 'linux', 02:53:44 INFO - 'TMOUT': '86400', 02:53:44 INFO - 'USER': 'cltbld', 02:53:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:44 INFO - '_': '/tools/buildbot/bin/python'} 02:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:53:45 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:53: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:53: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:53: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:53: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:53:46 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:53:46 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:53:46 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:53:46 INFO - Installing collected packages: marionette-driver 02:53:46 INFO - Running setup.py install for marionette-driver 02:53:46 INFO - Successfully installed marionette-driver 02:53:46 INFO - Cleaning up... 02:53:46 INFO - Return code: 0 02:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53: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:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53: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:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:46 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 0x259b3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2775a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', '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:53:46 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:53:46 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:53:46 INFO - Using env: {'DISPLAY': ':0', 02:53:46 INFO - 'HOME': '/home/cltbld', 02:53:46 INFO - 'LANG': 'en_US.UTF-8', 02:53:46 INFO - 'LANGUAGE': 'en_US:en', 02:53:46 INFO - 'LOGNAME': 'cltbld', 02:53:46 INFO - 'MAIL': '/var/mail/cltbld', 02:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:46 INFO - 'MOZ_NO_REMOTE': '1', 02:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:53:46 INFO - 'NO_EM_RESTART': '1', 02:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:46 INFO - 'PWD': '/builds/slave/test', 02:53:46 INFO - 'SHELL': '/bin/bash', 02:53:46 INFO - 'SHLVL': '1', 02:53:46 INFO - 'TERM': 'linux', 02:53:46 INFO - 'TMOUT': '86400', 02:53:46 INFO - 'USER': 'cltbld', 02:53:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:46 INFO - '_': '/tools/buildbot/bin/python'} 02:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:46 INFO - Cleaning up... 02:53:46 INFO - Return code: 0 02:53:46 INFO - Running post-action listener: _resource_record_post_action 02:53:46 INFO - Running post-action listener: _start_resource_monitoring 02:53:46 INFO - Starting resource monitoring. 02:53:46 INFO - [mozharness: 2017-06-05 09:53:46.669830Z] Finished create-virtualenv step (success) 02:53:46 INFO - [mozharness: 2017-06-05 09:53:46.670768Z] Running install step. 02:53:46 INFO - Running pre-action listener: _resource_record_pre_action 02:53:46 INFO - Running main action method: install 02:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:46 INFO - Reading from file tmpfile_stdout 02:53:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:46 INFO - Reading from file tmpfile_stdout 02:53:46 INFO - Output received: 02:53:46 INFO - Usage: mozinstall [options] installer 02:53:46 INFO - Options: 02:53:46 INFO - -h, --help show this help message and exit 02:53:46 INFO - -d DEST, --destination=DEST 02:53:46 INFO - Directory to install application into. [default: 02:53:46 INFO - "/builds/slave/test"] 02:53:46 INFO - --app=APP Application being installed. [default: firefox] 02:53:46 INFO - mkdir: /builds/slave/test/build/application 02:53:46 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:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:54:03 INFO - Reading from file tmpfile_stdout 02:54:03 INFO - Output received: 02:54:03 INFO - /builds/slave/test/build/application/firefox/firefox 02:54:03 INFO - Running post-action listener: _resource_record_post_action 02:54:04 INFO - [mozharness: 2017-06-05 09:54:04.000214Z] Finished install step (success) 02:54:04 INFO - [mozharness: 2017-06-05 09:54:04.000497Z] Running setup-mitmproxy step. 02:54:04 INFO - Running pre-action listener: _resource_record_pre_action 02:54:04 INFO - Running main action method: setup_mitmproxy 02:54:04 INFO - Skipping: mitmproxy is not required 02:54:04 INFO - Running post-action listener: _resource_record_post_action 02:54:04 INFO - [mozharness: 2017-06-05 09:54:04.001838Z] Finished setup-mitmproxy step (success) 02:54:04 INFO - [mozharness: 2017-06-05 09:54:04.002059Z] Running run-tests step. 02:54:04 INFO - Running pre-action listener: _resource_record_pre_action 02:54:04 INFO - Running main action method: run_tests 02:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:04 INFO - Python 2.7.3 02:54:04 INFO - Return code: 0 02:54:04 INFO - grabbing minidump binary from tooltool 02:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:04 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 0x2916840>, '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 0x2917740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2917bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:04 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:54:04 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:54:04 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:54:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:04 INFO - Return code: 0 02:54:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:54:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:04 INFO - ENV: RUST_BACKTRACE is now 1 02:54:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:54:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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:54:04 INFO - Using env: {'DISPLAY': ':0', 02:54:04 INFO - 'HOME': '/home/cltbld', 02:54:04 INFO - 'LANG': 'en_US.UTF-8', 02:54:04 INFO - 'LANGUAGE': 'en_US:en', 02:54:04 INFO - 'LOGNAME': 'cltbld', 02:54:04 INFO - 'MAIL': '/var/mail/cltbld', 02:54:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:04 INFO - 'MOZ_NO_REMOTE': '1', 02:54:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:54:04 INFO - 'NO_EM_RESTART': '1', 02:54:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:04 INFO - 'PWD': '/builds/slave/test', 02:54:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:04 INFO - 'RUST_BACKTRACE': '1', 02:54:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:54:04 INFO - 'SHELL': '/bin/bash', 02:54:04 INFO - 'SHLVL': '1', 02:54:04 INFO - 'TERM': 'linux', 02:54:04 INFO - 'TMOUT': '86400', 02:54:04 INFO - 'USER': 'cltbld', 02:54:04 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407', 02:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:04 INFO - '_': '/tools/buildbot/bin/python'} 02:54:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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:54:04 INFO - mozversion application_buildid: 20170605090608 02:54:04 INFO - mozversion application_changeset: 275588f4d852d7dc183a9dcc70a311413dc7a063 02:54:04 INFO - mozversion application_display_name: Nightly 02:54:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:04 INFO - mozversion application_name: Firefox 02:54:04 INFO - mozversion application_remotingname: firefox 02:54:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:54:04 INFO - mozversion application_vendor: Mozilla 02:54:04 INFO - mozversion application_version: 55.0a1 02:54:04 INFO - mozversion platform_buildid: 20170605090608 02:54:04 INFO - mozversion platform_changeset: 275588f4d852d7dc183a9dcc70a311413dc7a063 02:54:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:54:04 INFO - mozversion platform_version: 55.0a1 02:54:04 INFO - using testdate: 1496656444 02:54:04 INFO - actual date: 1496656444 02:54:04 INFO - starting webserver on 'localhost:56485' 02:54:04 INFO - SUITE-START | Running 2 tests 02:54:04 INFO - TEST-START | dromaeo_css 02:54:04 INFO - operating with platform_type : linux_ 02:54:04 INFO - Initialising browser for dromaeo_css test... 02:54:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56485/getInfo.html -profile /tmp/tmpgo3wGz/profile 02:54:04 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox http://localhost:56485/getInfo.html) 02:54:41 INFO - TEST-INFO | 3316: killed by SIGTERM 02:54:41 INFO - Browser initialized. 02:54:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:41 INFO - TEST-INFO | started process 3527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgo3wGz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:53 INFO - PID 3527 | RSS: Main: 186978304 02:54:53 INFO - PID 3527 | 02:57:54 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56485/tests/dromaeo/cssquery-ext.html) 02:57:55 INFO - PID 3527 | RSS: Main: 181825536 02:57:55 INFO - PID 3527 | 03:00:57 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-ext.html (next: http://localhost:56485/tests/dromaeo/cssquery-jquery.html) 03:00:58 INFO - PID 3527 | RSS: Main: 187666432 03:00:58 INFO - PID 3527 | 03:04:00 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56485/tests/dromaeo/cssquery-mootools.html) 03:04:00 INFO - PID 3527 | RSS: Main: 184811520 03:04:00 INFO - PID 3527 | 03:07:02 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56485/tests/dromaeo/cssquery-prototype.html) 03:07:03 INFO - PID 3527 | RSS: Main: 189411328 03:07:03 INFO - PID 3527 | 03:10:05 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56485/tests/dromaeo/cssquery-yui.html) 03:10:06 INFO - PID 3527 | RSS: Main: 187953152 03:10:06 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | Cycle 1(1): loaded http://localhost:56485/tests/dromaeo/cssquery-yui.html (next: http://localhost:56485/tests/dromaeo/cssquery-dojo.html) 03:13:08 INFO - PID 3527 | RSS: Main: 187387904 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | __start_tp_report 03:13:08 INFO - PID 3527 | _x_x_mozilla_page_load 03:13:08 INFO - PID 3527 | _x_x_mozilla_page_load_details 03:13:08 INFO - PID 3527 | |i|pagename|runs| 03:13:08 INFO - PID 3527 | |0;dojo.html;3094.3192497650507;3117.859696313666;3152.4956007038877;3166.857491412885;3177.2692280775423;5902.144189092579;6003.069524223742;6015.939840601593;6019.879602407955;6022.578419510636;5911;5993.0710739835395;6012.909806352908;6034.064719968401;6034.396560343964;5460.208269800896;5539.446055394458;5576.107822748361;5609.747561359749;5641.887162256752;5553.944460555404;5612.494875461208;5621.831345059655;5627.831165065055;5640.323161220659;5445.673259604437;5481.479259470384;5500.42245564218;5506.476884695988;5564.972175139139;5507.697076660782;5555.166724991243;5555.583331250132;5558.416366281563;5568.1647752837;5494.725263736797;5497.065498865202;5523.751431185607;5531.9723401383135;5553.722313884289;5901.616394934358;5933.614315069507;5934.910976335358;5936.97031514844;5958.493528050121;6264.655443950581;6353.714082866236;6366.93633063668;6467.5472716909835;6475.255345635218;6538.901916471256;6545.574537655085;6546.279909209983;6556.93443065568;6564.376384243489;6060.636361818305;6085.604435711664;6091.908621370683;6096.695165241809;6116.449519543263;6447.838804029937;6518.837029074216;6530.2816690164045;6647.634380109043;6674;6181.721822517998;6238.407351301619;6283.371662833772;6380.936190638127;6390.5526613136635;6487.18910136233;6488.253850807123;6498.54510184292;6503.479721622259;6544.8363790905605;6369.9681501592195;6466.191726034246;6475.935240647627;6482.546221764525;6534.542582019213;6241.937580624226;6340.239171299381;6360.491160707133;6532.444742196966;6536.477081833442;5287.07476191665;5300.231466437345;5305.36335639718;5309.761060752276;5330.573554115662;4506.436695413074;4515.525869783691;4522.276435770326;4544.227481328182;4623.583877451046;5449.4005659377435;5627.915581266284;5634.436556344414;5637.210790489335;5637.3235211774845;6415.230172379344;6455.193100862392;6497.577657452251;6525.902111468332;6538;5646.774129034875;5660.745266463019;5664.150377443417;5665.263515742927;5684.289463817023;5688.288963879515;5719;5761.798337058183;5775.422457754275;5778.191053252548;6116.0010150213275;6198.535109866688;6209.875802483925;6212.161358216583;6264.718087685974;6532.183477065367;6537;6548.639824809681;6552.508561857784;6562.376574225441;6280.371962803866;6336.873262534816;6338.207724034496;6340.904886426615;6354.078658594385;6134.252905685562;6243.344448832989;6247.937520624918;6344.333844946399;6414.069959855701;6506.219253689587;6578.276389597237;6584.835379115369;6598.472122230114;6603.702833372606;6149.661768602769;6362.1729175208775;6363.459105976044;6383;6384.712687928962;6131.264248290234;6219.533534984985;6227.96886015567;6327.936720632919;6344.365563443804;6160.199174107337;6227.0970709246;6247.781327653511;6248.968755156195;6265.373462653698;6329.936700633119;6356.269029061717;6363.427291543783;6364.172657554488;6380.266269379081;6068.120122582112;6112.898653789856;6142.938570614237;6192.287886893065;6211.503079753699 03:13:08 INFO - PID 3527 | |1;ext.html;732.5201992694783;775.0931410250008;798.9001374828148;1151.7178291318628;1155.260633194756;36019;36851.447228291596;36889.26221475569;36896.26207475849;36899.26201475972;37303;37492;37589.812050939705;37665.62334376655;37697;7124.536905101152;7256.8548629027655;7268.273172682716;7319.414446844266;7423.369013633847;7220.566765994031;7360.300771426706;7361.411087113018;7366.226546212651;7384.335409813116;7341.449391295648;7349.265073492661;7349.853002939938;7400.296971787699;7410.444216683771;7286.890696639554;7320.597367144805;7340.192578816326;7358.227386124487;7407.444441666869;7078.504504684674;7131.786046418616;7183.856322873566;7221.230798454412;7230.096237970254;34347;34575;34638.65361346379;34651.4802277966;34738.30523389544;3458.7060099891287;3465.047112044183;3490.371733088043;3493.2140268439653;3515.34966031285;28034.85982570074;28126.156215313575;28150.296242593893;28222.57666134989;28226.717732822613;3567.9643203568153;3579.570451545805;3580.4092324766384;3599.8380072896784;3627.5828279747902;137272;138939;160008.19995900063;171503;172342;41665.75002749923;41668.583314167074;41949;42130.78934605369;42238.788806055774;43621.345679814825;43871.34192987108;44236.77881610571;45457.54542454599;46289.7685511577;15132.697346053017;15195.316210770541;15197.468088617066;15265;15275.38898444072;12022.519099236108;12147.939260303641;12164.5134194633;12197.390130493617;12217.877821221851;13944.58166255014;14026.85973140276;14250.358733857001;14252.358643861051;14440.85559144416;5834.154047663065;5866.472017518444;6000.249968753906;6021.337652858182;6046.697665116727;987.916027137687;998.6654470752234;1008.5814387029301;1013.5185786751234;1019.918406527476;21604.567908642053;22502.099916003503;22704.65943010856;22844.200452984067;23804.88097559536;1084.9945750271197;1090.4765712458066;1100.5212732461246;1143.9313641181388;1155.179822326141;12354.196977196454;14555;15670.138142402277;15879.2060396982;16045.759313610306;197407;198934;199938;200405;200671;53157.46842531525;53191.20213196805;53653.41545352725;53940.460595393546;54042.189367159524;1420.7158568286384;1455.89080818939;1460.218782951116;1462.7293950619169;1465.369890946903;24505;26045.479090418463;26417.471650567266;27114;27284.31789205286;46620.7668961653;46846.06307873892;47098.293525596455;47124;47160.52839471561;186265;186832;187292;188678;190094;33238.16904577405;33289.667103328655;33395.49533784927;33401.16497087592;33433;38524.229515410094;39358.803205983786;39865.202695945336;40086;40241;28827.855860720563;29883.55174672338;30056.24859378533;30466.695333046388;31148.22129446782;30761;30833.075007749805;30922.381552369276;31013.991238005343;31915.6808431922;33523.32953340871;35078.47382289319;35376.823115884254;35480;35491.645083548836;29042.419151617272;29210.41579168447;30276.5458518118;30444.086677399715;32000.5199922006;21982.560348793253;24359.75640243575;24522.04945194955;24531.754682452945;24605 03:13:08 INFO - PID 3527 | |2;jquery.html;425.2749062847845;433.1337325349301;434.74784624917544;440.5748452743103;453.15260462934316;20061.197552097918;20902.686459703098;20904.05931733074;21670;22423.663645045337;24771.256862294114;25185.622215666735;25420.11029613964;25468.36329091769;25509.744902551014;6906.8273293167695;7041.929580704204;7058.223595404502;7059.08231929851;7098.645067746618;6491.642959637218;6832.521723479358;6852.897206541906;6870.4503639708955;6926.896096558556;6850.7602233921825;6859.759908403207;6895.310468953115;6899.827029404988;6921.307869213064;6857.58854468731;6870.931290687079;6876.106106206211;6881.380675739208;6892.069570607979;6692.732290708366;6712.463002959751;6722.260551339349;6738.056672065914;6756.797296081126;27617;28346.43307133846;28356.574651380244;28605.28486787826;28877.711222887712;1945.231633504772;1980.9702854457194;1981.4055783264962;1983.0283161251027;1985.493699106733;17848.643027139384;18256.269749210016;18257.17842697082;18317.450476485727;18372.90813545937;2353.694019777435;2381.9642705359433;2419.2984034629935;2455.0670745116918;2482.2305085423577;120102;121962;124175.3791231038;129134;129808;19495.198436304785;20146.489013323768;20606.896965515076;20700.275490357766;21108.261210857545;39114.80442597769;39565.208695825924;39686.47524594077;39753;39800.800995995414;10553.683389498327;10841.891581084246;10972.177086718528;11012.229143959847;11143.387113708663;8757.912420875837;8790.736277911672;8882.600282987281;9026.684066057787;9039.909600904039;10141.645042423479;10423;10559.419231942316;10653.733656658645;10770.623028193975;3654.8538058477893;3780.5085338905765;3987.6809855211513;4028.697847661437;4276.5723427656985;905.4069584422214;935.4854829843695;937.840567103594;978.8972157923458;981.8134554434778;18613.162407691685;18755.624887502174;19317;20466;21553.56892862134;992.6079198716611;999.3454287441738;1001.2390583156707;1025.7845852371086;1050.8844027157006;10561.207909406672;10762.892371076345;11333.886661133449;11401.258918170292;11487.885121148849;466757;473886;478399;491856;496015;106110.46944765381;107267;108348;108400;109206.45396772966;1097.91765617579;1141.0985321595847;1218.4882349413267;1220.6948262934266;1281.4105511464645;19109.522261943563;19534.706979395036;20249.582529222815;20790.27234046801;20823.8958805205;48824.75587622039;48976.51023489719;49097;49566.256506151716;49973;60293.397066030535;60407;61160.38839611725;61162.38837611567;61549.69225153846;10056.19550435978;10566.577336906437;10647.627333043307;10660.62687805923;10675.412852293199;15929.840701592835;16120.516384508484;17429.302827887248;17942;17943.82056179474;14563.199024053778;14722.190279534729;14743.967922245769;14947.402103915721;15186.088834669956;11024.118070554498;11459.51026366567;12190.634280971584;12274.938625306817;12301.630951071482;12963;13319.66700832487;13325.466981321026;13506.324683765968;13510.662233444242;9552.617895284111;9658.77848094928;9661.13049825519;9663.710088697351;9666.178374838217;12301.75396492083;12599.622011339674;14719.116852988427;14791;14811.333489992761 03:13:08 INFO - PID 3527 | |3;mootools.html;1319.4854006937294;1365.8087867698518;1380.351234919588;1390.402127085353;1393.4426229508194;10838.566457341707;11287.097032237421;11345.659630211107;11347.37589432582;11591.362475063868;11423;11613;11632.243904146246;11638.068954483642;11659.708507287321;2361.25620429565;2406.89168987396;2407.38611654028;2410.6384042393606;2411.131992482705;2311.641695537186;2365.1485465232504;2371.4545654499475;2374.5844477216506;2383.976160238393;2275.6927814744963;2298.425393651587;2299.3906614747107;2301.873396963166;2317.5133222023396;2222.733272007353;2246.651768975811;2253;2267.85258958168;2273.1134857405623;2180.4112889519897;2251.4033781048033;2358.3514533503253;2359.539889721505;2365.929022129339;11208.047315978152;11288.153388495895;11338;11345.659630211107;11375.658730238107;6137.41694539018;6378.840528986766;6384.074309225136;6384.3934826191435;6391.936080639181;3596.9280614387567;3670.944935825965;3702.222533268017;3720.5907350191455;3793.1844653399376;1229.846269216348;1270.2695949828792;1277.2783377391836;1303.1855090568395;1305.849827269857;16071;16180.676386472205;16189.838101619069;16257.105859177622;16270.674586508321;5108.897822043613;5225.085610018232;5247.921281180786;5332.653377530448;5396.1905714143195;12022.098342624338;12086.697832554257;12102.455389507493;12102.636920892388;12134.878651213552;6170.228721409824;6248.094026366151;6259.906101408483;6293.339199383999;6296.212973378328;5708.857278567986;5781.1328300754385;5826.271716035496;5839.328477225174;5893.675847828411;4155.340770740664;4206.558311377323;4217.873463796091;4258.467691538558;4297.763623000765;1233.073869889796;1266.9429875655617;1274.898008159345;1282.7178020835402;1286.9806952895715;844.4215712237137;866.4065115395848;882.9117088291248;890.7639475538988;908.6274627402734;6507.967460162764;6703.798886033427;6886.793396198122;7046.401055910305;7383.335499804936;549.9780008799684;565.6125553995527;572.3303734630492;578.254052272572;580.5964854426218;4417.116576684676;4448.466184057934;4636.9536304637195;5264.447233040476;5278.155495120763;14383.496577619733;14735.705285894437;14838.109713417229;14873;14881.553553393416;14100.506482273071;14485.710285794225;14617.488387906373;14647.12117272967;14678.926605367118;8963.641454341883;9130.406523575946;9150.63397464094;9157.175854173156;9170.358074934824;6726.932730672826;6861.348171923859;7029.859402812018;7391.1869694334655;7485.737999170003;12701.682457938625;12788.616341509769;12874.16317939331;12875.613731587693;12959.352032398154;13056.543020994219;13148.671283217613;13204.867951320364;13223.867761322264;13355.065145439727;9461.668841590512;9659.323847330901;9733.561989710339;9761.365511241747;9766.218702503924;10578.153747700011;10613.618427909787;10635.840462392916;10704.197185211297;10733.570657173626;8919.152680495343;9062.818743625223;9094.090590940854;9117.589708463003;9225;8852.247558957302;8904.910950890408;8928.776780580538;8991.82016359656;9017.188453038996;7915.406344524068;7969.123396426505;8250.422470427013;8263.876041859497;8287.046989596274;6011.398860113954;6153.692315384303;6246.593971391845;6258.874822503433;6473.643949582818;6276.874462510633;6308.243010838729;6519.3480651936325;6590.637514936724;6742.9662851685425 03:13:08 INFO - PID 3527 | |4;prototype.html;395.16028439565923;398.86438610872295;400.591396775289;401.5763369645025;404.47014411121427;6093.268807743066;6187.752489900404;6206.348333424993;6208.627482351062;6249.468795152417;5978.133170690247;6090.294717479102;6098.817035488932;6105.511559075275;6106.725197366118;4653.953460465403;4783.760811959397;4790.736509491977;4795.568398844103;4810.931299541196;4791.784369703371;4810.759462026885;4811.831585894494;4821.566059054684;4834.540718631724;4713.363695901044;4727.05458908218;4748.240281554952;4748.620110391161;4773;4720.90558188836;4762.618990480771;4763.45220299663;4775.164346239394;4777.331173635694;4150.605692459211;4163.521195062546;4164.354525048622;4178;4180.9338618652355;6102.7864024759365;6105.114758360058;6110.816675499742;6118.112873633343;6121.816345509642;5417.918731219035;5446.623093681903;5447;5447.509724124848;5453.890922181534;6440.8406486832355;6542.476601871839;6545.116409284733;6546.541742078057;6571.112899758519;4502.41468609082;4509.458864936196;4520.254158063915;4531.637469002472;4536.432945881765;6493.9675301623665;6852.349026842442;6854.6229957352325;6857.559912418398;6933.445324374038;4482.327650852399;4553.112143132057;4563.817447302137;4589.35748995141;4590.793414296365;4599.241125214369;4603.424571928509;4620.653450991189;4625.259958406638;4659.1147681941;5204.245384419238;5341.545968592635;5378.1663842104535;5389.434109418533;5394.244805727201;6448.355164483608;6500.382463665944;6501;6542.6401547914365;6563.868722625521;1613.5966008497876;1620.3194658243567;1620.9756853647204;1624;1636.2227941727583;1045.3780000899453;1064.8446435617286;1073.1736562846565;1085.5520800594609;1086.1148164246115;5702.51528620072;5710;5734.394369576526;5735.684537350402;5758.712064396764;6646.83382915431;6696.86606267872;6717.932820671731;6727.77983265531;6730.495212859055;5679.608495918526;5692.060809966392;5706.115552089433;5716.885662286814;5727.513161381329;3578.731595130376;3583.283343331344;3589.2821435712963;3597.892063238107;3608.440691692792;6525.575837570543;6556.27880933097;6565.835854103686;6570.277269500351;6574.717930003603;6832.419244364285;6850.6574671267235;6854.074699915447;6902;6933.826654333682;6452.774152904626;6490.8052758417325;6503.28463868974;6532.150820393414;6549.738010479623;6721.1598550181225;6740.730370785113;6756.729730810909;6766.255711871789;6779.661016949231;6680.3987641112535;6697.497687673346;6733.124693789972;6740.258571557223;6748.325167483213;6093.177421048279;6507.837304067436;6519.054737063005;6525.934740652533;6541.215054193527;4621.168189725881;4632.9305060424795;4637.443506779208;4643.767811609338;4647.3029045643425;6517.641529715911;6685.665716714047;6694.765683201259;6708.262091170065;6734.6295953721055;6470;6505.772297969548;6509.7396104155305;6534.509911756732;6559.114519539801;6460.709268082854;6482.643454610042;6524.217093948757;6525.662239240849;6533.67331633426;6314.273858506147;6401.55189136756;6411.903821442589;6420.582662126947;6478.902816457851;6508.739650413931;6540.50946179029;6564.934350656432;6568.47452203813;6590.5716128451495;6338.429541341301;6346.4605508532295;6354.856125897383;6357.268914074941;6393.520485963479 03:13:08 INFO - PID 3527 | |5;yui.html;838.4256784102886;860.4192170285056;864.9005364383096;866.6013633728485;885.6634478898018;14637.780433293483;14893;16659.83340166598;17077.743833842487;17132;16159.192040397991;16278.186090695477;16295.755563666526;16357.345706171738;16493.618808144332;967.5017366056486;971.1745016735789;977.1938151025397;977.3744803325877;978.2369751593733;661.5832025823725;943.32552225159;966.4394651102343;972.3631021680775;975.8633791269228;1021.5505177721778;1031.4017869635632;1033.519413472735;1035.321864178964;1037.8131936251473;1023.2581378500565;1023.948802559869;1027.2090490322485;1030.5414090729628;1032.4012072997643;755.9848803023964;756.2097607999654;757.9052618422697;757.9658915348823;759.7758661194961;15555.144467054308;16302.103384313858;16758;16890.408835690814;16939.407120750715;18601;18888;18967.24131034757;18980.335688250983;19038;14496.565103046925;14694.55916322512;14744.926275368554;14824.777628335476;14842.996195513575;3345.3142105868483;3355.1947532592244;3369.578802649669;3387.7459190560808;3398.796072235674;88508.48169214076;88665.55667221687;89249.55375223083;89305;89575;12593.685157870943;12783;12791.424385902657;12926.547570834975;12954.157979731288;21411.35765927025;21592.56814863694;21815.127394904026;22038.88980555119;22041.559168816533;7762.922370776333;7859.921400785919;7890.053193616803;7905.209479052049;7938.761837144895;3420.675035871588;3656.780593164419;3800.771953682788;3890.8054597270025;3896.785676787804;4029.6977726670616;4161.0845613964875;4173.916521669549;4174.519930208005;4180.268453020709;806.4314658165979;846.7459762071354;851.476342049635;855.7988872614931;855.9614817333235;633.9429451349308;649.5810202419412;653.7417720000573;658.2561705273107;680.3196803196803;10910.290831096112;11160.553577856957;11662.76674466506;12483.188592741442;12487.50049998008;641.8363317354044;646.6281887914467;659.5679829711546;677.2786981864299;680.1803826389189;5108.744562771846;5306.6550674206055;5524.116141417434;5592.384837667853;5610.5231055360755;82251.17748822435;83285.58357208176;83621;85461;95833;70857.64571177111;71612.28387716161;71964;72006;72950.63524682343;63197.368026320066;63360;64936.675316623114;64988.67505662536;67394;11245.662630121109;12325.568605098779;12354.444050017592;12445.62663120108;12501.812472813097;29653.40693186081;29711.65190265773;29794.255143621584;30631.54052689167;30868.53697194499;36558.63441365552;36836.81581592182;37288;37821;37909.43135853019;16102.919485402497;16285.348586056425;16711.498655040366;16736.832631673526;16899.493015209562;18087.547811304823;18434.446966591022;18694.34569790051;18938.0530973448;19213.03934803282;16983;17599.472015839547;17843.643127137126;18154.81845181584;18261.269549217883;17066.402675906284;17469.563260918578;17562.912185438992;17845.643087138444;18077.819221807615;17292.740608891127;17405.738913916048;17443.215055322795;17506.037167955885;17879.821201788334;10845.891541084487;11024.219065162704;11296.265742726697;11831.11266654987;12188;12805.615831525069;12984.610461686165;13557.84888658;13957.860421396063;14042.859571404155 03:13:08 INFO - PID 3527 | __end_tp_report 03:13:08 INFO - PID 3527 | __start_cc_report 03:13:08 INFO - PID 3527 | _x_x_mozilla_cycle_collect,379 03:13:08 INFO - PID 3527 | __end_cc_report 03:13:08 INFO - PID 3527 | __startTimestamp1496657588582__endTimestamp 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | ------- Summary: start ------- 03:13:08 INFO - PID 3527 | Number of tests: 6 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#0] dojo.html Cycles:165 Average:5959.11 Median:6160.20 stddev:679.46 (11.0%) stddev-sans-first:643.31 03:13:08 INFO - PID 3527 | Values: 3094.3 3117.9 3152.5 3166.9 3177.3 5902.1 6003.1 6015.9 6019.9 6022.6 5911.0 5993.1 6012.9 6034.1 6034.4 5460.2 5539.4 5576.1 5609.7 5641.9 5553.9 5612.5 5621.8 5627.8 5640.3 5445.7 5481.5 5500.4 5506.5 5565.0 5507.7 5555.2 5555.6 5558.4 5568.2 5494.7 5497.1 5523.8 5532.0 5553.7 5901.6 5933.6 5934.9 5937.0 5958.5 6264.7 6353.7 6366.9 6467.5 6475.3 6538.9 6545.6 6546.3 6556.9 6564.4 6060.6 6085.6 6091.9 6096.7 6116.4 6447.8 6518.8 6530.3 6647.6 6674.0 6181.7 6238.4 6283.4 6380.9 6390.6 6487.2 6488.3 6498.5 6503.5 6544.8 6370.0 6466.2 6475.9 6482.5 6534.5 6241.9 6340.2 6360.5 6532.4 6536.5 5287.1 5300.2 5305.4 5309.8 5330.6 4506.4 4515.5 4522.3 4544.2 4623.6 5449.4 5627.9 5634.4 5637.2 5637.3 6415.2 6455.2 6497.6 6525.9 6538.0 5646.8 5660.7 5664.2 5665.3 5684.3 5688.3 5719.0 5761.8 5775.4 5778.2 6116.0 6198.5 6209.9 6212.2 6264.7 6532.2 6537.0 6548.6 6552.5 6562.4 6280.4 6336.9 6338.2 6340.9 6354.1 6134.3 6243.3 6247.9 6344.3 6414.1 6506.2 6578.3 6584.8 6598.5 6603.7 6149.7 6362.2 6363.5 6383.0 6384.7 6131.3 6219.5 6228.0 6327.9 6344.4 6160.2 6227.1 6247.8 6249.0 6265.4 6329.9 6356.3 6363.4 6364.2 6380.3 6068.1 6112.9 6142.9 6192.3 6211.5 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#1] ext.html Cycles:180 Average:34729.62 Median:33935.16 stddev:47100.07 (138.8%) stddev-sans-first:47163.02 03:13:08 INFO - PID 3527 | Values: 732.5 775.1 798.9 1151.7 1155.3 36019.0 36851.4 36889.3 36896.3 36899.3 37303.0 37492.0 37589.8 37665.6 37697.0 7124.5 7256.9 7268.3 7319.4 7423.4 7220.6 7360.3 7361.4 7366.2 7384.3 7341.4 7349.3 7349.9 7400.3 7410.4 7286.9 7320.6 7340.2 7358.2 7407.4 7078.5 7131.8 7183.9 7221.2 7230.1 34347.0 34575.0 34638.7 34651.5 34738.3 3458.7 3465.0 3490.4 3493.2 3515.3 28034.9 28126.2 28150.3 28222.6 28226.7 3568.0 3579.6 3580.4 3599.8 3627.6 137272.0 138939.0 160008.2 171503.0 172342.0 41665.8 41668.6 41949.0 42130.8 42238.8 43621.3 43871.3 44236.8 45457.5 46289.8 15132.7 15195.3 15197.5 15265.0 15275.4 12022.5 12147.9 12164.5 12197.4 12217.9 13944.6 14026.9 14250.4 14252.4 14440.9 5834.2 5866.5 6000.2 6021.3 6046.7 987.9 998.7 1008.6 1013.5 1019.9 21604.6 22502.1 22704.7 22844.2 23804.9 1085.0 1090.5 1100.5 1143.9 1155.2 12354.2 14555.0 15670.1 15879.2 16045.8 197407.0 198934.0 199938.0 200405.0 200671.0 53157.5 53191.2 53653.4 53940.5 54042.2 1420.7 1455.9 1460.2 1462.7 1465.4 24505.0 26045.5 26417.5 27114.0 27284.3 46620.8 46846.1 47098.3 47124.0 47160.5 186265.0 186832.0 187292.0 188678.0 190094.0 33238.2 33289.7 33395.5 33401.2 33433.0 38524.2 39358.8 39865.2 40086.0 40241.0 28827.9 29883.6 30056.2 30466.7 31148.2 30761.0 30833.1 30922.4 31014.0 31915.7 33523.3 35078.5 35376.8 35480.0 35491.6 29042.4 29210.4 30276.5 30444.1 32000.5 21982.6 24359.8 24522.0 24531.8 24605.0 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#2] jquery.html Cycles:180 Average:33225.40 Median:21611.78 stddev:80581.31 (372.9%) stddev-sans-first:80769.73 03:13:08 INFO - PID 3527 | Values: 425.3 433.1 434.7 440.6 453.2 20061.2 20902.7 20904.1 21670.0 22423.7 24771.3 25185.6 25420.1 25468.4 25509.7 6906.8 7041.9 7058.2 7059.1 7098.6 6491.6 6832.5 6852.9 6870.5 6926.9 6850.8 6859.8 6895.3 6899.8 6921.3 6857.6 6870.9 6876.1 6881.4 6892.1 6692.7 6712.5 6722.3 6738.1 6756.8 27617.0 28346.4 28356.6 28605.3 28877.7 1945.2 1981.0 1981.4 1983.0 1985.5 17848.6 18256.3 18257.2 18317.5 18372.9 2353.7 2382.0 2419.3 2455.1 2482.2 120102.0 121962.0 124175.4 129134.0 129808.0 19495.2 20146.5 20606.9 20700.3 21108.3 39114.8 39565.2 39686.5 39753.0 39800.8 10553.7 10841.9 10972.2 11012.2 11143.4 8757.9 8790.7 8882.6 9026.7 9039.9 10141.6 10423.0 10559.4 10653.7 10770.6 3654.9 3780.5 3987.7 4028.7 4276.6 905.4 935.5 937.8 978.9 981.8 18613.2 18755.6 19317.0 20466.0 21553.6 992.6 999.3 1001.2 1025.8 1050.9 10561.2 10762.9 11333.9 11401.3 11487.9 466757.0 473886.0 478399.0 491856.0 496015.0 106110.5 107267.0 108348.0 108400.0 109206.5 1097.9 1141.1 1218.5 1220.7 1281.4 19109.5 19534.7 20249.6 20790.3 20823.9 48824.8 48976.5 49097.0 49566.3 49973.0 60293.4 60407.0 61160.4 61162.4 61549.7 10056.2 10566.6 10647.6 10660.6 10675.4 15929.8 16120.5 17429.3 17942.0 17943.8 14563.2 14722.2 14744.0 14947.4 15186.1 11024.1 11459.5 12190.6 12274.9 12301.6 12963.0 13319.7 13325.5 13506.3 13510.7 9552.6 9658.8 9661.1 9663.7 9666.2 12301.8 12599.6 14719.1 14791.0 14811.3 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#3] mootools.html Cycles:180 Average:7040.39 Median:3633.94 stddev:4445.31 (122.3%) stddev-sans-first:4436.99 03:13:08 INFO - PID 3527 | Values: 1319.5 1365.8 1380.4 1390.4 1393.4 10838.6 11287.1 11345.7 11347.4 11591.4 11423.0 11613.0 11632.2 11638.1 11659.7 2361.3 2406.9 2407.4 2410.6 2411.1 2311.6 2365.1 2371.5 2374.6 2384.0 2275.7 2298.4 2299.4 2301.9 2317.5 2222.7 2246.7 2253.0 2267.9 2273.1 2180.4 2251.4 2358.4 2359.5 2365.9 11208.0 11288.2 11338.0 11345.7 11375.7 6137.4 6378.8 6384.1 6384.4 6391.9 3596.9 3670.9 3702.2 3720.6 3793.2 1229.8 1270.3 1277.3 1303.2 1305.8 16071.0 16180.7 16189.8 16257.1 16270.7 5108.9 5225.1 5247.9 5332.7 5396.2 12022.1 12086.7 12102.5 12102.6 12134.9 6170.2 6248.1 6259.9 6293.3 6296.2 5708.9 5781.1 5826.3 5839.3 5893.7 4155.3 4206.6 4217.9 4258.5 4297.8 1233.1 1266.9 1274.9 1282.7 1287.0 844.4 866.4 882.9 890.8 908.6 6508.0 6703.8 6886.8 7046.4 7383.3 550.0 565.6 572.3 578.3 580.6 4417.1 4448.5 4637.0 5264.4 5278.2 14383.5 14735.7 14838.1 14873.0 14881.6 14100.5 14485.7 14617.5 14647.1 14678.9 8963.6 9130.4 9150.6 9157.2 9170.4 6726.9 6861.3 7029.9 7391.2 7485.7 12701.7 12788.6 12874.2 12875.6 12959.4 13056.5 13148.7 13204.9 13223.9 13355.1 9461.7 9659.3 9733.6 9761.4 9766.2 10578.2 10613.6 10635.8 10704.2 10733.6 8919.2 9062.8 9094.1 9117.6 9225.0 8852.2 8904.9 8928.8 8991.8 9017.2 7915.4 7969.1 8250.4 8263.9 8287.0 6011.4 6153.7 6246.6 6258.9 6473.6 6276.9 6308.2 6519.3 6590.6 6743.0 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#4] prototype.html Cycles:180 Average:5396.20 Median:6103.95 stddev:1601.60 (26.2%) stddev-sans-first:1561.48 03:13:08 INFO - PID 3527 | Values: 395.2 398.9 400.6 401.6 404.5 6093.3 6187.8 6206.3 6208.6 6249.5 5978.1 6090.3 6098.8 6105.5 6106.7 4654.0 4783.8 4790.7 4795.6 4810.9 4791.8 4810.8 4811.8 4821.6 4834.5 4713.4 4727.1 4748.2 4748.6 4773.0 4720.9 4762.6 4763.5 4775.2 4777.3 4150.6 4163.5 4164.4 4178.0 4180.9 6102.8 6105.1 6110.8 6118.1 6121.8 5417.9 5446.6 5447.0 5447.5 5453.9 6440.8 6542.5 6545.1 6546.5 6571.1 4502.4 4509.5 4520.3 4531.6 4536.4 6494.0 6852.3 6854.6 6857.6 6933.4 4482.3 4553.1 4563.8 4589.4 4590.8 4599.2 4603.4 4620.7 4625.3 4659.1 5204.2 5341.5 5378.2 5389.4 5394.2 6448.4 6500.4 6501.0 6542.6 6563.9 1613.6 1620.3 1621.0 1624.0 1636.2 1045.4 1064.8 1073.2 1085.6 1086.1 5702.5 5710.0 5734.4 5735.7 5758.7 6646.8 6696.9 6717.9 6727.8 6730.5 5679.6 5692.1 5706.1 5716.9 5727.5 3578.7 3583.3 3589.3 3597.9 3608.4 6525.6 6556.3 6565.8 6570.3 6574.7 6832.4 6850.7 6854.1 6902.0 6933.8 6452.8 6490.8 6503.3 6532.2 6549.7 6721.2 6740.7 6756.7 6766.3 6779.7 6680.4 6697.5 6733.1 6740.3 6748.3 6093.2 6507.8 6519.1 6525.9 6541.2 4621.2 4632.9 4637.4 4643.8 4647.3 6517.6 6685.7 6694.8 6708.3 6734.6 6470.0 6505.8 6509.7 6534.5 6559.1 6460.7 6482.6 6524.2 6525.7 6533.7 6314.3 6401.6 6411.9 6420.6 6478.9 6508.7 6540.5 6564.9 6568.5 6590.6 6338.4 6346.5 6354.9 6357.3 6393.5 03:13:08 INFO - PID 3527 | 03:13:08 INFO - PID 3527 | [#5] yui.html Cycles:180 Average:18486.06 Median:29682.53 stddev:23058.89 (77.7%) stddev-sans-first:23085.50 03:13:08 INFO - PID 3527 | Values: 838.4 860.4 864.9 866.6 885.7 14637.8 14893.0 16659.8 17077.7 17132.0 16159.2 16278.2 16295.8 16357.3 16493.6 967.5 971.2 977.2 977.4 978.2 661.6 943.3 966.4 972.4 975.9 1021.6 1031.4 1033.5 1035.3 1037.8 1023.3 1023.9 1027.2 1030.5 1032.4 756.0 756.2 757.9 758.0 759.8 15555.1 16302.1 16758.0 16890.4 16939.4 18601.0 18888.0 18967.2 18980.3 19038.0 14496.6 14694.6 14744.9 14824.8 14843.0 3345.3 3355.2 3369.6 3387.7 3398.8 88508.5 88665.6 89249.6 89305.0 89575.0 12593.7 12783.0 12791.4 12926.5 12954.2 21411.4 21592.6 21815.1 22038.9 22041.6 7762.9 7859.9 7890.1 7905.2 7938.8 3420.7 3656.8 3800.8 3890.8 3896.8 4029.7 4161.1 4173.9 4174.5 4180.3 806.4 846.7 851.5 855.8 856.0 633.9 649.6 653.7 658.3 680.3 10910.3 11160.6 11662.8 12483.2 12487.5 641.8 646.6 659.6 677.3 680.2 5108.7 5306.7 5524.1 5592.4 5610.5 82251.2 83285.6 83621.0 85461.0 95833.0 70857.6 71612.3 71964.0 72006.0 72950.6 63197.4 63360.0 64936.7 64988.7 67394.0 11245.7 12325.6 12354.4 12445.6 12501.8 29653.4 29711.7 29794.3 30631.5 30868.5 36558.6 36836.8 37288.0 37821.0 37909.4 16102.9 16285.3 16711.5 16736.8 16899.5 18087.5 18434.4 18694.3 18938.1 19213.0 16983.0 17599.5 17843.6 18154.8 18261.3 17066.4 17469.6 17562.9 17845.6 18077.8 17292.7 17405.7 17443.2 17506.0 17879.8 10845.9 11024.2 11296.3 11831.1 12188.0 12805.6 12984.6 13557.8 13957.9 14042.9 03:13:08 INFO - PID 3527 | -------- Summary: end -------- 03:13:08 INFO - PID 3527 | 03:13:09 INFO - TEST-INFO | 3527: exit 0 03:13:09 INFO - TEST-OK | dromaeo_css | took 1145041ms 03:13:09 INFO - TEST-START | kraken 03:13:09 INFO - operating with platform_type : linux_ 03:13:09 INFO - Initialising browser for kraken test... 03:13:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56485/getInfo.html -profile /tmp/tmpzMCFPm/profile 03:13:09 INFO - TEST-INFO | started process 3970 (/builds/slave/test/build/application/firefox/firefox http://localhost:56485/getInfo.html) 03:13:44 INFO - TEST-INFO | 3970: killed by SIGTERM 03:13:44 INFO - Browser initialized. 03:13:44 INFO - Running cycle 1/1 for kraken test... 03:13:44 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzMCFPm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:56 INFO - PID 4178 | RSS: Main: 187506688 03:13:56 INFO - PID 4178 | 03:13:59 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56485/tests/kraken/driver.html?testName=audio-beat-detection) 03:14:00 INFO - PID 4178 | RSS: Main: 191848448 03:14:00 INFO - PID 4178 | 03:14:02 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56485/tests/kraken/driver.html?testName=audio-dft) 03:14:03 INFO - PID 4178 | RSS: Main: 190439424 03:14:03 INFO - PID 4178 | 03:14:06 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56485/tests/kraken/driver.html?testName=audio-fft) 03:14:06 INFO - PID 4178 | RSS: Main: 185806848 03:14:06 INFO - PID 4178 | 03:14:08 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56485/tests/kraken/driver.html?testName=audio-oscillator) 03:14:09 INFO - PID 4178 | RSS: Main: 186720256 03:14:09 INFO - PID 4178 | 03:14:11 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56485/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:14:12 INFO - PID 4178 | RSS: Main: 186306560 03:14:12 INFO - PID 4178 | 03:14:15 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56485/tests/kraken/driver.html?testName=imaging-darkroom) 03:14:16 INFO - PID 4178 | RSS: Main: 187330560 03:14:16 INFO - PID 4178 | 03:14:19 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56485/tests/kraken/driver.html?testName=imaging-desaturate) 03:14:20 INFO - PID 4178 | RSS: Main: 187031552 03:14:20 INFO - PID 4178 | 03:14:22 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56485/tests/kraken/driver.html?testName=json-parse-financial) 03:14:23 INFO - PID 4178 | RSS: Main: 187904000 03:14:23 INFO - PID 4178 | 03:14:25 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56485/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:14:25 INFO - PID 4178 | RSS: Main: 188604416 03:14:25 INFO - PID 4178 | 03:14:27 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:14:28 INFO - PID 4178 | RSS: Main: 187977728 03:14:28 INFO - PID 4178 | 03:14:30 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:14:31 INFO - PID 4178 | RSS: Main: 188059648 03:14:31 INFO - PID 4178 | 03:14:33 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:14:34 INFO - PID 4178 | RSS: Main: 187269120 03:14:34 INFO - PID 4178 | 03:14:37 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:14:38 INFO - PID 4178 | RSS: Main: 187973632 03:14:38 INFO - PID 4178 | 03:14:39 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:56485/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56485/tests/kraken/driver.html?testName=ai-astar) 03:14:40 INFO - PID 4178 | RSS: Main: 189153280 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | __start_tp_report 03:14:40 INFO - PID 4178 | _x_x_mozilla_page_load 03:14:40 INFO - PID 4178 | _x_x_mozilla_page_load_details 03:14:40 INFO - PID 4178 | |i|pagename|runs| 03:14:40 INFO - PID 4178 | |0;ai-astar;103;110;111;112;109;112;111;111;111;111 03:14:40 INFO - PID 4178 | |1;audio-beat-detection;153;122;126;166;129;128;124;127;154;127 03:14:40 INFO - PID 4178 | |2;audio-dft;164;165;163;164;164;169;167;167;173;164 03:14:40 INFO - PID 4178 | |3;audio-fft;74;74;73;123;78;73;74;75;93;74 03:14:40 INFO - PID 4178 | |4;audio-oscillator;83;84;114;83;84;85;101;84;86;105 03:14:40 INFO - PID 4178 | |5;imaging-gaussian-blur;114;115;115;114;114;115;114;114;113;117 03:14:40 INFO - PID 4178 | |6;imaging-darkroom;151;151;150;150;151;150;152;150;151;151 03:14:40 INFO - PID 4178 | |7;imaging-desaturate;94;95;94;95;94;95;94;95;94;94 03:14:40 INFO - PID 4178 | |8;json-parse-financial;54;55;57;56;55;55;55;55;56;59 03:14:40 INFO - PID 4178 | |9;json-stringify-tinderbox;56;56;56;56;55;55;55;54;55;58 03:14:40 INFO - PID 4178 | |10;stanford-crypto-aes;91;87;87;88;91;87;89;91;111;89 03:14:40 INFO - PID 4178 | |11;stanford-crypto-ccm;132;134;131;131;137;139;142;129;146;130 03:14:40 INFO - PID 4178 | |12;stanford-crypto-pbkdf2;190;207;195;197;194;195;191;190;189;197 03:14:40 INFO - PID 4178 | |13;stanford-crypto-sha256-iterative;72;75;71;72;76;77;72;74;75;72 03:14:40 INFO - PID 4178 | __end_tp_report 03:14:40 INFO - PID 4178 | __start_cc_report 03:14:40 INFO - PID 4178 | _x_x_mozilla_cycle_collect,975 03:14:40 INFO - PID 4178 | __end_cc_report 03:14:40 INFO - PID 4178 | __startTimestamp1496657680161__endTimestamp 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | ------- Summary: start ------- 03:14:40 INFO - PID 4178 | Number of tests: 14 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 03:14:40 INFO - PID 4178 | Values: 103.0 110.0 111.0 112.0 109.0 112.0 111.0 111.0 111.0 111.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:128.50 stddev:15.73 (12.2%) stddev-sans-first:15.37 03:14:40 INFO - PID 4178 | Values: 153.0 122.0 126.0 166.0 129.0 128.0 124.0 127.0 154.0 127.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#2] audio-dft Cycles:10 Average:166.00 Median:166.00 stddev:3.09 (1.9%) stddev-sans-first:3.19 03:14:40 INFO - PID 4178 | Values: 164.0 165.0 163.0 164.0 164.0 169.0 167.0 167.0 173.0 164.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.00 stddev:15.91 (21.5%) stddev-sans-first:16.66 03:14:40 INFO - PID 4178 | Values: 74.0 74.0 73.0 123.0 78.0 73.0 74.0 75.0 93.0 74.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:11.36 (13.5%) stddev-sans-first:11.68 03:14:40 INFO - PID 4178 | Values: 83.0 84.0 114.0 83.0 84.0 85.0 101.0 84.0 86.0 105.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.08 (0.9%) stddev-sans-first:1.13 03:14:40 INFO - PID 4178 | Values: 114.0 115.0 115.0 114.0 114.0 115.0 114.0 114.0 113.0 117.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 03:14:40 INFO - PID 4178 | Values: 151.0 151.0 150.0 150.0 151.0 150.0 152.0 150.0 151.0 151.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 03:14:40 INFO - PID 4178 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:1.42 (2.6%) stddev-sans-first:1.36 03:14:40 INFO - PID 4178 | Values: 54.0 55.0 57.0 56.0 55.0 55.0 55.0 55.0 56.0 59.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:1.07 (1.9%) stddev-sans-first:1.13 03:14:40 INFO - PID 4178 | Values: 56.0 56.0 56.0 56.0 55.0 55.0 55.0 54.0 55.0 58.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:89.00 stddev:7.19 (8.1%) stddev-sans-first:7.62 03:14:40 INFO - PID 4178 | Values: 91.0 87.0 87.0 88.0 91.0 87.0 89.0 91.0 111.0 89.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:135.50 stddev:5.70 (4.2%) stddev-sans-first:5.94 03:14:40 INFO - PID 4178 | Values: 132.0 134.0 131.0 131.0 137.0 139.0 142.0 129.0 146.0 130.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:195.00 stddev:5.30 (2.7%) stddev-sans-first:5.36 03:14:40 INFO - PID 4178 | Values: 190.0 207.0 195.0 197.0 194.0 195.0 191.0 190.0 189.0 197.0 03:14:40 INFO - PID 4178 | 03:14:40 INFO - PID 4178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.50 stddev:2.07 (2.8%) stddev-sans-first:2.11 03:14:40 INFO - PID 4178 | Values: 72.0 75.0 71.0 72.0 76.0 77.0 72.0 74.0 75.0 72.0 03:14:40 INFO - PID 4178 | -------- Summary: end -------- 03:14:40 INFO - PID 4178 | 03:14:41 INFO - TEST-INFO | 4178: exit 0 03:14:41 INFO - TEST-OK | kraken | took 91941ms 03:14:41 INFO - SUITE-END | took 1236s 03:14:41 INFO - Completed test suite (00:20:37) 03:14:41 INFO - javascript benchmark 03:14:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7820.688278134145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.3192497650507, 3117.859696313666, 3152.4956007038877, 3166.857491412885, 3177.2692280775423, 5902.144189092579, 6003.069524223742, 6015.939840601593, 6019.879602407955, 6022.578419510636, 5911.0, 5993.0710739835395, 6012.909806352908, 6034.064719968401, 6034.396560343964, 5460.208269800896, 5539.446055394458, 5576.107822748361, 5609.747561359749, 5641.887162256752, 5553.944460555404, 5612.494875461208, 5621.831345059655, 5627.831165065055, 5640.323161220659, 5445.673259604437, 5481.479259470384, 5500.42245564218, 5506.476884695988, 5564.972175139139, 5507.697076660782, 5555.166724991243, 5555.583331250132, 5558.416366281563, 5568.1647752837, 5494.725263736797, 5497.065498865202, 5523.751431185607, 5531.9723401383135, 5553.722313884289, 5901.616394934358, 5933.614315069507, 5934.910976335358, 5936.97031514844, 5958.493528050121, 6264.655443950581, 6353.714082866236, 6366.93633063668, 6467.5472716909835, 6475.255345635218, 6538.901916471256, 6545.574537655085, 6546.279909209983, 6556.93443065568, 6564.376384243489, 6060.636361818305, 6085.604435711664, 6091.908621370683, 6096.695165241809, 6116.449519543263, 6447.838804029937, 6518.837029074216, 6530.2816690164045, 6647.634380109043, 6674.0, 6181.721822517998, 6238.407351301619, 6283.371662833772, 6380.936190638127, 6390.5526613136635, 6487.18910136233, 6488.253850807123, 6498.54510184292, 6503.479721622259, 6544.8363790905605, 6369.9681501592195, 6466.191726034246, 6475.935240647627, 6482.546221764525, 6534.542582019213, 6241.937580624226, 6340.239171299381, 6360.491160707133, 6532.444742196966, 6536.477081833442, 5287.07476191665, 5300.231466437345, 5305.36335639718, 5309.761060752276, 5330.573554115662, 4506.436695413074, 4515.525869783691, 4522.276435770326, 4544.227481328182, 4623.583877451046, 5449.4005659377435, 5627.915581266284, 5634.436556344414, 5637.210790489335, 5637.3235211774845, 6415.230172379344, 6455.193100862392, 6497.577657452251, 6525.902111468332, 6538.0, 5646.774129034875, 5660.745266463019, 5664.150377443417, 5665.263515742927, 5684.289463817023, 5688.288963879515, 5719.0, 5761.798337058183, 5775.422457754275, 5778.191053252548, 6116.0010150213275, 6198.535109866688, 6209.875802483925, 6212.161358216583, 6264.718087685974, 6532.183477065367, 6537.0, 6548.639824809681, 6552.508561857784, 6562.376574225441, 6280.371962803866, 6336.873262534816, 6338.207724034496, 6340.904886426615, 6354.078658594385, 6134.252905685562, 6243.344448832989, 6247.937520624918, 6344.333844946399, 6414.069959855701, 6506.219253689587, 6578.276389597237, 6584.835379115369, 6598.472122230114, 6603.702833372606, 6149.661768602769, 6362.1729175208775, 6363.459105976044, 6383.0, 6384.712687928962, 6131.264248290234, 6219.533534984985, 6227.96886015567, 6327.936720632919, 6344.365563443804, 6160.199174107337, 6227.0970709246, 6247.781327653511, 6248.968755156195, 6265.373462653698, 6329.936700633119, 6356.269029061717, 6363.427291543783, 6364.172657554488, 6380.266269379081, 6068.120122582112, 6112.898653789856, 6142.938570614237, 6192.287886893065, 6211.503079753699], "value": 5910.283959346238, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.5201992694783, 775.0931410250008, 798.9001374828148, 1151.7178291318628, 1155.260633194756, 36019.0, 36851.447228291596, 36889.26221475569, 36896.26207475849, 36899.26201475972, 37303.0, 37492.0, 37589.812050939705, 37665.62334376655, 37697.0, 7124.536905101152, 7256.8548629027655, 7268.273172682716, 7319.414446844266, 7423.369013633847, 7220.566765994031, 7360.300771426706, 7361.411087113018, 7366.226546212651, 7384.335409813116, 7341.449391295648, 7349.265073492661, 7349.853002939938, 7400.296971787699, 7410.444216683771, 7286.890696639554, 7320.597367144805, 7340.192578816326, 7358.227386124487, 7407.444441666869, 7078.504504684674, 7131.786046418616, 7183.856322873566, 7221.230798454412, 7230.096237970254, 34347.0, 34575.0, 34638.65361346379, 34651.4802277966, 34738.30523389544, 3458.7060099891287, 3465.047112044183, 3490.371733088043, 3493.2140268439653, 3515.34966031285, 28034.85982570074, 28126.156215313575, 28150.296242593893, 28222.57666134989, 28226.717732822613, 3567.9643203568153, 3579.570451545805, 3580.4092324766384, 3599.8380072896784, 3627.5828279747902, 137272.0, 138939.0, 160008.19995900063, 171503.0, 172342.0, 41665.75002749923, 41668.583314167074, 41949.0, 42130.78934605369, 42238.788806055774, 43621.345679814825, 43871.34192987108, 44236.77881610571, 45457.54542454599, 46289.7685511577, 15132.697346053017, 15195.316210770541, 15197.468088617066, 15265.0, 15275.38898444072, 12022.519099236108, 12147.939260303641, 12164.5134194633, 12197.390130493617, 12217.877821221851, 13944.58166255014, 14026.85973140276, 14250.358733857001, 14252.358643861051, 14440.85559144416, 5834.154047663065, 5866.472017518444, 6000.249968753906, 6021.337652858182, 6046.697665116727, 987.916027137687, 998.6654470752234, 1008.5814387029301, 1013.5185786751234, 1019.918406527476, 21604.567908642053, 22502.099916003503, 22704.65943010856, 22844.200452984067, 23804.88097559536, 1084.9945750271197, 1090.4765712458066, 1100.5212732461246, 1143.9313641181388, 1155.179822326141, 12354.196977196454, 14555.0, 15670.138142402277, 15879.2060396982, 16045.759313610306, 197407.0, 198934.0, 199938.0, 200405.0, 200671.0, 53157.46842531525, 53191.20213196805, 53653.41545352725, 53940.460595393546, 54042.189367159524, 1420.7158568286384, 1455.89080818939, 1460.218782951116, 1462.7293950619169, 1465.369890946903, 24505.0, 26045.479090418463, 26417.471650567266, 27114.0, 27284.31789205286, 46620.7668961653, 46846.06307873892, 47098.293525596455, 47124.0, 47160.52839471561, 186265.0, 186832.0, 187292.0, 188678.0, 190094.0, 33238.16904577405, 33289.667103328655, 33395.49533784927, 33401.16497087592, 33433.0, 38524.229515410094, 39358.803205983786, 39865.202695945336, 40086.0, 40241.0, 28827.855860720563, 29883.55174672338, 30056.24859378533, 30466.695333046388, 31148.22129446782, 30761.0, 30833.075007749805, 30922.381552369276, 31013.991238005343, 31915.6808431922, 33523.32953340871, 35078.47382289319, 35376.823115884254, 35480.0, 35491.645083548836, 29042.419151617272, 29210.41579168447, 30276.5458518118, 30444.086677399715, 32000.5199922006, 21982.560348793253, 24359.75640243575, 24522.04945194955, 24531.754682452945, 24605.0], "value": 16467.71933779227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.2749062847845, 433.1337325349301, 434.74784624917544, 440.5748452743103, 453.15260462934316, 20061.197552097918, 20902.686459703098, 20904.05931733074, 21670.0, 22423.663645045337, 24771.256862294114, 25185.622215666735, 25420.11029613964, 25468.36329091769, 25509.744902551014, 6906.8273293167695, 7041.929580704204, 7058.223595404502, 7059.08231929851, 7098.645067746618, 6491.642959637218, 6832.521723479358, 6852.897206541906, 6870.4503639708955, 6926.896096558556, 6850.7602233921825, 6859.759908403207, 6895.310468953115, 6899.827029404988, 6921.307869213064, 6857.58854468731, 6870.931290687079, 6876.106106206211, 6881.380675739208, 6892.069570607979, 6692.732290708366, 6712.463002959751, 6722.260551339349, 6738.056672065914, 6756.797296081126, 27617.0, 28346.43307133846, 28356.574651380244, 28605.28486787826, 28877.711222887712, 1945.231633504772, 1980.9702854457194, 1981.4055783264962, 1983.0283161251027, 1985.493699106733, 17848.643027139384, 18256.269749210016, 18257.17842697082, 18317.450476485727, 18372.90813545937, 2353.694019777435, 2381.9642705359433, 2419.2984034629935, 2455.0670745116918, 2482.2305085423577, 120102.0, 121962.0, 124175.3791231038, 129134.0, 129808.0, 19495.198436304785, 20146.489013323768, 20606.896965515076, 20700.275490357766, 21108.261210857545, 39114.80442597769, 39565.208695825924, 39686.47524594077, 39753.0, 39800.800995995414, 10553.683389498327, 10841.891581084246, 10972.177086718528, 11012.229143959847, 11143.387113708663, 8757.912420875837, 8790.736277911672, 8882.600282987281, 9026.684066057787, 9039.909600904039, 10141.645042423479, 10423.0, 10559.419231942316, 10653.733656658645, 10770.623028193975, 3654.8538058477893, 3780.5085338905765, 3987.6809855211513, 4028.697847661437, 4276.5723427656985, 905.4069584422214, 935.4854829843695, 937.840567103594, 978.8972157923458, 981.8134554434778, 18613.162407691685, 18755.624887502174, 19317.0, 20466.0, 21553.56892862134, 992.6079198716611, 999.3454287441738, 1001.2390583156707, 1025.7845852371086, 1050.8844027157006, 10561.207909406672, 10762.892371076345, 11333.886661133449, 11401.258918170292, 11487.885121148849, 466757.0, 473886.0, 478399.0, 491856.0, 496015.0, 106110.46944765381, 107267.0, 108348.0, 108400.0, 109206.45396772966, 1097.91765617579, 1141.0985321595847, 1218.4882349413267, 1220.6948262934266, 1281.4105511464645, 19109.522261943563, 19534.706979395036, 20249.582529222815, 20790.27234046801, 20823.8958805205, 48824.75587622039, 48976.51023489719, 49097.0, 49566.256506151716, 49973.0, 60293.397066030535, 60407.0, 61160.38839611725, 61162.38837611567, 61549.69225153846, 10056.19550435978, 10566.577336906437, 10647.627333043307, 10660.62687805923, 10675.412852293199, 15929.840701592835, 16120.516384508484, 17429.302827887248, 17942.0, 17943.82056179474, 14563.199024053778, 14722.190279534729, 14743.967922245769, 14947.402103915721, 15186.088834669956, 11024.118070554498, 11459.51026366567, 12190.634280971584, 12274.938625306817, 12301.630951071482, 12963.0, 13319.66700832487, 13325.466981321026, 13506.324683765968, 13510.662233444242, 9552.617895284111, 9658.77848094928, 9661.13049825519, 9663.710088697351, 9666.178374838217, 12301.75396492083, 12599.622011339674, 14719.116852988427, 14791.0, 14811.333489992761], "value": 11511.692279915116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.4854006937294, 1365.8087867698518, 1380.351234919588, 1390.402127085353, 1393.4426229508194, 10838.566457341707, 11287.097032237421, 11345.659630211107, 11347.37589432582, 11591.362475063868, 11423.0, 11613.0, 11632.243904146246, 11638.068954483642, 11659.708507287321, 2361.25620429565, 2406.89168987396, 2407.38611654028, 2410.6384042393606, 2411.131992482705, 2311.641695537186, 2365.1485465232504, 2371.4545654499475, 2374.5844477216506, 2383.976160238393, 2275.6927814744963, 2298.425393651587, 2299.3906614747107, 2301.873396963166, 2317.5133222023396, 2222.733272007353, 2246.651768975811, 2253.0, 2267.85258958168, 2273.1134857405623, 2180.4112889519897, 2251.4033781048033, 2358.3514533503253, 2359.539889721505, 2365.929022129339, 11208.047315978152, 11288.153388495895, 11338.0, 11345.659630211107, 11375.658730238107, 6137.41694539018, 6378.840528986766, 6384.074309225136, 6384.3934826191435, 6391.936080639181, 3596.9280614387567, 3670.944935825965, 3702.222533268017, 3720.5907350191455, 3793.1844653399376, 1229.846269216348, 1270.2695949828792, 1277.2783377391836, 1303.1855090568395, 1305.849827269857, 16071.0, 16180.676386472205, 16189.838101619069, 16257.105859177622, 16270.674586508321, 5108.897822043613, 5225.085610018232, 5247.921281180786, 5332.653377530448, 5396.1905714143195, 12022.098342624338, 12086.697832554257, 12102.455389507493, 12102.636920892388, 12134.878651213552, 6170.228721409824, 6248.094026366151, 6259.906101408483, 6293.339199383999, 6296.212973378328, 5708.857278567986, 5781.1328300754385, 5826.271716035496, 5839.328477225174, 5893.675847828411, 4155.340770740664, 4206.558311377323, 4217.873463796091, 4258.467691538558, 4297.763623000765, 1233.073869889796, 1266.9429875655617, 1274.898008159345, 1282.7178020835402, 1286.9806952895715, 844.4215712237137, 866.4065115395848, 882.9117088291248, 890.7639475538988, 908.6274627402734, 6507.967460162764, 6703.798886033427, 6886.793396198122, 7046.401055910305, 7383.335499804936, 549.9780008799684, 565.6125553995527, 572.3303734630492, 578.254052272572, 580.5964854426218, 4417.116576684676, 4448.466184057934, 4636.9536304637195, 5264.447233040476, 5278.155495120763, 14383.496577619733, 14735.705285894437, 14838.109713417229, 14873.0, 14881.553553393416, 14100.506482273071, 14485.710285794225, 14617.488387906373, 14647.12117272967, 14678.926605367118, 8963.641454341883, 9130.406523575946, 9150.63397464094, 9157.175854173156, 9170.358074934824, 6726.932730672826, 6861.348171923859, 7029.859402812018, 7391.1869694334655, 7485.737999170003, 12701.682457938625, 12788.616341509769, 12874.16317939331, 12875.613731587693, 12959.352032398154, 13056.543020994219, 13148.671283217613, 13204.867951320364, 13223.867761322264, 13355.065145439727, 9461.668841590512, 9659.323847330901, 9733.561989710339, 9761.365511241747, 9766.218702503924, 10578.153747700011, 10613.618427909787, 10635.840462392916, 10704.197185211297, 10733.570657173626, 8919.152680495343, 9062.818743625223, 9094.090590940854, 9117.589708463003, 9225.0, 8852.247558957302, 8904.910950890408, 8928.776780580538, 8991.82016359656, 9017.188453038996, 7915.406344524068, 7969.123396426505, 8250.422470427013, 8263.876041859497, 8287.046989596274, 6011.398860113954, 6153.692315384303, 6246.593971391845, 6258.874822503433, 6473.643949582818, 6276.874462510633, 6308.243010838729, 6519.3480651936325, 6590.637514936724, 6742.9662851685425], "value": 5257.164835294666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.16028439565923, 398.86438610872295, 400.591396775289, 401.5763369645025, 404.47014411121427, 6093.268807743066, 6187.752489900404, 6206.348333424993, 6208.627482351062, 6249.468795152417, 5978.133170690247, 6090.294717479102, 6098.817035488932, 6105.511559075275, 6106.725197366118, 4653.953460465403, 4783.760811959397, 4790.736509491977, 4795.568398844103, 4810.931299541196, 4791.784369703371, 4810.759462026885, 4811.831585894494, 4821.566059054684, 4834.540718631724, 4713.363695901044, 4727.05458908218, 4748.240281554952, 4748.620110391161, 4773.0, 4720.90558188836, 4762.618990480771, 4763.45220299663, 4775.164346239394, 4777.331173635694, 4150.605692459211, 4163.521195062546, 4164.354525048622, 4178.0, 4180.9338618652355, 6102.7864024759365, 6105.114758360058, 6110.816675499742, 6118.112873633343, 6121.816345509642, 5417.918731219035, 5446.623093681903, 5447.0, 5447.509724124848, 5453.890922181534, 6440.8406486832355, 6542.476601871839, 6545.116409284733, 6546.541742078057, 6571.112899758519, 4502.41468609082, 4509.458864936196, 4520.254158063915, 4531.637469002472, 4536.432945881765, 6493.9675301623665, 6852.349026842442, 6854.6229957352325, 6857.559912418398, 6933.445324374038, 4482.327650852399, 4553.112143132057, 4563.817447302137, 4589.35748995141, 4590.793414296365, 4599.241125214369, 4603.424571928509, 4620.653450991189, 4625.259958406638, 4659.1147681941, 5204.245384419238, 5341.545968592635, 5378.1663842104535, 5389.434109418533, 5394.244805727201, 6448.355164483608, 6500.382463665944, 6501.0, 6542.6401547914365, 6563.868722625521, 1613.5966008497876, 1620.3194658243567, 1620.9756853647204, 1624.0, 1636.2227941727583, 1045.3780000899453, 1064.8446435617286, 1073.1736562846565, 1085.5520800594609, 1086.1148164246115, 5702.51528620072, 5710.0, 5734.394369576526, 5735.684537350402, 5758.712064396764, 6646.83382915431, 6696.86606267872, 6717.932820671731, 6727.77983265531, 6730.495212859055, 5679.608495918526, 5692.060809966392, 5706.115552089433, 5716.885662286814, 5727.513161381329, 3578.731595130376, 3583.283343331344, 3589.2821435712963, 3597.892063238107, 3608.440691692792, 6525.575837570543, 6556.27880933097, 6565.835854103686, 6570.277269500351, 6574.717930003603, 6832.419244364285, 6850.6574671267235, 6854.074699915447, 6902.0, 6933.826654333682, 6452.774152904626, 6490.8052758417325, 6503.28463868974, 6532.150820393414, 6549.738010479623, 6721.1598550181225, 6740.730370785113, 6756.729730810909, 6766.255711871789, 6779.661016949231, 6680.3987641112535, 6697.497687673346, 6733.124693789972, 6740.258571557223, 6748.325167483213, 6093.177421048279, 6507.837304067436, 6519.054737063005, 6525.934740652533, 6541.215054193527, 4621.168189725881, 4632.9305060424795, 4637.443506779208, 4643.767811609338, 4647.3029045643425, 6517.641529715911, 6685.665716714047, 6694.765683201259, 6708.262091170065, 6734.6295953721055, 6470.0, 6505.772297969548, 6509.7396104155305, 6534.509911756732, 6559.114519539801, 6460.709268082854, 6482.643454610042, 6524.217093948757, 6525.662239240849, 6533.67331633426, 6314.273858506147, 6401.55189136756, 6411.903821442589, 6420.582662126947, 6478.902816457851, 6508.739650413931, 6540.50946179029, 6564.934350656432, 6568.47452203813, 6590.5716128451495, 6338.429541341301, 6346.4605508532295, 6354.856125897383, 6357.268914074941, 6393.520485963479], "value": 4889.828492458445, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [838.4256784102886, 860.4192170285056, 864.9005364383096, 866.6013633728485, 885.6634478898018, 14637.780433293483, 14893.0, 16659.83340166598, 17077.743833842487, 17132.0, 16159.192040397991, 16278.186090695477, 16295.755563666526, 16357.345706171738, 16493.618808144332, 967.5017366056486, 971.1745016735789, 977.1938151025397, 977.3744803325877, 978.2369751593733, 661.5832025823725, 943.32552225159, 966.4394651102343, 972.3631021680775, 975.8633791269228, 1021.5505177721778, 1031.4017869635632, 1033.519413472735, 1035.321864178964, 1037.8131936251473, 1023.2581378500565, 1023.948802559869, 1027.2090490322485, 1030.5414090729628, 1032.4012072997643, 755.9848803023964, 756.2097607999654, 757.9052618422697, 757.9658915348823, 759.7758661194961, 15555.144467054308, 16302.103384313858, 16758.0, 16890.408835690814, 16939.407120750715, 18601.0, 18888.0, 18967.24131034757, 18980.335688250983, 19038.0, 14496.565103046925, 14694.55916322512, 14744.926275368554, 14824.777628335476, 14842.996195513575, 3345.3142105868483, 3355.1947532592244, 3369.578802649669, 3387.7459190560808, 3398.796072235674, 88508.48169214076, 88665.55667221687, 89249.55375223083, 89305.0, 89575.0, 12593.685157870943, 12783.0, 12791.424385902657, 12926.547570834975, 12954.157979731288, 21411.35765927025, 21592.56814863694, 21815.127394904026, 22038.88980555119, 22041.559168816533, 7762.922370776333, 7859.921400785919, 7890.053193616803, 7905.209479052049, 7938.761837144895, 3420.675035871588, 3656.780593164419, 3800.771953682788, 3890.8054597270025, 3896.785676787804, 4029.6977726670616, 4161.0845613964875, 4173.916521669549, 4174.519930208005, 4180.268453020709, 806.4314658165979, 846.7459762071354, 851.476342049635, 855.7988872614931, 855.9614817333235, 633.9429451349308, 649.5810202419412, 653.7417720000573, 658.2561705273107, 680.3196803196803, 10910.290831096112, 11160.553577856957, 11662.76674466506, 12483.188592741442, 12487.50049998008, 641.8363317354044, 646.6281887914467, 659.5679829711546, 677.2786981864299, 680.1803826389189, 5108.744562771846, 5306.6550674206055, 5524.116141417434, 5592.384837667853, 5610.5231055360755, 82251.17748822435, 83285.58357208176, 83621.0, 85461.0, 95833.0, 70857.64571177111, 71612.28387716161, 71964.0, 72006.0, 72950.63524682343, 63197.368026320066, 63360.0, 64936.675316623114, 64988.67505662536, 67394.0, 11245.662630121109, 12325.568605098779, 12354.444050017592, 12445.62663120108, 12501.812472813097, 29653.40693186081, 29711.65190265773, 29794.255143621584, 30631.54052689167, 30868.53697194499, 36558.63441365552, 36836.81581592182, 37288.0, 37821.0, 37909.43135853019, 16102.919485402497, 16285.348586056425, 16711.498655040366, 16736.832631673526, 16899.493015209562, 18087.547811304823, 18434.446966591022, 18694.34569790051, 18938.0530973448, 19213.03934803282, 16983.0, 17599.472015839547, 17843.643127137126, 18154.81845181584, 18261.269549217883, 17066.402675906284, 17469.563260918578, 17562.912185438992, 17845.643087138444, 18077.819221807615, 17292.740608891127, 17405.738913916048, 17443.215055322795, 17506.037167955885, 17879.821201788334, 10845.891541084487, 11024.219065162704, 11296.265742726697, 11831.11266654987, 12188.0, 12805.615831525069, 12984.610461686165, 13557.84888658, 13957.860421396063, 14042.859571404155], "value": 7943.523348994985, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 112.0, 109.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 126.0, 166.0, 129.0, 128.0, 124.0, 127.0, 154.0, 127.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 164.0, 164.0, 169.0, 167.0, 167.0, 173.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 123.0, 78.0, 73.0, 74.0, 75.0, 93.0, 74.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 114.0, 83.0, 84.0, 85.0, 101.0, 84.0, 86.0, 105.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 117.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 150.0, 151.0, 150.0, 152.0, 150.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 59.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 54.0, 55.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 87.0, 88.0, 91.0, 87.0, 89.0, 91.0, 111.0, 89.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 134.0, 131.0, 131.0, 137.0, 139.0, 142.0, 129.0, 146.0, 130.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 207.0, 195.0, 197.0, 194.0, 195.0, 191.0, 190.0, 189.0, 197.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 71.0, 72.0, 76.0, 77.0, 72.0, 74.0, 75.0, 72.0], "value": 73.6, "unit": "score"}]}]} 03:14:42 INFO - Return code: 0 03:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:14:42 INFO - # TBPL SUCCESS # 03:14:42 INFO - Running post-action listener: _resource_record_post_action 03:14:42 INFO - [mozharness: 2017-06-05 10:14:42.063124Z] Finished run-tests step (success) 03:14:42 INFO - Running post-run listener: _resource_record_post_run 03:14:42 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 10969088; Write bytes: 425353216; Read time: 3280; Write time: 331692 03:14:42 INFO - TinderboxPrint: CPU usage
12.7% 03:14:42 INFO - TinderboxPrint: I/O read bytes / time
10,969,088 / 3,280 03:14:42 INFO - TinderboxPrint: I/O write bytes / time
425,353,216 / 331,692 03:14:42 INFO - TinderboxPrint: CPU idle
8,746.2 (87.3%) 03:14:42 INFO - TinderboxPrint: CPU user
1,209.9 (12.1%) 03:14:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:14:42 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 40960; Write bytes: 102797312; Read time: 196; Write time: 95716 03:14:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:14:42 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 8568832; Write bytes: 322555904; Read time: 2436; Write time: 235976 03:14:42 INFO - Running post-run listener: _upload_blobber_files 03:14:42 INFO - Blob upload gear active. 03:14:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:14:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:14:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:14:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:14:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:45 INFO - (blobuploader) - INFO - Done attempting. 03:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:46 INFO - (blobuploader) - INFO - Done attempting. 03:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:53 INFO - (blobuploader) - INFO - Done attempting. 03:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:14:54 INFO - (blobuploader) - INFO - Done attempting. 03:14:54 INFO - (blobuploader) - INFO - Iteration through files over. 03:14:54 INFO - Return code: 0 03:14:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:14:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:14:54 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c1a3f271e1f5aa9de7df2a767c8989c9c5f5e4476b0ee09c9953578a5f0b16a8e513e1903c6e5a48fd42327c6001a5361ff3f19cf9f72caa2d4eef57ba8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ef88930d8251e62d2c5d48bfe5f9e0d05c7888effa3a053aeb3958ed5320a1930013f7e0fdee554232bfd2b80fdbcbb5081ce771f9dde813f76d936eb8f4bfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18123548ac6f3255de4393d033e4ac8e005b542c0a2f662b9b75844d75ace1f81f4c9a19895d0cfdeec3c9666dde69826c37a044d3d5c80ac15acede3c0a8922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6fdfae43e21a6efd0d8011652c77cef0a7f8b4a57cd1a55f592da02e04c9df7405e55d0133efeaa7eb983ef4992c4945692ad87d5b3f20977191725b71ed35"} 03:14:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:14:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:14:54 INFO - Contents: 03:14:54 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c1a3f271e1f5aa9de7df2a767c8989c9c5f5e4476b0ee09c9953578a5f0b16a8e513e1903c6e5a48fd42327c6001a5361ff3f19cf9f72caa2d4eef57ba8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ef88930d8251e62d2c5d48bfe5f9e0d05c7888effa3a053aeb3958ed5320a1930013f7e0fdee554232bfd2b80fdbcbb5081ce771f9dde813f76d936eb8f4bfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18123548ac6f3255de4393d033e4ac8e005b542c0a2f662b9b75844d75ace1f81f4c9a19895d0cfdeec3c9666dde69826c37a044d3d5c80ac15acede3c0a8922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6fdfae43e21a6efd0d8011652c77cef0a7f8b4a57cd1a55f592da02e04c9df7405e55d0133efeaa7eb983ef4992c4945692ad87d5b3f20977191725b71ed35"} 03:14:54 INFO - Running post-run listener: copy_logs_to_upload_dir 03:14:54 INFO - Copying logs to upload dir... 03:14:54 INFO - mkdir: /builds/slave/test/build/upload/logs 03:14:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.321879 ========= master_lag: -0.13 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-05 03:14:54.108510) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:14:54.112052) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 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-Non-PGO/sha512/59c1a3f271e1f5aa9de7df2a767c8989c9c5f5e4476b0ee09c9953578a5f0b16a8e513e1903c6e5a48fd42327c6001a5361ff3f19cf9f72caa2d4eef57ba8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ef88930d8251e62d2c5d48bfe5f9e0d05c7888effa3a053aeb3958ed5320a1930013f7e0fdee554232bfd2b80fdbcbb5081ce771f9dde813f76d936eb8f4bfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18123548ac6f3255de4393d033e4ac8e005b542c0a2f662b9b75844d75ace1f81f4c9a19895d0cfdeec3c9666dde69826c37a044d3d5c80ac15acede3c0a8922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6fdfae43e21a6efd0d8011652c77cef0a7f8b4a57cd1a55f592da02e04c9df7405e55d0133efeaa7eb983ef4992c4945692ad87d5b3f20977191725b71ed35"} build_url:https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011158 build_url: 'https://queue.taskcluster.net/v1/task/GGIj7gUQTUKYCybQRx4diQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/59c1a3f271e1f5aa9de7df2a767c8989c9c5f5e4476b0ee09c9953578a5f0b16a8e513e1903c6e5a48fd42327c6001a5361ff3f19cf9f72caa2d4eef57ba8263", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ef88930d8251e62d2c5d48bfe5f9e0d05c7888effa3a053aeb3958ed5320a1930013f7e0fdee554232bfd2b80fdbcbb5081ce771f9dde813f76d936eb8f4bfa", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18123548ac6f3255de4393d033e4ac8e005b542c0a2f662b9b75844d75ace1f81f4c9a19895d0cfdeec3c9666dde69826c37a044d3d5c80ac15acede3c0a8922", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6fdfae43e21a6efd0d8011652c77cef0a7f8b4a57cd1a55f592da02e04c9df7405e55d0133efeaa7eb983ef4992c4945692ad87d5b3f20977191725b71ed35"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-05 03:14:54.135807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:14:54.136141) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1496656371.153463-1798310407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004257 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-05 03:14:54.219459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:14:54.219809) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-05 03:14:54.220109) ========= ========= Total master_lag: 0.04 =========