builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-002 starttime: 1496177306.89 results: success (0) revision: 692e277e2b9f3bb36d6d67e1166d135228f2d851 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:26.892926) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:26.893340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:26.893767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:26.918331) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:26.918602) ========= 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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 13:48:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2017-05-30 13:48:27 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128924 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:27.059846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:27.060132) ========= 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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021250 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:27.109547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 13:48:27.109842) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 692e277e2b9f3bb36d6d67e1166d135228f2d851 --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 692e277e2b9f3bb36d6d67e1166d135228f2d851 --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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 13:48:27,268 truncating revision to first 12 chars 2017-05-30 13:48:27,268 Setting DEBUG logging. 2017-05-30 13:48:27,268 attempt 1/10 2017-05-30 13:48:27,268 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/692e277e2b9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 13:48:28,407 unpacking tar archive at: mozilla-central-692e277e2b9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461346 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-30 13:48:28.584307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:28.584610) ========= script_repo_revision: 692e277e2b9f3bb36d6d67e1166d135228f2d851 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:28.584987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:28.585262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 13:48:28.592206) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 13:48:28.592523) ========= /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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:48:28 INFO - MultiFileLogger online at 20170530 13:48:28 in /builds/slave/test 13:48:28 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 13:48:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:28 INFO - {'append_to_log': False, 13:48:28 INFO - 'base_work_dir': '/builds/slave/test', 13:48:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:48:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:28 INFO - 'branch': 'Firefox-Non-PGO', 13:48:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:28 INFO - 'config_files': ('talos/linux_config.py',), 13:48:28 INFO - 'default_actions': ('clobber', 13:48:28 INFO - 'read-buildbot-config', 13:48:28 INFO - 'download-and-extract', 13:48:28 INFO - 'populate-webroot', 13:48:28 INFO - 'create-virtualenv', 13:48:28 INFO - 'install', 13:48:28 INFO - 'setup-mitmproxy', 13:48:28 INFO - 'run-tests'), 13:48:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:28 INFO - 'download_minidump_stackwalk': True, 13:48:28 INFO - 'download_symbols': 'ondemand', 13:48:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:28 INFO - 'gecko_profile': False, 13:48:28 INFO - 'gecko_profile_interval': 0, 13:48:28 INFO - 'installer_path': 'installer.exe', 13:48:28 INFO - 'log_level': 'info', 13:48:28 INFO - 'log_name': 'talos', 13:48:28 INFO - 'log_to_console': True, 13:48:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:48:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:48:28 INFO - 'opt_config_files': (), 13:48:28 INFO - 'pip_index': False, 13:48:28 INFO - 'suite': 'dromaeojs-e10s', 13:48:28 INFO - 'system_bits': '32', 13:48:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:28 INFO - 'title': 'talos-linux64-ix-002', 13:48:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:28 INFO - 'use_talos_json': True, 13:48:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:28 INFO - 'work_dir': 'build'} 13:48:28 INFO - [mozharness: 2017-05-30 20:48:28.853701Z] Running clobber step. 13:48:28 INFO - Running pre-action listener: _resource_record_pre_action 13:48:28 INFO - Running main action method: clobber 13:48:28 INFO - rmtree: /builds/slave/test/build 13:48:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:30 INFO - Running post-action listener: _resource_record_post_action 13:48:30 INFO - [mozharness: 2017-05-30 20:48:30.395180Z] Finished clobber step (success) 13:48:30 INFO - [mozharness: 2017-05-30 20:48:30.395280Z] Running read-buildbot-config step. 13:48:30 INFO - Running pre-action listener: _resource_record_pre_action 13:48:30 INFO - Running main action method: read_buildbot_config 13:48:30 INFO - Using buildbot properties: 13:48:30 INFO - { 13:48:30 INFO - "project": "", 13:48:30 INFO - "product": "firefox", 13:48:30 INFO - "who": "ryanvm@gmail.com", 13:48:30 INFO - "installer_path": "public/build/target.tar.bz2", 13:48:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:48:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:48:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:48:30 INFO - "stage_platform": "linux64", 13:48:30 INFO - "basedir": "/builds/slave/test", 13:48:30 INFO - "buildnumber": 916, 13:48:30 INFO - "platform": "ubuntu64_hw", 13:48:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:48:30 INFO - "slavebuilddir": "test", 13:48:30 INFO - "taskId": "Kt80VIkTTD6vTxvYRLMm3w", 13:48:30 INFO - "branch": "mozilla-central", 13:48:30 INFO - "script_repo_revision": "production", 13:48:30 INFO - "revision": "692e277e2b9f3bb36d6d67e1166d135228f2d851", 13:48:30 INFO - "slavename": "talos-linux64-ix-002", 13:48:30 INFO - "repo_path": "mozilla-central" 13:48:30 INFO - } 13:48:30 INFO - Finding installer, test and symbols from parent task. 13:48:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kt80VIkTTD6vTxvYRLMm3w'}, attempt #1 13:48:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kt80VIkTTD6vTxvYRLMm3w'}, attempt #1 13:48:31 INFO - Task dependencies: PZVsRlzkQW29UrG0ZBaGEg 13:48:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg'}, attempt #1 13:48:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 13:48:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/test_packages.json 13:48:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.crashreporter-symbols.zip 13:48:31 INFO - Running post-action listener: _resource_record_post_action 13:48:31 INFO - [mozharness: 2017-05-30 20:48:31.797330Z] Finished read-buildbot-config step (success) 13:48:31 INFO - [mozharness: 2017-05-30 20:48:31.797596Z] Running download-and-extract step. 13:48:31 INFO - Running pre-action listener: _resource_record_pre_action 13:48:31 INFO - Running main action method: download_and_extract 13:48:31 INFO - mkdir: /builds/slave/test/build/tests 13:48: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')]} 13:48:31 INFO - trying https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.test_packages.json 13:48:31 INFO - Downloading https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:48:32 INFO - Downloaded 986 bytes. 13:48:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:48:32 INFO - Using the following test package requirements: 13:48:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:48:32 INFO - u'common': [u'target.common.tests.zip'], 13:48:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:48:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:48:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:48:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:48:32 INFO - u'mozbase': [u'target.common.tests.zip'], 13:48:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:48:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:48:32 INFO - u'web-platform': [u'target.common.tests.zip', 13:48:32 INFO - u'target.web-platform.tests.zip'], 13:48:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:48:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:48:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip 13:48:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:48:32 INFO - Fetch https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip into memory 13:48:33 INFO - Content-Length response header: 63526967 13:48:33 INFO - Bytes received: 63526967 13:48:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:48:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip 13:48:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:48:44 INFO - Fetch https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.common.tests.zip into memory 13:48:45 INFO - Content-Length response header: 63526967 13:48:45 INFO - Bytes received: 63526967 13:48:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.talos.tests.zip 13:48:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:48:57 INFO - Fetch https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.talos.tests.zip into memory 13:48:58 INFO - Content-Length response header: 14447425 13:48:58 INFO - Bytes received: 14447425 13:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:58 INFO - trying https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 13:48:58 INFO - Downloading https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:48:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:48:59 INFO - Downloaded 54148769 bytes. 13:48:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 13:48:59 INFO - mkdir: /builds/slave/test/properties 13:48:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:59 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:59 INFO - Contents: 13:48:59 INFO - build_url:https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - Running post-action listener: set_extra_try_arguments 13:48:59 INFO - [mozharness: 2017-05-30 20:48:59.390669Z] Finished download-and-extract step (success) 13:48:59 INFO - [mozharness: 2017-05-30 20:48:59.390765Z] Running populate-webroot step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: populate_webroot 13:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:59 INFO - '--tppagecycles', 13:48:59 INFO - '7'], 13:48:59 INFO - 'tests': ['tsvgm']}}, 13:48:59 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['damp', 'tps']}, 13:48:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'tests': ['damp', 'tps']}, 13:48:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['dromaeo_dom']}, 13:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:48:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:48:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:48:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['a11yr', 13:48:59 INFO - 'ts_paint', 13:48:59 INFO - 'tpaint', 13:48:59 INFO - 'sessionrestore', 13:48:59 INFO - 'sessionrestore_no_auto_restore', 13:48:59 INFO - 'tabpaint']}, 13:48:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:48:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:48:59 INFO - 'bloom_basic_ref']}, 13:48:59 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 13:48:59 INFO - 'talos_options': ['--mitmproxy', 13:48:59 INFO - 'mitmproxy-recording-1.mp', 13:48:59 INFO - '--firstNonBlankPaint'], 13:48:59 INFO - 'tests': ['Quantum_1']}, 13:48:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tsvgx', 13:48:59 INFO - 'tsvgr_opacity', 13:48:59 INFO - 'tart', 13:48:59 INFO - 'tscrollx', 13:48:59 INFO - 'cart', 13:48:59 INFO - 'tsvg_static']}, 13:48:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:59 INFO - 'tsvgr_opacity', 13:48:59 INFO - 'tart', 13:48:59 INFO - 'tscrollx', 13:48:59 INFO - 'cart', 13:48:59 INFO - 'tsvg_static']}, 13:48:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s'], 13:48:59 INFO - 'tests': ['tp5o']}, 13:48:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:48:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'talos_options': ['--disable-e10s', 13:48:59 INFO - '--xperf_path', 13:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:59 INFO - 'tests': ['tp5n']}, 13:48:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:48:59 INFO - 'talos_options': ['--xperf_path', 13:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:59 INFO - 'tests': ['tp5n']}}, 13:48:59 INFO - 'talos.zip': {'path': '', 13:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:59 INFO - Running post-action listener: _resource_record_post_action 13:48:59 INFO - [mozharness: 2017-05-30 20:48:59.405139Z] Finished populate-webroot step (success) 13:48:59 INFO - [mozharness: 2017-05-30 20:48:59.405234Z] Running create-virtualenv step. 13:48:59 INFO - Running pre-action listener: _resource_record_pre_action 13:48:59 INFO - Running main action method: create_virtualenv 13:48:59 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:59 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 13:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:59 INFO - Using real prefix '/usr' 13:48:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:01 INFO - Installing pip.................done. 13:49:01 INFO - Return code: 0 13:49:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:02 INFO - Reading from file tmpfile_stdout 13:49:02 INFO - Output received: 13:49:02 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) 13:49:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 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 13:49:02 INFO - Cleaning up... 13:49:02 INFO - Return code: 0 13:49:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 INFO - Downloading/unpacking psutil>=3.1.1 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:03 INFO - Installing collected packages: psutil 13:49:03 INFO - Running setup.py install for psutil 13:49:03 INFO - building 'psutil._psutil_linux' extension 13:49:03 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 13:49:04 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 13:49:04 INFO - building 'psutil._psutil_posix' extension 13:49:04 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 13:49:04 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 13:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:04 INFO - Successfully installed psutil 13:49:04 INFO - Cleaning up... 13:49:04 INFO - Return code: 0 13:49:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49: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')]} 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:49:04 INFO - Using env: {'DISPLAY': ':0', 13:49:04 INFO - 'HOME': '/home/cltbld', 13:49:04 INFO - 'LANG': 'en_US.UTF-8', 13:49:04 INFO - 'LANGUAGE': 'en_US:en', 13:49:04 INFO - 'LOGNAME': 'cltbld', 13:49:04 INFO - 'MAIL': '/var/mail/cltbld', 13:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:04 INFO - 'MOZ_NO_REMOTE': '1', 13:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:04 INFO - 'NO_EM_RESTART': '1', 13:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:04 INFO - 'PWD': '/builds/slave/test', 13:49:04 INFO - 'SHELL': '/bin/bash', 13:49:04 INFO - 'SHLVL': '1', 13:49:04 INFO - 'TERM': 'linux', 13:49:04 INFO - 'TMOUT': '86400', 13:49:04 INFO - 'USER': 'cltbld', 13:49:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:04 INFO - '_': '/tools/buildbot/bin/python'} 13:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:05 INFO - Installing collected packages: mozsystemmonitor 13:49:05 INFO - Running setup.py install for mozsystemmonitor 13:49:05 INFO - Successfully installed mozsystemmonitor 13:49:05 INFO - Cleaning up... 13:49:05 INFO - Return code: 0 13:49:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:05 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:05 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 13:49:05 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 13:49:05 INFO - Using env: {'DISPLAY': ':0', 13:49:05 INFO - 'HOME': '/home/cltbld', 13:49:05 INFO - 'LANG': 'en_US.UTF-8', 13:49:05 INFO - 'LANGUAGE': 'en_US:en', 13:49:05 INFO - 'LOGNAME': 'cltbld', 13:49:05 INFO - 'MAIL': '/var/mail/cltbld', 13:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:05 INFO - 'MOZ_NO_REMOTE': '1', 13:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:05 INFO - 'NO_EM_RESTART': '1', 13:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:05 INFO - 'PWD': '/builds/slave/test', 13:49:05 INFO - 'SHELL': '/bin/bash', 13:49:05 INFO - 'SHLVL': '1', 13:49:05 INFO - 'TERM': 'linux', 13:49:05 INFO - 'TMOUT': '86400', 13:49:05 INFO - 'USER': 'cltbld', 13:49:05 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:05 INFO - '_': '/tools/buildbot/bin/python'} 13:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:06 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:06 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 13:49:06 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 13:49:06 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 13:49:06 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 13:49:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:07 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 13:49:07 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 13:49:07 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 13:49:07 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 13:49:07 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:07 INFO - warning: no files found matching '*.txt' 13:49:07 INFO - no previously-included directories found matching 'build' 13:49:07 INFO - no previously-included directories found matching 'dist' 13:49:07 INFO - no previously-included directories found matching '.git*' 13:49:07 INFO - Installing collected packages: jsonschema, functools32 13:49:07 INFO - Running setup.py install for functools32 13:49:07 INFO - warning: no files found matching '*.txt' 13:49:07 INFO - no previously-included directories found matching 'build' 13:49:07 INFO - no previously-included directories found matching 'dist' 13:49:07 INFO - no previously-included directories found matching '.git*' 13:49:07 INFO - Successfully installed jsonschema functools32 13:49:07 INFO - Cleaning up... 13:49:07 INFO - Return code: 0 13:49:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:07 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:07 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 13:49:07 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 13:49:07 INFO - Using env: {'DISPLAY': ':0', 13:49:07 INFO - 'HOME': '/home/cltbld', 13:49:07 INFO - 'LANG': 'en_US.UTF-8', 13:49:07 INFO - 'LANGUAGE': 'en_US:en', 13:49:07 INFO - 'LOGNAME': 'cltbld', 13:49:07 INFO - 'MAIL': '/var/mail/cltbld', 13:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:07 INFO - 'MOZ_NO_REMOTE': '1', 13:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:07 INFO - 'NO_EM_RESTART': '1', 13:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:07 INFO - 'PWD': '/builds/slave/test', 13:49:07 INFO - 'SHELL': '/bin/bash', 13:49:07 INFO - 'SHLVL': '1', 13:49:07 INFO - 'TERM': 'linux', 13:49:07 INFO - 'TMOUT': '86400', 13:49:07 INFO - 'USER': 'cltbld', 13:49:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:07 INFO - '_': '/tools/buildbot/bin/python'} 13:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:07 INFO - Cleaning up... 13:49:07 INFO - Return code: 0 13:49:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:07 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:07 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 13:49:07 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 13:49:07 INFO - Using env: {'DISPLAY': ':0', 13:49:07 INFO - 'HOME': '/home/cltbld', 13:49:07 INFO - 'LANG': 'en_US.UTF-8', 13:49:07 INFO - 'LANGUAGE': 'en_US:en', 13:49:07 INFO - 'LOGNAME': 'cltbld', 13:49:07 INFO - 'MAIL': '/var/mail/cltbld', 13:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:07 INFO - 'MOZ_NO_REMOTE': '1', 13:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:07 INFO - 'NO_EM_RESTART': '1', 13:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:07 INFO - 'PWD': '/builds/slave/test', 13:49:07 INFO - 'SHELL': '/bin/bash', 13:49:07 INFO - 'SHLVL': '1', 13:49:07 INFO - 'TERM': 'linux', 13:49:07 INFO - 'TMOUT': '86400', 13:49:07 INFO - 'USER': 'cltbld', 13:49:07 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:07 INFO - '_': '/tools/buildbot/bin/python'} 13:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:07 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:07 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 13:49:07 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 13:49:07 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 13:49:07 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 13:49:09 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 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 13:49:09 INFO - Downloading docopt-0.6.1.tar.gz 13:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:09 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:09 INFO - Running setup.py install for blobuploader 13:49:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:09 INFO - Running setup.py install for requests 13:49:10 INFO - Running setup.py install for docopt 13:49:10 INFO - Successfully installed blobuploader requests docopt 13:49:10 INFO - Cleaning up... 13:49:10 INFO - Return code: 0 13:49:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:10 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:10 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 13:49:10 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 13:49:10 INFO - Using env: {'DISPLAY': ':0', 13:49:10 INFO - 'HOME': '/home/cltbld', 13:49:10 INFO - 'LANG': 'en_US.UTF-8', 13:49:10 INFO - 'LANGUAGE': 'en_US:en', 13:49:10 INFO - 'LOGNAME': 'cltbld', 13:49:10 INFO - 'MAIL': '/var/mail/cltbld', 13:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:10 INFO - 'MOZ_NO_REMOTE': '1', 13:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:10 INFO - 'NO_EM_RESTART': '1', 13:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:10 INFO - 'PWD': '/builds/slave/test', 13:49:10 INFO - 'SHELL': '/bin/bash', 13:49:10 INFO - 'SHLVL': '1', 13:49:10 INFO - 'TERM': 'linux', 13:49:10 INFO - 'TMOUT': '86400', 13:49:10 INFO - 'USER': 'cltbld', 13:49:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:10 INFO - '_': '/tools/buildbot/bin/python'} 13:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:10 INFO - Running setup.py (path:/tmp/pip-e8H9QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:10 INFO - Running setup.py (path:/tmp/pip-cDrGm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:10 INFO - Running setup.py (path:/tmp/pip-4XrU7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:10 INFO - Running setup.py (path:/tmp/pip-t4xily-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:10 INFO - Running setup.py (path:/tmp/pip-fytNGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:10 INFO - Running setup.py (path:/tmp/pip-VuvKgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:10 INFO - Running setup.py (path:/tmp/pip-brn1K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:10 INFO - Running setup.py (path:/tmp/pip-V12oQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:11 INFO - Running setup.py (path:/tmp/pip-jjSqOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:11 INFO - Running setup.py (path:/tmp/pip-KYgzmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:11 INFO - Running setup.py (path:/tmp/pip-PDuB5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:11 INFO - Running setup.py (path:/tmp/pip-ihtGQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:11 INFO - Running setup.py (path:/tmp/pip-KUfWAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:11 INFO - Running setup.py (path:/tmp/pip-Eez62d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:11 INFO - Running setup.py (path:/tmp/pip-eik_DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:11 INFO - Running setup.py (path:/tmp/pip-LMMQH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:11 INFO - Running setup.py (path:/tmp/pip-NP9DXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:11 INFO - Running setup.py install for manifestparser 13:49:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:11 INFO - Running setup.py install for mozcrash 13:49:11 INFO - Running setup.py install for mozdebug 13:49:11 INFO - Running setup.py install for mozdevice 13:49:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for mozfile 13:49:12 INFO - Running setup.py install for mozhttpd 13:49:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for mozinfo 13:49:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for mozInstall 13:49:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for mozleak 13:49:12 INFO - Running setup.py install for mozlog 13:49:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for moznetwork 13:49:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Running setup.py install for mozprocess 13:49:12 INFO - Running setup.py install for mozprofile 13:49:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:13 INFO - Running setup.py install for mozrunner 13:49:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:13 INFO - Running setup.py install for mozscreenshot 13:49:13 INFO - Running setup.py install for moztest 13:49:13 INFO - Running setup.py install for mozversion 13:49:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:13 INFO - Cleaning up... 13:49:13 INFO - Return code: 0 13:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:13 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:13 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 13:49:13 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 13:49:13 INFO - Using env: {'DISPLAY': ':0', 13:49:13 INFO - 'HOME': '/home/cltbld', 13:49:13 INFO - 'LANG': 'en_US.UTF-8', 13:49:13 INFO - 'LANGUAGE': 'en_US:en', 13:49:13 INFO - 'LOGNAME': 'cltbld', 13:49:13 INFO - 'MAIL': '/var/mail/cltbld', 13:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:13 INFO - 'MOZ_NO_REMOTE': '1', 13:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:13 INFO - 'NO_EM_RESTART': '1', 13:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:13 INFO - 'PWD': '/builds/slave/test', 13:49:13 INFO - 'SHELL': '/bin/bash', 13:49:13 INFO - 'SHLVL': '1', 13:49:13 INFO - 'TERM': 'linux', 13:49:13 INFO - 'TMOUT': '86400', 13:49:13 INFO - 'USER': 'cltbld', 13:49:13 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:13 INFO - '_': '/tools/buildbot/bin/python'} 13:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:13 INFO - Running setup.py (path:/tmp/pip-wHJmHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:13 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)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:13 INFO - Running setup.py (path:/tmp/pip-ownN47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:13 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)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:13 INFO - Running setup.py (path:/tmp/pip-UdSn7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:13 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)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:13 INFO - Running setup.py (path:/tmp/pip-Sc2cop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:13 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)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:13 INFO - Running setup.py (path:/tmp/pip-OhnYrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:14 INFO - Running setup.py (path:/tmp/pip-aUK8DC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:14 INFO - Running setup.py (path:/tmp/pip-8vmTWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:14 INFO - Running setup.py (path:/tmp/pip-GXE660-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:14 INFO - Running setup.py (path:/tmp/pip-NNwGKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:14 INFO - Running setup.py (path:/tmp/pip-a6LxnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:14 INFO - Running setup.py (path:/tmp/pip-iXwNR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:14 INFO - Running setup.py (path:/tmp/pip-00cd7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:14 INFO - Running setup.py (path:/tmp/pip-cnTaJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:14 INFO - Running setup.py (path:/tmp/pip-f_JvIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:14 INFO - Running setup.py (path:/tmp/pip-tIvMnf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:14 INFO - Running setup.py (path:/tmp/pip-QQACuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:14 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)) 13:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:14 INFO - Running setup.py (path:/tmp/pip-lbLZUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:14 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)) 13:49:14 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)) 13:49:14 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)) 13:49:14 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)) 13:49:14 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)) 13:49:14 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)) 13:49:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:15 INFO - Downloading blessings-1.6.tar.gz 13:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:16 INFO - Installing collected packages: blessings 13:49:16 INFO - Running setup.py install for blessings 13:49:16 INFO - Successfully installed blessings 13:49:16 INFO - Cleaning up... 13:49:16 INFO - Return code: 0 13:49:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:16 INFO - Reading from file tmpfile_stdout 13:49:16 INFO - Current package versions: 13:49:16 INFO - argparse == 1.2.1 13:49:16 INFO - blessings == 1.6 13:49:16 INFO - blobuploader == 1.2.4 13:49:16 INFO - docopt == 0.6.1 13:49:16 INFO - functools32 == 3.2.3-2 13:49:16 INFO - jsonschema == 2.5.1 13:49:16 INFO - manifestparser == 1.1 13:49:16 INFO - mozInstall == 1.12 13:49:16 INFO - mozcrash == 1.0 13:49:16 INFO - mozdebug == 0.1 13:49:16 INFO - mozdevice == 0.51 13:49:16 INFO - mozfile == 1.2 13:49:16 INFO - mozhttpd == 0.7 13:49:16 INFO - mozinfo == 0.9 13:49:16 INFO - mozleak == 0.1 13:49:16 INFO - mozlog == 3.4 13:49:16 INFO - moznetwork == 0.27 13:49:16 INFO - mozprocess == 0.25 13:49:16 INFO - mozprofile == 0.28 13:49:16 INFO - mozrunner == 6.13 13:49:16 INFO - mozscreenshot == 0.1 13:49:16 INFO - mozsystemmonitor == 0.3 13:49:16 INFO - moztest == 0.8 13:49:16 INFO - mozversion == 1.4 13:49:16 INFO - psutil == 3.1.1 13:49:16 INFO - requests == 1.2.3 13:49:16 INFO - wsgiref == 0.1.2 13:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:16 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')]} 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:16 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')]} 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:16 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:16 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 13:49:16 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 13:49:16 INFO - Using env: {'DISPLAY': ':0', 13:49:16 INFO - 'HOME': '/home/cltbld', 13:49:16 INFO - 'LANG': 'en_US.UTF-8', 13:49:16 INFO - 'LANGUAGE': 'en_US:en', 13:49:16 INFO - 'LOGNAME': 'cltbld', 13:49:16 INFO - 'MAIL': '/var/mail/cltbld', 13:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:16 INFO - 'MOZ_NO_REMOTE': '1', 13:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:16 INFO - 'NO_EM_RESTART': '1', 13:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:16 INFO - 'PWD': '/builds/slave/test', 13:49:16 INFO - 'SHELL': '/bin/bash', 13:49:16 INFO - 'SHLVL': '1', 13:49:16 INFO - 'TERM': 'linux', 13:49:16 INFO - 'TMOUT': '86400', 13:49:16 INFO - 'USER': 'cltbld', 13:49:16 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:16 INFO - '_': '/tools/buildbot/bin/python'} 13:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 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)) 13:49:16 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:17 INFO - Downloading marionette_driver-1.4.0.tar.gz 13:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 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)) 13:49:17 INFO - Installing collected packages: marionette-driver 13:49:17 INFO - Running setup.py install for marionette-driver 13:49:17 INFO - Successfully installed marionette-driver 13:49:17 INFO - Cleaning up... 13:49:17 INFO - Return code: 0 13:49:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:17 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')]} 13:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:17 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')]} 13:49:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:17 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 0x12943b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, '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': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', '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 13:49:18 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 13:49:18 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 13:49:18 INFO - Using env: {'DISPLAY': ':0', 13:49:18 INFO - 'HOME': '/home/cltbld', 13:49:18 INFO - 'LANG': 'en_US.UTF-8', 13:49:18 INFO - 'LANGUAGE': 'en_US:en', 13:49:18 INFO - 'LOGNAME': 'cltbld', 13:49:18 INFO - 'MAIL': '/var/mail/cltbld', 13:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:18 INFO - 'MOZ_NO_REMOTE': '1', 13:49:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:18 INFO - 'NO_EM_RESTART': '1', 13:49:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:18 INFO - 'PWD': '/builds/slave/test', 13:49:18 INFO - 'SHELL': '/bin/bash', 13:49:18 INFO - 'SHLVL': '1', 13:49:18 INFO - 'TERM': 'linux', 13:49:18 INFO - 'TMOUT': '86400', 13:49:18 INFO - 'USER': 'cltbld', 13:49:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:18 INFO - '_': '/tools/buildbot/bin/python'} 13:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:18 INFO - Cleaning up... 13:49:18 INFO - Return code: 0 13:49:18 INFO - Running post-action listener: _resource_record_post_action 13:49:18 INFO - Running post-action listener: _start_resource_monitoring 13:49:18 INFO - Starting resource monitoring. 13:49:18 INFO - [mozharness: 2017-05-30 20:49:18.249177Z] Finished create-virtualenv step (success) 13:49:18 INFO - [mozharness: 2017-05-30 20:49:18.249826Z] Running install step. 13:49:18 INFO - Running pre-action listener: _resource_record_pre_action 13:49:18 INFO - Running main action method: install 13:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:18 INFO - Reading from file tmpfile_stdout 13:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:18 INFO - Reading from file tmpfile_stdout 13:49:18 INFO - Output received: 13:49:18 INFO - Usage: mozinstall [options] installer 13:49:18 INFO - Options: 13:49:18 INFO - -h, --help show this help message and exit 13:49:18 INFO - -d DEST, --destination=DEST 13:49:18 INFO - Directory to install application into. [default: 13:49:18 INFO - "/builds/slave/test"] 13:49:18 INFO - --app=APP Application being installed. [default: firefox] 13:49:18 INFO - mkdir: /builds/slave/test/build/application 13:49:18 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'] 13:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:49:34 INFO - Reading from file tmpfile_stdout 13:49:34 INFO - Output received: 13:49:34 INFO - /builds/slave/test/build/application/firefox/firefox 13:49:34 INFO - Running post-action listener: _resource_record_post_action 13:49:34 INFO - [mozharness: 2017-05-30 20:49:34.082788Z] Finished install step (success) 13:49:34 INFO - [mozharness: 2017-05-30 20:49:34.083073Z] Running setup-mitmproxy step. 13:49:34 INFO - Running pre-action listener: _resource_record_pre_action 13:49:34 INFO - Running main action method: setup_mitmproxy 13:49:34 INFO - Skipping: mitmproxy is not required 13:49:34 INFO - Running post-action listener: _resource_record_post_action 13:49:34 INFO - [mozharness: 2017-05-30 20:49:34.084192Z] Finished setup-mitmproxy step (success) 13:49:34 INFO - [mozharness: 2017-05-30 20:49:34.084410Z] Running run-tests step. 13:49:34 INFO - Running pre-action listener: _resource_record_pre_action 13:49:34 INFO - Running main action method: run_tests 13:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:34 INFO - Python 2.7.3 13:49:34 INFO - Return code: 0 13:49:34 INFO - grabbing minidump binary from tooltool 13:49: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')]} 13:49:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160ee40>, '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 0x160ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:49:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:49:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:49:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:34 INFO - Return code: 0 13:49:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:49:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:34 INFO - ENV: RUST_BACKTRACE is now 1 13:49:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:49:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:34 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/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:49:34 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/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 13:49:34 INFO - Using env: {'DISPLAY': ':0', 13:49:34 INFO - 'HOME': '/home/cltbld', 13:49:34 INFO - 'LANG': 'en_US.UTF-8', 13:49:34 INFO - 'LANGUAGE': 'en_US:en', 13:49:34 INFO - 'LOGNAME': 'cltbld', 13:49:34 INFO - 'MAIL': '/var/mail/cltbld', 13:49:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:34 INFO - 'MOZ_NO_REMOTE': '1', 13:49:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:34 INFO - 'NO_EM_RESTART': '1', 13:49:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:34 INFO - 'PWD': '/builds/slave/test', 13:49:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:34 INFO - 'RUST_BACKTRACE': '1', 13:49:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:49:34 INFO - 'SHELL': '/bin/bash', 13:49:34 INFO - 'SHLVL': '1', 13:49:34 INFO - 'TERM': 'linux', 13:49:34 INFO - 'TMOUT': '86400', 13:49:34 INFO - 'USER': 'cltbld', 13:49:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912', 13:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:34 INFO - '_': '/tools/buildbot/bin/python'} 13:49:34 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/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 13:49:34 INFO - mozversion application_buildid: 20170530200850 13:49:34 INFO - mozversion application_changeset: 692e277e2b9f3bb36d6d67e1166d135228f2d851 13:49:34 INFO - mozversion application_display_name: Nightly 13:49:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:34 INFO - mozversion application_name: Firefox 13:49:34 INFO - mozversion application_remotingname: firefox 13:49:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:49:34 INFO - mozversion application_vendor: Mozilla 13:49:34 INFO - mozversion application_version: 55.0a1 13:49:34 INFO - mozversion platform_buildid: 20170530200850 13:49:34 INFO - mozversion platform_changeset: 692e277e2b9f3bb36d6d67e1166d135228f2d851 13:49:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:49:34 INFO - mozversion platform_version: 55.0a1 13:49:34 INFO - using testdate: 1496177374 13:49:34 INFO - actual date: 1496177374 13:49:34 INFO - starting webserver on 'localhost:44618' 13:49:34 INFO - SUITE-START | Running 2 tests 13:49:34 INFO - TEST-START | dromaeo_css 13:49:34 INFO - operating with platform_type : linux_ 13:49:34 INFO - Initialising browser for dromaeo_css test... 13:49:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44618/getInfo.html -profile /tmp/tmpn8n9kJ/profile 13:49:34 INFO - TEST-INFO | started process 22941 (/builds/slave/test/build/application/firefox/firefox http://localhost:44618/getInfo.html) 13:50:09 INFO - TEST-INFO | 22941: killed by SIGTERM 13:50:09 INFO - Browser initialized. 13:50:09 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:09 INFO - TEST-INFO | started process 23139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn8n9kJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:21 INFO - PID 23139 | RSS: Main: 182362112 13:50:21 INFO - PID 23139 | 13:53:26 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44618/tests/dromaeo/cssquery-ext.html) 13:53:28 INFO - PID 23139 | RSS: Main: 178565120 13:53:28 INFO - PID 23139 | 13:56:30 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-ext.html (next: http://localhost:44618/tests/dromaeo/cssquery-jquery.html) 13:56:30 INFO - PID 23139 | RSS: Main: 183902208 13:56:30 INFO - PID 23139 | 13:59:32 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44618/tests/dromaeo/cssquery-mootools.html) 13:59:33 INFO - PID 23139 | RSS: Main: 180961280 13:59:33 INFO - PID 23139 | 14:02:34 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44618/tests/dromaeo/cssquery-prototype.html) 14:02:35 INFO - PID 23139 | RSS: Main: 185114624 14:02:35 INFO - PID 23139 | 14:05:38 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44618/tests/dromaeo/cssquery-yui.html) 14:05:39 INFO - PID 23139 | RSS: Main: 183750656 14:05:39 INFO - PID 23139 | 14:08:40 INFO - PID 23139 | Cycle 1(1): loaded http://localhost:44618/tests/dromaeo/cssquery-yui.html (next: http://localhost:44618/tests/dromaeo/cssquery-dojo.html) 14:08:41 INFO - PID 23139 | RSS: Main: 181641216 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | __start_tp_report 14:08:41 INFO - PID 23139 | _x_x_mozilla_page_load 14:08:41 INFO - PID 23139 | _x_x_mozilla_page_load_details 14:08:41 INFO - PID 23139 | |i|pagename|runs| 14:08:41 INFO - PID 23139 | |0;dojo.html;2725.9045933392335;2744.7804175665947;2755.655543057118;2787.553991361381;2787.749102580768;5295.576353891689;5358.6516876403;5369.731513424333;5388.622796404248;5434.809781657643;5284.841454756353;5354.41101478837;5376.059189641816;5381.946180538193;5432.91850622241;4657.790399432017;4709.128811169936;4724.858254252378;4747.715137091785;4787.8563643090765;4770.7376094314795;4783.784729687172;4785.473597904228;4792.209285467894;4830.87922801931;4695.694779839334;4734.171519983989;4734.763261836894;4741.075490279397;4745.2882067690125;4718.150732868083;4745.383100196987;4767.976160119212;4787.976060119712;4791.856244312677;4686.929696054562;4708.128996135726;4708.270218116198;4713.175194340976;4722.268048452495;5185.066687996159;5319.867003324909;5327.786888524454;5333.599980001515;5359.954808812283;5708.257926469574;5711.8000869969765;5753.626014309057;5758.856028599276;5794.652320860761;5858.502027327682;5858.970705146489;5864.354920958691;5868.501177399883;5906.586538942276;5412.052890744104;5412.783488660488;5413.756380962866;5424.918626220609;5427.891442171134;5827.096799996008;5885.47030767233;5931.377205393372;5942.316633587193;5999.850003749942;5739.368669446441;5751.079827227623;5763.827085187451;5772.653640781483;5800.245968024215;5704.857378565486;5812.709364531756;5817.88364232713;5823.417658234142;5835.620684655484;5654.943450565442;5723.02708539541;5766.250387449605;5796.333421656479;5797.739101740432;5709.286339207599;5726.255586773693;5767.106098554731;5783.508401785895;5820.156077368758;4830.686005409637;4835.298881662139;4844;4870.902581948341;4872.610191184696;4134.441850350164;4148.336266197454;4154.044569748975;4167.562405947392;4204.306289462265;4790.185668436374;4811.182099043171;4817.7350245736825;4885.658003939761;4895.877603059952;5831.912521312183;5848.473637372657;5851.327097383855;5899.528037756969;5916.7337469813965;4862.367892173995;4863.051704917578;4870.926936095891;4882.462929077798;4921.630877684116;5049.495050494921;5117.692938423706;5118.283440318359;5138.563222126087;5152.562032227303;5205.947940520547;5210.140326846028;5245.816396426107;5263.578913686819;5264.842054738364;5683.829485115453;5750.7987220447085;5771.913421298768;5774.538036957118;5880.676562789087;5296.41739408657;5431.23962645222;5435.483629055233;5449.291592093003;5462.863428414322;5622.9156562652415;5751.769929202785;5772.826815195551;5781.82654520365;5785.56608254391;5776.884462310646;5806.303243610793;5832.766689332379;5877.206577112035;5923.111533270044;5648.689322087324;5700.030994730989;5705.914411283917;5706.372299047019;5728.4271572844045;5635.267415235993;5679.801206957736;5684.431556844283;5688.14677798317;5688.914666280092;5458.399576046711;5551.861203469945;5586.888262234814;5601.383847776659;5627.127795191752;5633.577481688808;5644.6330988485615;5714.514266287412;5730.656160630376;5737;5403;5533.418991006048;5543.52880005204;5546.833594992157;5551.472610102034 14:08:41 INFO - PID 23139 | |1;ext.html;654.8362909272682;718.5042320798649;737.5169264131993;1087.7226307291635;1110.4780753046066;33708.662913370856;34533.30933381334;34566.30867382651;34592.827035864786;34623.65376346236;36197.63802361976;36540.81729591348;36588.63411365885;36638.45042324361;36696.08259793506;6661.766838160665;6861.348171923659;6995.160580730319;7156.85686286274;7158.677859496335;6869.278725733801;6991.61546114966;7006.194287656908;7007.7547285845;7014.193367762721;6970.546914450544;7021.262767409425;7024.4029257513175;7026.6486675666265;7040.47196460265;6989.510734248604;6990.266022067686;7006.334398232185;7008.053912721768;7014.894776578355;6791.864162716718;6825.795226143224;6831.11195544581;6832.965835170842;6839.521233513656;32400.351992960008;32625.51061734076;32702.6729732702;32709.509357359657;32833.343333133445;3107.9689203107905;3117.454445472056;3138.497840345534;3138.717515423623;3140.010896567574;24928.12751553705;25052.373690657696;25128;25161;25222.117225897007;3055.801372910776;3100.937981240385;3111.3466172103886;3135.0751528299206;3135.717785399325;128754;130516.3474182623;135856;146815;146884;39800.60199398027;39899.60100399017;39932.80033599814;39939.80030099831;39985;42188;42267.36598951018;42341;42411;42448.78775606164;12854.357282135856;12987.805182922264;12997.220166790023;13000.544980925622;13023.348832558335;10328.793424131625;10383.94808025955;10387.37675739458;10390.48047597617;10410.583576657;13010.739785204243;13020.348982550835;13061.608151755463;13164.210147391188;13291;5224.529792318634;5298;5363.678179309254;5388.380336261302;5391.892162156735;837.2841220756287;893.1470445724318;898.380117718772;916.1296768070359;920.8940971788196;20991.16035358599;21589.784102158777;21694.674579881314;21792.673109903364;22065.22771703015;974.1281553010016;982.474376208725;986.5363279258737;1004.5128112865254;1005.0452070533023;11049.723756906142;11511.769764604662;11534.942325288488;11561.42192890352;11570.074394048455;172369;173436;173597;173731;174129;42268;42620.3606945896;42704.35943460851;42708.14583708309;42717.786411068366;1212.0969877441362;1231.1259006105586;1234.3519652182677;1236.1841184818156;1242.5402601037674;19708.50728731793;19842.543300591875;20700.58598828045;21258.893705531373;21524.139034438445;30537.694623053485;30549.389012220076;30595.54106688357;30599.54100688447;30699;149618;149895;150168;150265;150379;29814.25464363408;29814.701852981194;29946.70053299439;30455.543166852072;30652.693473065876;36515.63484365229;36658;36707.81646091752;36710.26579468342;36721.44917826288;26517.867410662824;28064.71935280621;28347.43305133927;28559.42881142407;28964.855175723987;26910.461790764468;27644.86177569099;28313.57529637016;28665.856670716512;28686.856565717037;31107.22231944129;31126.22184445407;31133.68866311308;31140.844295779283;31207.375852482368;27438.862805685843;27837.304067398476;27929.301767455978;28005.299867503476;29585.852070739507;20408.89795551072;23105.422364441023;23174.304770856903;23201.88399057994;23221.651675224548 14:08:41 INFO - PID 23139 | |2;jquery.html;411.15712788782986;423.79456146475803;423.90674051708635;445.8149867804861;448.737488569187;17432.215550300236;18081.36715214966;18097.457076287716;19673.70489442656;20463.079161437734;20066.698999515018;20503.384898453034;20514.794852051476;20526.589468210626;20536.691949620767;5673.602847800656;5799.884002319951;5800.767969281244;5802.39074897136;5812.622179558315;5676.886462270752;5693.259876216107;5713.428657134295;5723.9141412878635;5748.913766293509;5283.154695248761;5502;5686.346070201938;5706.201131841545;5732.770689172428;5541.33503979521;5567.4432556744405;5581.302337207849;5583.553315734732;5583.916241256385;5054.823081192178;5055.6713813602;5071.518205770446;5072.264521644378;5082.618803589746;24102.397440063964;24251.514969700507;24268.757312427002;24389;24572.262832115066;1662.0941586835204;1682.8401301876302;1684.9241784119745;1690.408357075014;1696.957576060596;15329.310181041768;15596;16055.956362836378;16121.83878161215;16144.112073836051;2059.06312627754;2081.5628717969244;2106.083853523722;2106.1049054152077;2144.5282037951783;102088;104459;109304.4534777329;109609;110282.44858775735;11194.832077518844;11211.524427427361;11478.770424591461;11553.13351498641;11861.881381186078;15412.537623871302;15464.613384665248;15481.612959675873;15482.612934676723;15502.457413990682;7554.508956917783;7618.69525218985;7891.210878912178;8171.346292296602;8189.918100819034;7560.924390756132;7598.620068996528;7657.157712651604;7762.7671169865;7772.183920688246;7484.32641062307;7493.962530187423;7518.135414427302;7604.80987975294;7631.656575454007;2062.669972804344;2073.782252863458;2098.9055492502875;2131.1049359269145;2234.664800279971;829.2371018662844;847.7541512961295;873.6068769053951;886.7472770260445;887.7558671365426;17841.821581784276;17946.641067178844;18066.45800625957;18445.7233141503;18645.440636780917;858.6393714639867;873.6592728835759;876.6756300168978;884.2218847414234;900.5137225897942;9653;9809;9965.202783777426;10094.747631309276;10169.593216271267;332882;335412;338237;338257;339264;79733;81831.18168818354;81868;82395.5880220595;83793.58103209444;906.4425378392241;1035.342557476008;1070.844727514506;1071.6784964510616;1071.6999240212754;18048.278068877622;18312.084395780425;18477.445676629723;18878.716819248;18938.242470301586;42773.14453710971;42960.57039429565;42973;43015;43492.56507434885;52899.73550132225;53210;53387.46612533825;53738.19392709191;54227.72886135544;9682.467464289532;9824.65613703517;9831.705048848546;9846.507674616383;9855.408675479493;14729.631759206106;15533.922330388275;15757;15780.447684330993;15834.524964251092;13118.672033199246;13496.190228586316;13503.189808611514;13561.45754169822;13562.864371356554;11809.291442513477;12137.69655758613;12186.756264874475;12287.631371058882;12528.185667931555;13886.09740366873;14251.857481425468;14699.485518006819;14963.952523323263;14965.92517037408;9594.808103838024;9645.131938125602;9647;9722.659706910224;9781.657641982496;14012.43950241979;14069.648258793612;14174.220417877115;14207.502737404555;14252.643683907985 14:08:41 INFO - PID 23139 | |3;mootools.html;1230.2802860326708;1293.6571808470758;1294.9546765863186;1305.4973835073495;1311.7704401729698;10207.489625518721;10635.52140153693;10644.840327395086;10825.404602746847;11141.108711303097;11234.550617975292;11400.657980260605;11408.600698975537;11420.371879546621;11430.54277828888;2211.8562293450914;2252.628316327804;2255.9436014099615;2256.751757306695;2257.221258665758;2123.57528494301;2156.55790562935;2161.049138379116;2164.545445456456;2167.9891600541973;2081.1155259014936;2107.6627739561673;2109.24067335759;2128.5423633918704;2129.190907455165;1849.6670599292122;1856.9535761605932;1858.0523932794238;1862.37610400516;1868.6729822281181;1993.2326054468988;2021.4036859126593;2088.185607613032;2101.4746313421647;2106.24175296893;10666.573337066508;10756.300840445347;10756.762972258211;10761.354318740901;10762.246642735012;5437.374701909292;5654.717264136818;5655.943440565583;5666.829995100154;5677.40387259336;3351.145457908242;3360.092774950774;3400.863965441379;3418.572678415198;3516.1912760065075;1145.307089211032;1162.203890335123;1174.0666170394557;1190.3096204201543;1190.3928996211907;15121.243937803067;15279.541613751606;15279.770803437958;16249.512514624581;16753.07858067818;5046.848594542096;5075.756439672304;5189.247559103985;5228.9738551307;5251.2123181523075;11812.291262524275;11843.703907402383;11853.822192667118;11858.110641701907;11862;5758.309002919593;5835.124731290255;5843.298804143445;5843.707814609253;5858.150568167592;5355.732213389315;5406;5408.188771684278;5413.891722165535;5472.616916815785;4145.689073319513;4151.379064056308;4157.858702768077;4187.769672668032;4200.789960501963;1205.9819102713466;1221.780079585683;1226.3255209634665;1231.9938400307942;1244.2223610243598;667.7796327212009;689.6138162628844;689.8034060292792;707.3881092854747;712.5190496414899;5226.372835259793;5364;5397.190421436738;5542.445755424506;5559.33288005442;558.9273394458694;560.548758249613;572.8195618380197;573.1259828761089;586.7213073789916;3268.950965735516;3418.4872269159823;3442.242706604543;3592.2995015972156;3630.9636903631153;13989.510367137102;14584.416623334948;14589;14662.193579353025;14663;14135.575932722035;14409.92795036039;14415;14442.422303107758;14445.638859028608;7612.8477430451085;7614.96192519045;7636.930829683849;7877.881831772528;7883.645235964395;6176.227971503562;6222.315545290105;6272.341404152498;6385.521085918482;6634.933650663625;12827.102102853083;13000.544980925622;13490.190588564717;13498.122622029538;13538.120022198525;13246.139000964906;13261.07172497916;13286.269255191057;13410.12834165776;13543.86456135426;8337.124601916954;8547.658093676184;8549;8553.529555874487;8578.613962371834;10168.135708464863;10254.179665626882;10295.794084118426;10299.845502317321;10318.896811031793;7975.282224599814;8132.105468398589;8270.131636178356;8453.112423195476;8482.660693572188;8105.4731442458415;8143.18568143181;8199.42604017713;8212.548309842778;8225.300849427626;7461.179270280373;7614.657340419583;7619;7623.352015078559;7629.2752188542;5105.591552675703;5175.767090480862;5257.4753321537855;5364.946350536445;5418.07892658257;4925.1627223372825;5189.844304670866;5257.5005374489365;5260.263563101093;5336.0661884170895 14:08:41 INFO - PID 23139 | |4;prototype.html;356.6968077134438;359.90282623691587;388.53764020815225;394.9506311711036;402.26988016749607;5571.247881535992;5575.303087114111;5627.465390787874;5661;5687.601867869251;5484.698341591211;5518.834434966948;5565.6104072714925;5567.49892509674;5606.505105228175;4114.531281231267;4206.8737937861915;4219.13507730916;4220.978895105528;4224.471941007374;4227.936580951288;4245.150969806051;4248.044190057228;4253.766042867641;4257.106007738379;4197.454330936974;4202.474690663667;4207.621314081732;4218.6203241708245;4226.281532139528;4205.453291072172;4210.052738133926;4217.894552636178;4219.050713589449;4252.851150209759;3719.3119272934596;3737.8320574066975;3738.065483629093;3742.288965096623;3747.4940882980723;5519.613627046108;5520.171974203861;5524.254225679522;5534.778608855641;5535.723213839292;4998.550130488274;5003.274525193863;5011.649184557083;5016.874578135539;5020.347354843883;5900.97049514754;5926.703664816742;5951.768086967387;5955.106733989893;5955.910661340084;4187.246295666779;4192.350185721218;4209.137126888981;4210.494740631113;4213.6839737019845;5989.13157592151;6222.81331560054;6304.338044505307;6402.743890244385;6410.647414392207;4180.456540649696;4226.957730422718;4240.286216821237;4277.636400905958;4296.3125899856495;4316.503602085738;4347.5652434756275;4365.170617582649;4377.343398490252;4378.620734468632;4816.157172494799;4948.628852836052;4950.900981980412;4955.0337684151245;4961.90076198474;5921.407859214044;5928.628548580516;5938.910916336172;5940.8811823764145;5961.4038596140035;1491.5823569400586;1505.3301280929882;1507.2991059157325;1507.7889095526634;1511.5389806109242;998.4358837256926;998.4907697074544;1022.846573014039;1027.7430642339416;1030.6959446963165;5104.438511763703;5120.436751957282;5121.28436973618;5139.563137133386;5169.65588946869;6138.263408391022;6139.053254437895;6139.938600614026;6144.754209831646;6171.352008039181;5132;5132.46109158533;5136;5142.074426603247;5153;3257.332246889382;3282.8194449305515;3292.703656670911;3296.752743544244;3298.8185649789493;5701.828945131652;5704.686242256716;5705.600607957404;5780;5784.971075144597;6302.590331628521;6350.618962862243;6366.427021568081;6376.840578985562;6395.232572091379;5707.1153971134545;5737.3115226172295;5737.88524229513;5758.3090029196765;5758.942410576008;6101;6125.387461253839;6147.72335244924;6162.599431036968;6212.316645168938;6045.274567051982;6057.42454466825;6083.8174854754425;6092.390760923872;6106.3588323227195;5411.675299482044;5712.7717540728945;5734.881698068836;5753.884922301614;5754.625949313281;4306.4832220133785;4319.07139964909;4325.307950727868;4326;4329.437173167594;6198;6201.875962480815;6213;6225.750969961332;6245.406686364788;5840.2991641003355;5973.193618861398;5978.611390259619;6000.189974353581;6040.728167232397;5917.112433135064;5927.644341339534;5952.345242023461;5978.970105149447;5981.983062879234;5830.4461076197695;5863.325717542537;5875.089361149029;5902;5915.142304365929;5985.910211346921;5989.910151347821;5995.100734889801;6012.759489620541;6024.216851809237;5851.683371241436;5868.4424979626865;5870.354261031198;5872.324682661549;5897.144913987534 14:08:41 INFO - PID 23139 | |5;yui.html;741.3513175971025;750.182301291592;757.6249756370601;769.6075001749107;785.2500861677099;13359.131656442325;13494;13796.655083622902;14951.102933823964;14981.400743970242;15558.144302063381;16026.83973160268;16029.519114426557;16036.198190090507;16046.43837465689;848.9023762267341;860.2386887604483;862.8964524257098;864.6066039951838;867.2195024477958;632.8702615963716;641.1952998986266;877.350760437275;910.7586489580233;916.8212198621271;928.6007016982695;939.8825146856643;940.0411580188204;940.4545363689078;942.0626476655738;933.5332333833084;934.3833070173687;935.2517985611483;937.343859298487;937.6905621145006;693.0609024771463;695.0339028750042;695.3880585085143;695.8851789454734;696.7839969609437;14835.554933352018;14893.925530372388;15281;15281.541553753294;15337.769933451007;16031.679366412724;16461.25924333396;16506.917465412596;16525.66948661032;16599.41902033423;12449;12971.156874803202;13064.86935130646;13074.86925130746;13092.47630094795;2931.589577459157;2940.867660955262;2950.6754257031707;2954.5863579098946;2954.8670309836107;75581.62209188975;75711.62144189299;76210;76353.61823190904;76640.23359766387;10301.587936482607;10311.535980880879;10453.895461045293;10494.790104197873;10539.314944528582;16464.341426343053;16478.505644830675;16550.33798648065;16824.242909068875;16829.326826926786;6113.969430152821;6157.630542167395;6164.198654174928;6175.814725558241;6185.721642526097;2937.3390987027747;3001.714837090473;3003.564483149931;3010.819350838957;3014.9246268843017;3596.5324507813816;4116.650084742831;4374.4094547236355;4393.956060439418;4421.911561768747;779.1935346915915;793.2266040610474;804.6982381606897;804.9959750201211;807.3944541593804;497.3261231031972;509.1065180608009;514.9845504634867;520.5835331734597;521.2415934814911;10509.894901050891;10643.201759867887;10881.455927203766;10934.671959841218;11353.26203796767;617.1514168018974;624.8031869960947;626.6584711332334;631.26457676806;632.0487666062638;4926.4088309403105;4978.77595508203;5010.148274793294;5061.5950723942;5244.213367994755;71492.28507714857;74174.25825741673;75973.24026759662;87630.56184719162;89217;62450.37549624537;63936.36063639397;65122.348776512576;65922.67038664776;67189;58609.70695146497;59100.40899590949;63488.04767928485;63931.680341597996;64076.359236407974;9971.40171589678;10374.896251037695;10690.305130166515;10767.569297228336;10829.241953063525;27388.315292117855;27710;28042.85978570094;28495.43009139764;29195.708042919297;49547.752261238464;52363.73818130885;52578.47421525889;53160.20259696185;53910.730446347516;14762;14764.926175369055;15184.772228416361;15312.846871531588;15552.30014649321;16106.838931611002;16288.267027983533;16406.425775097814;17096.57258568546;17130.571735706708;15537.766933496232;15693.764593531334;15788.368465261721;15837;16084.758728619314;13799.03406761517;14695;14736.852631473548;14794.852051479347;14860.331285091981;13930.58208253754;14323.427062917366;14397.064190827563;14405.42378304856;14629.487967921497;9425.38734982224;9491.715248542554;9767.316287859781;9836.262280329147;10165.237607179342;10994;12160.695982600506;12829.743405132032;12862.228266304051;12867.613971580868 14:08:41 INFO - PID 23139 | __end_tp_report 14:08:41 INFO - PID 23139 | __start_cc_report 14:08:41 INFO - PID 23139 | _x_x_mozilla_cycle_collect,382 14:08:41 INFO - PID 23139 | __end_cc_report 14:08:41 INFO - PID 23139 | __startTimestamp1496178521031__endTimestamp 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | ------- Summary: start ------- 14:08:41 INFO - PID 23139 | Number of tests: 6 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#0] dojo.html Cycles:165 Average:5285.46 Median:5434.81 stddev:639.22 (11.8%) stddev-sans-first:608.82 14:08:41 INFO - PID 23139 | Values: 2725.9 2744.8 2755.7 2787.6 2787.7 5295.6 5358.7 5369.7 5388.6 5434.8 5284.8 5354.4 5376.1 5381.9 5432.9 4657.8 4709.1 4724.9 4747.7 4787.9 4770.7 4783.8 4785.5 4792.2 4830.9 4695.7 4734.2 4734.8 4741.1 4745.3 4718.2 4745.4 4768.0 4788.0 4791.9 4686.9 4708.1 4708.3 4713.2 4722.3 5185.1 5319.9 5327.8 5333.6 5360.0 5708.3 5711.8 5753.6 5758.9 5794.7 5858.5 5859.0 5864.4 5868.5 5906.6 5412.1 5412.8 5413.8 5424.9 5427.9 5827.1 5885.5 5931.4 5942.3 5999.9 5739.4 5751.1 5763.8 5772.7 5800.2 5704.9 5812.7 5817.9 5823.4 5835.6 5654.9 5723.0 5766.3 5796.3 5797.7 5709.3 5726.3 5767.1 5783.5 5820.2 4830.7 4835.3 4844.0 4870.9 4872.6 4134.4 4148.3 4154.0 4167.6 4204.3 4790.2 4811.2 4817.7 4885.7 4895.9 5831.9 5848.5 5851.3 5899.5 5916.7 4862.4 4863.1 4870.9 4882.5 4921.6 5049.5 5117.7 5118.3 5138.6 5152.6 5205.9 5210.1 5245.8 5263.6 5264.8 5683.8 5750.8 5771.9 5774.5 5880.7 5296.4 5431.2 5435.5 5449.3 5462.9 5622.9 5751.8 5772.8 5781.8 5785.6 5776.9 5806.3 5832.8 5877.2 5923.1 5648.7 5700.0 5705.9 5706.4 5728.4 5635.3 5679.8 5684.4 5688.1 5688.9 5458.4 5551.9 5586.9 5601.4 5627.1 5633.6 5644.6 5714.5 5730.7 5737.0 5403.0 5533.4 5543.5 5546.8 5551.5 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#1] ext.html Cycles:180 Average:30298.61 Median:3104.45 stddev:39838.95 (1283.3%) stddev-sans-first:39888.52 14:08:41 INFO - PID 23139 | Values: 654.8 718.5 737.5 1087.7 1110.5 33708.7 34533.3 34566.3 34592.8 34623.7 36197.6 36540.8 36588.6 36638.5 36696.1 6661.8 6861.3 6995.2 7156.9 7158.7 6869.3 6991.6 7006.2 7007.8 7014.2 6970.5 7021.3 7024.4 7026.6 7040.5 6989.5 6990.3 7006.3 7008.1 7014.9 6791.9 6825.8 6831.1 6833.0 6839.5 32400.4 32625.5 32702.7 32709.5 32833.3 3108.0 3117.5 3138.5 3138.7 3140.0 24928.1 25052.4 25128.0 25161.0 25222.1 3055.8 3100.9 3111.3 3135.1 3135.7 128754.0 130516.3 135856.0 146815.0 146884.0 39800.6 39899.6 39932.8 39939.8 39985.0 42188.0 42267.4 42341.0 42411.0 42448.8 12854.4 12987.8 12997.2 13000.5 13023.3 10328.8 10383.9 10387.4 10390.5 10410.6 13010.7 13020.3 13061.6 13164.2 13291.0 5224.5 5298.0 5363.7 5388.4 5391.9 837.3 893.1 898.4 916.1 920.9 20991.2 21589.8 21694.7 21792.7 22065.2 974.1 982.5 986.5 1004.5 1005.0 11049.7 11511.8 11534.9 11561.4 11570.1 172369.0 173436.0 173597.0 173731.0 174129.0 42268.0 42620.4 42704.4 42708.1 42717.8 1212.1 1231.1 1234.4 1236.2 1242.5 19708.5 19842.5 20700.6 21258.9 21524.1 30537.7 30549.4 30595.5 30599.5 30699.0 149618.0 149895.0 150168.0 150265.0 150379.0 29814.3 29814.7 29946.7 30455.5 30652.7 36515.6 36658.0 36707.8 36710.3 36721.4 26517.9 28064.7 28347.4 28559.4 28964.9 26910.5 27644.9 28313.6 28665.9 28686.9 31107.2 31126.2 31133.7 31140.8 31207.4 27438.9 27837.3 27929.3 28005.3 29585.9 20408.9 23105.4 23174.3 23201.9 23221.7 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#2] jquery.html Cycles:180 Average:25683.92 Median:178727.13 stddev:57141.90 (32.0%) stddev-sans-first:57270.69 14:08:41 INFO - PID 23139 | Values: 411.2 423.8 423.9 445.8 448.7 17432.2 18081.4 18097.5 19673.7 20463.1 20066.7 20503.4 20514.8 20526.6 20536.7 5673.6 5799.9 5800.8 5802.4 5812.6 5676.9 5693.3 5713.4 5723.9 5748.9 5283.2 5502.0 5686.3 5706.2 5732.8 5541.3 5567.4 5581.3 5583.6 5583.9 5054.8 5055.7 5071.5 5072.3 5082.6 24102.4 24251.5 24268.8 24389.0 24572.3 1662.1 1682.8 1684.9 1690.4 1697.0 15329.3 15596.0 16056.0 16121.8 16144.1 2059.1 2081.6 2106.1 2106.1 2144.5 102088.0 104459.0 109304.5 109609.0 110282.4 11194.8 11211.5 11478.8 11553.1 11861.9 15412.5 15464.6 15481.6 15482.6 15502.5 7554.5 7618.7 7891.2 8171.3 8189.9 7560.9 7598.6 7657.2 7762.8 7772.2 7484.3 7494.0 7518.1 7604.8 7631.7 2062.7 2073.8 2098.9 2131.1 2234.7 829.2 847.8 873.6 886.7 887.8 17841.8 17946.6 18066.5 18445.7 18645.4 858.6 873.7 876.7 884.2 900.5 9653.0 9809.0 9965.2 10094.7 10169.6 332882.0 335412.0 338237.0 338257.0 339264.0 79733.0 81831.2 81868.0 82395.6 83793.6 906.4 1035.3 1070.8 1071.7 1071.7 18048.3 18312.1 18477.4 18878.7 18938.2 42773.1 42960.6 42973.0 43015.0 43492.6 52899.7 53210.0 53387.5 53738.2 54227.7 9682.5 9824.7 9831.7 9846.5 9855.4 14729.6 15533.9 15757.0 15780.4 15834.5 13118.7 13496.2 13503.2 13561.5 13562.9 11809.3 12137.7 12186.8 12287.6 12528.2 13886.1 14251.9 14699.5 14964.0 14965.9 9594.8 9645.1 9647.0 9722.7 9781.7 14012.4 14069.6 14174.2 14207.5 14252.6 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#3] mootools.html Cycles:180 Average:6585.51 Median:3310.05 stddev:4427.87 (133.8%) stddev-sans-first:4422.01 14:08:41 INFO - PID 23139 | Values: 1230.3 1293.7 1295.0 1305.5 1311.8 10207.5 10635.5 10644.8 10825.4 11141.1 11234.6 11400.7 11408.6 11420.4 11430.5 2211.9 2252.6 2255.9 2256.8 2257.2 2123.6 2156.6 2161.0 2164.5 2168.0 2081.1 2107.7 2109.2 2128.5 2129.2 1849.7 1857.0 1858.1 1862.4 1868.7 1993.2 2021.4 2088.2 2101.5 2106.2 10666.6 10756.3 10756.8 10761.4 10762.2 5437.4 5654.7 5655.9 5666.8 5677.4 3351.1 3360.1 3400.9 3418.6 3516.2 1145.3 1162.2 1174.1 1190.3 1190.4 15121.2 15279.5 15279.8 16249.5 16753.1 5046.8 5075.8 5189.2 5229.0 5251.2 11812.3 11843.7 11853.8 11858.1 11862.0 5758.3 5835.1 5843.3 5843.7 5858.2 5355.7 5406.0 5408.2 5413.9 5472.6 4145.7 4151.4 4157.9 4187.8 4200.8 1206.0 1221.8 1226.3 1232.0 1244.2 667.8 689.6 689.8 707.4 712.5 5226.4 5364.0 5397.2 5542.4 5559.3 558.9 560.5 572.8 573.1 586.7 3269.0 3418.5 3442.2 3592.3 3631.0 13989.5 14584.4 14589.0 14662.2 14663.0 14135.6 14409.9 14415.0 14442.4 14445.6 7612.8 7615.0 7636.9 7877.9 7883.6 6176.2 6222.3 6272.3 6385.5 6634.9 12827.1 13000.5 13490.2 13498.1 13538.1 13246.1 13261.1 13286.3 13410.1 13543.9 8337.1 8547.7 8549.0 8553.5 8578.6 10168.1 10254.2 10295.8 10299.8 10318.9 7975.3 8132.1 8270.1 8453.1 8482.7 8105.5 8143.2 8199.4 8212.5 8225.3 7461.2 7614.7 7619.0 7623.4 7629.3 5105.6 5175.8 5257.5 5364.9 5418.1 4925.2 5189.8 5257.5 5260.3 5336.1 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#4] prototype.html Cycles:180 Average:4909.43 Median:5550.67 stddev:1453.88 (26.2%) stddev-sans-first:1417.23 14:08:41 INFO - PID 23139 | Values: 356.7 359.9 388.5 395.0 402.3 5571.2 5575.3 5627.5 5661.0 5687.6 5484.7 5518.8 5565.6 5567.5 5606.5 4114.5 4206.9 4219.1 4221.0 4224.5 4227.9 4245.2 4248.0 4253.8 4257.1 4197.5 4202.5 4207.6 4218.6 4226.3 4205.5 4210.1 4217.9 4219.1 4252.9 3719.3 3737.8 3738.1 3742.3 3747.5 5519.6 5520.2 5524.3 5534.8 5535.7 4998.6 5003.3 5011.6 5016.9 5020.3 5901.0 5926.7 5951.8 5955.1 5955.9 4187.2 4192.4 4209.1 4210.5 4213.7 5989.1 6222.8 6304.3 6402.7 6410.6 4180.5 4227.0 4240.3 4277.6 4296.3 4316.5 4347.6 4365.2 4377.3 4378.6 4816.2 4948.6 4950.9 4955.0 4961.9 5921.4 5928.6 5938.9 5940.9 5961.4 1491.6 1505.3 1507.3 1507.8 1511.5 998.4 998.5 1022.8 1027.7 1030.7 5104.4 5120.4 5121.3 5139.6 5169.7 6138.3 6139.1 6139.9 6144.8 6171.4 5132.0 5132.5 5136.0 5142.1 5153.0 3257.3 3282.8 3292.7 3296.8 3298.8 5701.8 5704.7 5705.6 5780.0 5785.0 6302.6 6350.6 6366.4 6376.8 6395.2 5707.1 5737.3 5737.9 5758.3 5758.9 6101.0 6125.4 6147.7 6162.6 6212.3 6045.3 6057.4 6083.8 6092.4 6106.4 5411.7 5712.8 5734.9 5753.9 5754.6 4306.5 4319.1 4325.3 4326.0 4329.4 6198.0 6201.9 6213.0 6225.8 6245.4 5840.3 5973.2 5978.6 6000.2 6040.7 5917.1 5927.6 5952.3 5979.0 5982.0 5830.4 5863.3 5875.1 5902.0 5915.1 5985.9 5989.9 5995.1 6012.8 6024.2 5851.7 5868.4 5870.4 5872.3 5897.1 14:08:41 INFO - PID 23139 | 14:08:41 INFO - PID 23139 | [#5] yui.html Cycles:180 Average:17021.41 Median:3856.59 stddev:21536.23 (558.4%) stddev-sans-first:21561.94 14:08:41 INFO - PID 23139 | Values: 741.4 750.2 757.6 769.6 785.3 13359.1 13494.0 13796.7 14951.1 14981.4 15558.1 16026.8 16029.5 16036.2 16046.4 848.9 860.2 862.9 864.6 867.2 632.9 641.2 877.4 910.8 916.8 928.6 939.9 940.0 940.5 942.1 933.5 934.4 935.3 937.3 937.7 693.1 695.0 695.4 695.9 696.8 14835.6 14893.9 15281.0 15281.5 15337.8 16031.7 16461.3 16506.9 16525.7 16599.4 12449.0 12971.2 13064.9 13074.9 13092.5 2931.6 2940.9 2950.7 2954.6 2954.9 75581.6 75711.6 76210.0 76353.6 76640.2 10301.6 10311.5 10453.9 10494.8 10539.3 16464.3 16478.5 16550.3 16824.2 16829.3 6114.0 6157.6 6164.2 6175.8 6185.7 2937.3 3001.7 3003.6 3010.8 3014.9 3596.5 4116.7 4374.4 4394.0 4421.9 779.2 793.2 804.7 805.0 807.4 497.3 509.1 515.0 520.6 521.2 10509.9 10643.2 10881.5 10934.7 11353.3 617.2 624.8 626.7 631.3 632.0 4926.4 4978.8 5010.1 5061.6 5244.2 71492.3 74174.3 75973.2 87630.6 89217.0 62450.4 63936.4 65122.3 65922.7 67189.0 58609.7 59100.4 63488.0 63931.7 64076.4 9971.4 10374.9 10690.3 10767.6 10829.2 27388.3 27710.0 28042.9 28495.4 29195.7 49547.8 52363.7 52578.5 53160.2 53910.7 14762.0 14764.9 15184.8 15312.8 15552.3 16106.8 16288.3 16406.4 17096.6 17130.6 15537.8 15693.8 15788.4 15837.0 16084.8 13799.0 14695.0 14736.9 14794.9 14860.3 13930.6 14323.4 14397.1 14405.4 14629.5 9425.4 9491.7 9767.3 9836.3 10165.2 10994.0 12160.7 12829.7 12862.2 12867.6 14:08:41 INFO - PID 23139 | -------- Summary: end -------- 14:08:41 INFO - PID 23139 | 14:08:41 INFO - TEST-INFO | 23139: exit 0 14:08:41 INFO - TEST-OK | dromaeo_css | took 1147557ms 14:08:41 INFO - TEST-START | kraken 14:08:41 INFO - operating with platform_type : linux_ 14:08:41 INFO - Initialising browser for kraken test... 14:08:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44618/getInfo.html -profile /tmp/tmpW8FGRr/profile 14:08:41 INFO - TEST-INFO | started process 23544 (/builds/slave/test/build/application/firefox/firefox http://localhost:44618/getInfo.html) 14:09:16 INFO - TEST-INFO | 23544: killed by SIGTERM 14:09:17 INFO - Browser initialized. 14:09:17 INFO - Running cycle 1/1 for kraken test... 14:09:17 INFO - TEST-INFO | started process 23742 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW8FGRr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:29 INFO - PID 23742 | RSS: Main: 182116352 14:09:29 INFO - PID 23742 | 14:09:31 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44618/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:32 INFO - PID 23742 | RSS: Main: 185974784 14:09:32 INFO - PID 23742 | 14:09:35 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44618/tests/kraken/driver.html?testName=audio-dft) 14:09:36 INFO - PID 23742 | RSS: Main: 184623104 14:09:36 INFO - PID 23742 | 14:09:39 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44618/tests/kraken/driver.html?testName=audio-fft) 14:09:39 INFO - PID 23742 | RSS: Main: 181116928 14:09:39 INFO - PID 23742 | 14:09:41 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44618/tests/kraken/driver.html?testName=audio-oscillator) 14:09:42 INFO - PID 23742 | RSS: Main: 181575680 14:09:42 INFO - PID 23742 | 14:09:44 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44618/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:45 INFO - PID 23742 | RSS: Main: 181805056 14:09:45 INFO - PID 23742 | 14:09:48 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44618/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:48 INFO - PID 23742 | RSS: Main: 183070720 14:09:48 INFO - PID 23742 | 14:09:52 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44618/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:53 INFO - PID 23742 | RSS: Main: 181907456 14:09:53 INFO - PID 23742 | 14:09:55 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44618/tests/kraken/driver.html?testName=json-parse-financial) 14:09:56 INFO - PID 23742 | RSS: Main: 182759424 14:09:56 INFO - PID 23742 | 14:09:58 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44618/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:58 INFO - PID 23742 | RSS: Main: 182788096 14:09:58 INFO - PID 23742 | 14:10:00 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:10:01 INFO - PID 23742 | RSS: Main: 182583296 14:10:01 INFO - PID 23742 | 14:10:03 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:10:04 INFO - PID 23742 | RSS: Main: 182644736 14:10:04 INFO - PID 23742 | 14:10:06 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:10:07 INFO - PID 23742 | RSS: Main: 182927360 14:10:07 INFO - PID 23742 | 14:10:10 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:10:11 INFO - PID 23742 | RSS: Main: 182644736 14:10:11 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | Cycle 1(1): loaded http://localhost:44618/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44618/tests/kraken/driver.html?testName=ai-astar) 14:10:13 INFO - PID 23742 | RSS: Main: 184205312 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | __start_tp_report 14:10:13 INFO - PID 23742 | _x_x_mozilla_page_load 14:10:13 INFO - PID 23742 | _x_x_mozilla_page_load_details 14:10:13 INFO - PID 23742 | |i|pagename|runs| 14:10:13 INFO - PID 23742 | |0;ai-astar;102;110;110;109;109;114;110;112;112;112 14:10:13 INFO - PID 23742 | |1;audio-beat-detection;148;124;125;169;126;122;122;122;152;123 14:10:13 INFO - PID 23742 | |2;audio-dft;162;166;164;165;169;169;170;165;163;160 14:10:13 INFO - PID 23742 | |3;audio-fft;74;77;72;110;76;75;75;76;92;73 14:10:13 INFO - PID 23742 | |4;audio-oscillator;85;83;105;84;86;86;99;84;84;108 14:10:13 INFO - PID 23742 | |5;imaging-gaussian-blur;114;115;115;114;114;114;114;114;114;114 14:10:13 INFO - PID 23742 | |6;imaging-darkroom;151;150;151;152;151;151;151;149;150;150 14:10:13 INFO - PID 23742 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;94;95 14:10:13 INFO - PID 23742 | |8;json-parse-financial;55;55;55;55;56;55;59;56;57;57 14:10:13 INFO - PID 23742 | |9;json-stringify-tinderbox;58;58;57;58;58;58;59;59;58;60 14:10:13 INFO - PID 23742 | |10;stanford-crypto-aes;87;88;87;87;88;96;87;88;126;86 14:10:13 INFO - PID 23742 | |11;stanford-crypto-ccm;137;131;136;135;132;130;140;134;137;139 14:10:13 INFO - PID 23742 | |12;stanford-crypto-pbkdf2;183;199;185;195;212;191;192;192;193;191 14:10:13 INFO - PID 23742 | |13;stanford-crypto-sha256-iterative;76;73;73;71;74;75;73;72;71;73 14:10:13 INFO - PID 23742 | __end_tp_report 14:10:13 INFO - PID 23742 | __start_cc_report 14:10:13 INFO - PID 23742 | _x_x_mozilla_cycle_collect,993 14:10:13 INFO - PID 23742 | __end_cc_report 14:10:13 INFO - PID 23742 | __startTimestamp1496178613407__endTimestamp 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | ------- Summary: start ------- 14:10:13 INFO - PID 23742 | Number of tests: 14 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:3.23 (2.9%) stddev-sans-first:1.69 14:10:13 INFO - PID 23742 | Values: 102.0 110.0 110.0 109.0 109.0 114.0 110.0 112.0 112.0 112.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:125.50 stddev:16.79 (13.4%) stddev-sans-first:16.95 14:10:13 INFO - PID 23742 | Values: 148.0 124.0 125.0 169.0 126.0 122.0 122.0 122.0 152.0 123.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:3.27 (2.0%) stddev-sans-first:3.24 14:10:13 INFO - PID 23742 | Values: 162.0 166.0 164.0 165.0 169.0 169.0 170.0 165.0 163.0 160.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.50 stddev:11.94 (15.8%) stddev-sans-first:12.47 14:10:13 INFO - PID 23742 | Values: 74.0 77.0 72.0 110.0 76.0 75.0 75.0 76.0 92.0 73.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:84.50 stddev:9.67 (11.4%) stddev-sans-first:10.06 14:10:13 INFO - PID 23742 | Values: 85.0 83.0 105.0 84.0 86.0 86.0 99.0 84.0 84.0 108.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:10:13 INFO - PID 23742 | Values: 114.0 115.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 14:10:13 INFO - PID 23742 | Values: 151.0 150.0 151.0 152.0 151.0 151.0 151.0 149.0 150.0 150.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:10:13 INFO - PID 23742 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.33 (2.4%) stddev-sans-first:1.36 14:10:13 INFO - PID 23742 | Values: 55.0 55.0 55.0 55.0 56.0 55.0 59.0 56.0 57.0 57.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 14:10:13 INFO - PID 23742 | Values: 58.0 58.0 57.0 58.0 58.0 58.0 59.0 59.0 58.0 60.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:87.50 stddev:12.27 (14.0%) stddev-sans-first:12.89 14:10:13 INFO - PID 23742 | Values: 87.0 88.0 87.0 87.0 88.0 96.0 87.0 88.0 126.0 86.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:136.50 stddev:3.35 (2.5%) stddev-sans-first:3.48 14:10:13 INFO - PID 23742 | Values: 137.0 131.0 136.0 135.0 132.0 130.0 140.0 134.0 137.0 139.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.30 Median:192.50 stddev:7.99 (4.1%) stddev-sans-first:7.55 14:10:13 INFO - PID 23742 | Values: 183.0 199.0 185.0 195.0 212.0 191.0 192.0 192.0 193.0 191.0 14:10:13 INFO - PID 23742 | 14:10:13 INFO - PID 23742 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.60 (2.2%) stddev-sans-first:1.30 14:10:13 INFO - PID 23742 | Values: 76.0 73.0 73.0 71.0 74.0 75.0 73.0 72.0 71.0 73.0 14:10:13 INFO - PID 23742 | -------- Summary: end -------- 14:10:13 INFO - PID 23742 | 14:10:14 INFO - TEST-INFO | 23742: exit 0 14:10:14 INFO - TEST-OK | kraken | took 92673ms 14:10:14 INFO - SUITE-END | took 1240s 14:10:15 INFO - Completed test suite (00:20:40) 14:10:15 INFO - javascript benchmark 14:10:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6943.583940615138, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2725.9045933392335, 2744.7804175665947, 2755.655543057118, 2787.553991361381, 2787.749102580768, 5295.576353891689, 5358.6516876403, 5369.731513424333, 5388.622796404248, 5434.809781657643, 5284.841454756353, 5354.41101478837, 5376.059189641816, 5381.946180538193, 5432.91850622241, 4657.790399432017, 4709.128811169936, 4724.858254252378, 4747.715137091785, 4787.8563643090765, 4770.7376094314795, 4783.784729687172, 4785.473597904228, 4792.209285467894, 4830.87922801931, 4695.694779839334, 4734.171519983989, 4734.763261836894, 4741.075490279397, 4745.2882067690125, 4718.150732868083, 4745.383100196987, 4767.976160119212, 4787.976060119712, 4791.856244312677, 4686.929696054562, 4708.128996135726, 4708.270218116198, 4713.175194340976, 4722.268048452495, 5185.066687996159, 5319.867003324909, 5327.786888524454, 5333.599980001515, 5359.954808812283, 5708.257926469574, 5711.8000869969765, 5753.626014309057, 5758.856028599276, 5794.652320860761, 5858.502027327682, 5858.970705146489, 5864.354920958691, 5868.501177399883, 5906.586538942276, 5412.052890744104, 5412.783488660488, 5413.756380962866, 5424.918626220609, 5427.891442171134, 5827.096799996008, 5885.47030767233, 5931.377205393372, 5942.316633587193, 5999.850003749942, 5739.368669446441, 5751.079827227623, 5763.827085187451, 5772.653640781483, 5800.245968024215, 5704.857378565486, 5812.709364531756, 5817.88364232713, 5823.417658234142, 5835.620684655484, 5654.943450565442, 5723.02708539541, 5766.250387449605, 5796.333421656479, 5797.739101740432, 5709.286339207599, 5726.255586773693, 5767.106098554731, 5783.508401785895, 5820.156077368758, 4830.686005409637, 4835.298881662139, 4844.0, 4870.902581948341, 4872.610191184696, 4134.441850350164, 4148.336266197454, 4154.044569748975, 4167.562405947392, 4204.306289462265, 4790.185668436374, 4811.182099043171, 4817.7350245736825, 4885.658003939761, 4895.877603059952, 5831.912521312183, 5848.473637372657, 5851.327097383855, 5899.528037756969, 5916.7337469813965, 4862.367892173995, 4863.051704917578, 4870.926936095891, 4882.462929077798, 4921.630877684116, 5049.495050494921, 5117.692938423706, 5118.283440318359, 5138.563222126087, 5152.562032227303, 5205.947940520547, 5210.140326846028, 5245.816396426107, 5263.578913686819, 5264.842054738364, 5683.829485115453, 5750.7987220447085, 5771.913421298768, 5774.538036957118, 5880.676562789087, 5296.41739408657, 5431.23962645222, 5435.483629055233, 5449.291592093003, 5462.863428414322, 5622.9156562652415, 5751.769929202785, 5772.826815195551, 5781.82654520365, 5785.56608254391, 5776.884462310646, 5806.303243610793, 5832.766689332379, 5877.206577112035, 5923.111533270044, 5648.689322087324, 5700.030994730989, 5705.914411283917, 5706.372299047019, 5728.4271572844045, 5635.267415235993, 5679.801206957736, 5684.431556844283, 5688.14677798317, 5688.914666280092, 5458.399576046711, 5551.861203469945, 5586.888262234814, 5601.383847776659, 5627.127795191752, 5633.577481688808, 5644.6330988485615, 5714.514266287412, 5730.656160630376, 5737.0, 5403.0, 5533.418991006048, 5543.52880005204, 5546.833594992157, 5551.472610102034], "value": 5237.776252509475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.8362909272682, 718.5042320798649, 737.5169264131993, 1087.7226307291635, 1110.4780753046066, 33708.662913370856, 34533.30933381334, 34566.30867382651, 34592.827035864786, 34623.65376346236, 36197.63802361976, 36540.81729591348, 36588.63411365885, 36638.45042324361, 36696.08259793506, 6661.766838160665, 6861.348171923659, 6995.160580730319, 7156.85686286274, 7158.677859496335, 6869.278725733801, 6991.61546114966, 7006.194287656908, 7007.7547285845, 7014.193367762721, 6970.546914450544, 7021.262767409425, 7024.4029257513175, 7026.6486675666265, 7040.47196460265, 6989.510734248604, 6990.266022067686, 7006.334398232185, 7008.053912721768, 7014.894776578355, 6791.864162716718, 6825.795226143224, 6831.11195544581, 6832.965835170842, 6839.521233513656, 32400.351992960008, 32625.51061734076, 32702.6729732702, 32709.509357359657, 32833.343333133445, 3107.9689203107905, 3117.454445472056, 3138.497840345534, 3138.717515423623, 3140.010896567574, 24928.12751553705, 25052.373690657696, 25128.0, 25161.0, 25222.117225897007, 3055.801372910776, 3100.937981240385, 3111.3466172103886, 3135.0751528299206, 3135.717785399325, 128754.0, 130516.3474182623, 135856.0, 146815.0, 146884.0, 39800.60199398027, 39899.60100399017, 39932.80033599814, 39939.80030099831, 39985.0, 42188.0, 42267.36598951018, 42341.0, 42411.0, 42448.78775606164, 12854.357282135856, 12987.805182922264, 12997.220166790023, 13000.544980925622, 13023.348832558335, 10328.793424131625, 10383.94808025955, 10387.37675739458, 10390.48047597617, 10410.583576657, 13010.739785204243, 13020.348982550835, 13061.608151755463, 13164.210147391188, 13291.0, 5224.529792318634, 5298.0, 5363.678179309254, 5388.380336261302, 5391.892162156735, 837.2841220756287, 893.1470445724318, 898.380117718772, 916.1296768070359, 920.8940971788196, 20991.16035358599, 21589.784102158777, 21694.674579881314, 21792.673109903364, 22065.22771703015, 974.1281553010016, 982.474376208725, 986.5363279258737, 1004.5128112865254, 1005.0452070533023, 11049.723756906142, 11511.769764604662, 11534.942325288488, 11561.42192890352, 11570.074394048455, 172369.0, 173436.0, 173597.0, 173731.0, 174129.0, 42268.0, 42620.3606945896, 42704.35943460851, 42708.14583708309, 42717.786411068366, 1212.0969877441362, 1231.1259006105586, 1234.3519652182677, 1236.1841184818156, 1242.5402601037674, 19708.50728731793, 19842.543300591875, 20700.58598828045, 21258.893705531373, 21524.139034438445, 30537.694623053485, 30549.389012220076, 30595.54106688357, 30599.54100688447, 30699.0, 149618.0, 149895.0, 150168.0, 150265.0, 150379.0, 29814.25464363408, 29814.701852981194, 29946.70053299439, 30455.543166852072, 30652.693473065876, 36515.63484365229, 36658.0, 36707.81646091752, 36710.26579468342, 36721.44917826288, 26517.867410662824, 28064.71935280621, 28347.43305133927, 28559.42881142407, 28964.855175723987, 26910.461790764468, 27644.86177569099, 28313.57529637016, 28665.856670716512, 28686.856565717037, 31107.22231944129, 31126.22184445407, 31133.68866311308, 31140.844295779283, 31207.375852482368, 27438.862805685843, 27837.304067398476, 27929.301767455978, 28005.299867503476, 29585.852070739507, 20408.89795551072, 23105.422364441023, 23174.304770856903, 23201.88399057994, 23221.651675224548], "value": 14681.152833332968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.15712788782986, 423.79456146475803, 423.90674051708635, 445.8149867804861, 448.737488569187, 17432.215550300236, 18081.36715214966, 18097.457076287716, 19673.70489442656, 20463.079161437734, 20066.698999515018, 20503.384898453034, 20514.794852051476, 20526.589468210626, 20536.691949620767, 5673.602847800656, 5799.884002319951, 5800.767969281244, 5802.39074897136, 5812.622179558315, 5676.886462270752, 5693.259876216107, 5713.428657134295, 5723.9141412878635, 5748.913766293509, 5283.154695248761, 5502.0, 5686.346070201938, 5706.201131841545, 5732.770689172428, 5541.33503979521, 5567.4432556744405, 5581.302337207849, 5583.553315734732, 5583.916241256385, 5054.823081192178, 5055.6713813602, 5071.518205770446, 5072.264521644378, 5082.618803589746, 24102.397440063964, 24251.514969700507, 24268.757312427002, 24389.0, 24572.262832115066, 1662.0941586835204, 1682.8401301876302, 1684.9241784119745, 1690.408357075014, 1696.957576060596, 15329.310181041768, 15596.0, 16055.956362836378, 16121.83878161215, 16144.112073836051, 2059.06312627754, 2081.5628717969244, 2106.083853523722, 2106.1049054152077, 2144.5282037951783, 102088.0, 104459.0, 109304.4534777329, 109609.0, 110282.44858775735, 11194.832077518844, 11211.524427427361, 11478.770424591461, 11553.13351498641, 11861.881381186078, 15412.537623871302, 15464.613384665248, 15481.612959675873, 15482.612934676723, 15502.457413990682, 7554.508956917783, 7618.69525218985, 7891.210878912178, 8171.346292296602, 8189.918100819034, 7560.924390756132, 7598.620068996528, 7657.157712651604, 7762.7671169865, 7772.183920688246, 7484.32641062307, 7493.962530187423, 7518.135414427302, 7604.80987975294, 7631.656575454007, 2062.669972804344, 2073.782252863458, 2098.9055492502875, 2131.1049359269145, 2234.664800279971, 829.2371018662844, 847.7541512961295, 873.6068769053951, 886.7472770260445, 887.7558671365426, 17841.821581784276, 17946.641067178844, 18066.45800625957, 18445.7233141503, 18645.440636780917, 858.6393714639867, 873.6592728835759, 876.6756300168978, 884.2218847414234, 900.5137225897942, 9653.0, 9809.0, 9965.202783777426, 10094.747631309276, 10169.593216271267, 332882.0, 335412.0, 338237.0, 338257.0, 339264.0, 79733.0, 81831.18168818354, 81868.0, 82395.5880220595, 83793.58103209444, 906.4425378392241, 1035.342557476008, 1070.844727514506, 1071.6784964510616, 1071.6999240212754, 18048.278068877622, 18312.084395780425, 18477.445676629723, 18878.716819248, 18938.242470301586, 42773.14453710971, 42960.57039429565, 42973.0, 43015.0, 43492.56507434885, 52899.73550132225, 53210.0, 53387.46612533825, 53738.19392709191, 54227.72886135544, 9682.467464289532, 9824.65613703517, 9831.705048848546, 9846.507674616383, 9855.408675479493, 14729.631759206106, 15533.922330388275, 15757.0, 15780.447684330993, 15834.524964251092, 13118.672033199246, 13496.190228586316, 13503.189808611514, 13561.45754169822, 13562.864371356554, 11809.291442513477, 12137.69655758613, 12186.756264874475, 12287.631371058882, 12528.185667931555, 13886.09740366873, 14251.857481425468, 14699.485518006819, 14963.952523323263, 14965.92517037408, 9594.808103838024, 9645.131938125602, 9647.0, 9722.659706910224, 9781.657641982496, 14012.43950241979, 14069.648258793612, 14174.220417877115, 14207.502737404555, 14252.643683907985], "value": 9533.76737571267, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.2802860326708, 1293.6571808470758, 1294.9546765863186, 1305.4973835073495, 1311.7704401729698, 10207.489625518721, 10635.52140153693, 10644.840327395086, 10825.404602746847, 11141.108711303097, 11234.550617975292, 11400.657980260605, 11408.600698975537, 11420.371879546621, 11430.54277828888, 2211.8562293450914, 2252.628316327804, 2255.9436014099615, 2256.751757306695, 2257.221258665758, 2123.57528494301, 2156.55790562935, 2161.049138379116, 2164.545445456456, 2167.9891600541973, 2081.1155259014936, 2107.6627739561673, 2109.24067335759, 2128.5423633918704, 2129.190907455165, 1849.6670599292122, 1856.9535761605932, 1858.0523932794238, 1862.37610400516, 1868.6729822281181, 1993.2326054468988, 2021.4036859126593, 2088.185607613032, 2101.4746313421647, 2106.24175296893, 10666.573337066508, 10756.300840445347, 10756.762972258211, 10761.354318740901, 10762.246642735012, 5437.374701909292, 5654.717264136818, 5655.943440565583, 5666.829995100154, 5677.40387259336, 3351.145457908242, 3360.092774950774, 3400.863965441379, 3418.572678415198, 3516.1912760065075, 1145.307089211032, 1162.203890335123, 1174.0666170394557, 1190.3096204201543, 1190.3928996211907, 15121.243937803067, 15279.541613751606, 15279.770803437958, 16249.512514624581, 16753.07858067818, 5046.848594542096, 5075.756439672304, 5189.247559103985, 5228.9738551307, 5251.2123181523075, 11812.291262524275, 11843.703907402383, 11853.822192667118, 11858.110641701907, 11862.0, 5758.309002919593, 5835.124731290255, 5843.298804143445, 5843.707814609253, 5858.150568167592, 5355.732213389315, 5406.0, 5408.188771684278, 5413.891722165535, 5472.616916815785, 4145.689073319513, 4151.379064056308, 4157.858702768077, 4187.769672668032, 4200.789960501963, 1205.9819102713466, 1221.780079585683, 1226.3255209634665, 1231.9938400307942, 1244.2223610243598, 667.7796327212009, 689.6138162628844, 689.8034060292792, 707.3881092854747, 712.5190496414899, 5226.372835259793, 5364.0, 5397.190421436738, 5542.445755424506, 5559.33288005442, 558.9273394458694, 560.548758249613, 572.8195618380197, 573.1259828761089, 586.7213073789916, 3268.950965735516, 3418.4872269159823, 3442.242706604543, 3592.2995015972156, 3630.9636903631153, 13989.510367137102, 14584.416623334948, 14589.0, 14662.193579353025, 14663.0, 14135.575932722035, 14409.92795036039, 14415.0, 14442.422303107758, 14445.638859028608, 7612.8477430451085, 7614.96192519045, 7636.930829683849, 7877.881831772528, 7883.645235964395, 6176.227971503562, 6222.315545290105, 6272.341404152498, 6385.521085918482, 6634.933650663625, 12827.102102853083, 13000.544980925622, 13490.190588564717, 13498.122622029538, 13538.120022198525, 13246.139000964906, 13261.07172497916, 13286.269255191057, 13410.12834165776, 13543.86456135426, 8337.124601916954, 8547.658093676184, 8549.0, 8553.529555874487, 8578.613962371834, 10168.135708464863, 10254.179665626882, 10295.794084118426, 10299.845502317321, 10318.896811031793, 7975.282224599814, 8132.105468398589, 8270.131636178356, 8453.112423195476, 8482.660693572188, 8105.4731442458415, 8143.18568143181, 8199.42604017713, 8212.548309842778, 8225.300849427626, 7461.179270280373, 7614.657340419583, 7619.0, 7623.352015078559, 7629.2752188542, 5105.591552675703, 5175.767090480862, 5257.4753321537855, 5364.946350536445, 5418.07892658257, 4925.1627223372825, 5189.844304670866, 5257.5005374489365, 5260.263563101093, 5336.0661884170895], "value": 4816.77003914409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6968077134438, 359.90282623691587, 388.53764020815225, 394.9506311711036, 402.26988016749607, 5571.247881535992, 5575.303087114111, 5627.465390787874, 5661.0, 5687.601867869251, 5484.698341591211, 5518.834434966948, 5565.6104072714925, 5567.49892509674, 5606.505105228175, 4114.531281231267, 4206.8737937861915, 4219.13507730916, 4220.978895105528, 4224.471941007374, 4227.936580951288, 4245.150969806051, 4248.044190057228, 4253.766042867641, 4257.106007738379, 4197.454330936974, 4202.474690663667, 4207.621314081732, 4218.6203241708245, 4226.281532139528, 4205.453291072172, 4210.052738133926, 4217.894552636178, 4219.050713589449, 4252.851150209759, 3719.3119272934596, 3737.8320574066975, 3738.065483629093, 3742.288965096623, 3747.4940882980723, 5519.613627046108, 5520.171974203861, 5524.254225679522, 5534.778608855641, 5535.723213839292, 4998.550130488274, 5003.274525193863, 5011.649184557083, 5016.874578135539, 5020.347354843883, 5900.97049514754, 5926.703664816742, 5951.768086967387, 5955.106733989893, 5955.910661340084, 4187.246295666779, 4192.350185721218, 4209.137126888981, 4210.494740631113, 4213.6839737019845, 5989.13157592151, 6222.81331560054, 6304.338044505307, 6402.743890244385, 6410.647414392207, 4180.456540649696, 4226.957730422718, 4240.286216821237, 4277.636400905958, 4296.3125899856495, 4316.503602085738, 4347.5652434756275, 4365.170617582649, 4377.343398490252, 4378.620734468632, 4816.157172494799, 4948.628852836052, 4950.900981980412, 4955.0337684151245, 4961.90076198474, 5921.407859214044, 5928.628548580516, 5938.910916336172, 5940.8811823764145, 5961.4038596140035, 1491.5823569400586, 1505.3301280929882, 1507.2991059157325, 1507.7889095526634, 1511.5389806109242, 998.4358837256926, 998.4907697074544, 1022.846573014039, 1027.7430642339416, 1030.6959446963165, 5104.438511763703, 5120.436751957282, 5121.28436973618, 5139.563137133386, 5169.65588946869, 6138.263408391022, 6139.053254437895, 6139.938600614026, 6144.754209831646, 6171.352008039181, 5132.0, 5132.46109158533, 5136.0, 5142.074426603247, 5153.0, 3257.332246889382, 3282.8194449305515, 3292.703656670911, 3296.752743544244, 3298.8185649789493, 5701.828945131652, 5704.686242256716, 5705.600607957404, 5780.0, 5784.971075144597, 6302.590331628521, 6350.618962862243, 6366.427021568081, 6376.840578985562, 6395.232572091379, 5707.1153971134545, 5737.3115226172295, 5737.88524229513, 5758.3090029196765, 5758.942410576008, 6101.0, 6125.387461253839, 6147.72335244924, 6162.599431036968, 6212.316645168938, 6045.274567051982, 6057.42454466825, 6083.8174854754425, 6092.390760923872, 6106.3588323227195, 5411.675299482044, 5712.7717540728945, 5734.881698068836, 5753.884922301614, 5754.625949313281, 4306.4832220133785, 4319.07139964909, 4325.307950727868, 4326.0, 4329.437173167594, 6198.0, 6201.875962480815, 6213.0, 6225.750969961332, 6245.406686364788, 5840.2991641003355, 5973.193618861398, 5978.611390259619, 6000.189974353581, 6040.728167232397, 5917.112433135064, 5927.644341339534, 5952.345242023461, 5978.970105149447, 5981.983062879234, 5830.4461076197695, 5863.325717542537, 5875.089361149029, 5902.0, 5915.142304365929, 5985.910211346921, 5989.910151347821, 5995.100734889801, 6012.759489620541, 6024.216851809237, 5851.683371241436, 5868.4424979626865, 5870.354261031198, 5872.324682661549, 5897.144913987534], "value": 4458.908174544335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.3513175971025, 750.182301291592, 757.6249756370601, 769.6075001749107, 785.2500861677099, 13359.131656442325, 13494.0, 13796.655083622902, 14951.102933823964, 14981.400743970242, 15558.144302063381, 16026.83973160268, 16029.519114426557, 16036.198190090507, 16046.43837465689, 848.9023762267341, 860.2386887604483, 862.8964524257098, 864.6066039951838, 867.2195024477958, 632.8702615963716, 641.1952998986266, 877.350760437275, 910.7586489580233, 916.8212198621271, 928.6007016982695, 939.8825146856643, 940.0411580188204, 940.4545363689078, 942.0626476655738, 933.5332333833084, 934.3833070173687, 935.2517985611483, 937.343859298487, 937.6905621145006, 693.0609024771463, 695.0339028750042, 695.3880585085143, 695.8851789454734, 696.7839969609437, 14835.554933352018, 14893.925530372388, 15281.0, 15281.541553753294, 15337.769933451007, 16031.679366412724, 16461.25924333396, 16506.917465412596, 16525.66948661032, 16599.41902033423, 12449.0, 12971.156874803202, 13064.86935130646, 13074.86925130746, 13092.47630094795, 2931.589577459157, 2940.867660955262, 2950.6754257031707, 2954.5863579098946, 2954.8670309836107, 75581.62209188975, 75711.62144189299, 76210.0, 76353.61823190904, 76640.23359766387, 10301.587936482607, 10311.535980880879, 10453.895461045293, 10494.790104197873, 10539.314944528582, 16464.341426343053, 16478.505644830675, 16550.33798648065, 16824.242909068875, 16829.326826926786, 6113.969430152821, 6157.630542167395, 6164.198654174928, 6175.814725558241, 6185.721642526097, 2937.3390987027747, 3001.714837090473, 3003.564483149931, 3010.819350838957, 3014.9246268843017, 3596.5324507813816, 4116.650084742831, 4374.4094547236355, 4393.956060439418, 4421.911561768747, 779.1935346915915, 793.2266040610474, 804.6982381606897, 804.9959750201211, 807.3944541593804, 497.3261231031972, 509.1065180608009, 514.9845504634867, 520.5835331734597, 521.2415934814911, 10509.894901050891, 10643.201759867887, 10881.455927203766, 10934.671959841218, 11353.26203796767, 617.1514168018974, 624.8031869960947, 626.6584711332334, 631.26457676806, 632.0487666062638, 4926.4088309403105, 4978.77595508203, 5010.148274793294, 5061.5950723942, 5244.213367994755, 71492.28507714857, 74174.25825741673, 75973.24026759662, 87630.56184719162, 89217.0, 62450.37549624537, 63936.36063639397, 65122.348776512576, 65922.67038664776, 67189.0, 58609.70695146497, 59100.40899590949, 63488.04767928485, 63931.680341597996, 64076.359236407974, 9971.40171589678, 10374.896251037695, 10690.305130166515, 10767.569297228336, 10829.241953063525, 27388.315292117855, 27710.0, 28042.85978570094, 28495.43009139764, 29195.708042919297, 49547.752261238464, 52363.73818130885, 52578.47421525889, 53160.20259696185, 53910.730446347516, 14762.0, 14764.926175369055, 15184.772228416361, 15312.846871531588, 15552.30014649321, 16106.838931611002, 16288.267027983533, 16406.425775097814, 17096.57258568546, 17130.571735706708, 15537.766933496232, 15693.764593531334, 15788.368465261721, 15837.0, 16084.758728619314, 13799.03406761517, 14695.0, 14736.852631473548, 14794.852051479347, 14860.331285091981, 13930.58208253754, 14323.427062917366, 14397.064190827563, 14405.42378304856, 14629.487967921497, 9425.38734982224, 9491.715248542554, 9767.316287859781, 9836.262280329147, 10165.237607179342, 10994.0, 12160.695982600506, 12829.743405132032, 12862.228266304051, 12867.613971580868], "value": 7117.290602632864, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 110.0, 109.0, 109.0, 114.0, 110.0, 112.0, 112.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 125.0, 169.0, 126.0, 122.0, 122.0, 122.0, 152.0, 123.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 164.0, 165.0, 169.0, 169.0, 170.0, 165.0, 163.0, 160.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 110.0, 76.0, 75.0, 75.0, 76.0, 92.0, 73.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 105.0, 84.0, 86.0, 86.0, 99.0, 84.0, 84.0, 108.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 151.0, 151.0, 151.0, 149.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 59.0, 56.0, 57.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 59.0, 59.0, 58.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 87.0, 88.0, 96.0, 87.0, 88.0, 126.0, 86.0], "value": 92.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 136.0, 135.0, 132.0, 130.0, 140.0, 134.0, 137.0, 139.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 199.0, 185.0, 195.0, 212.0, 191.0, 192.0, 192.0, 193.0, 191.0], "value": 193.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 73.0, 71.0, 74.0, 75.0, 73.0, 72.0, 71.0, 73.0], "value": 73.1, "unit": "score"}]}]} 14:10:15 INFO - Return code: 0 14:10:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:10:15 INFO - # TBPL SUCCESS # 14:10:15 INFO - Running post-action listener: _resource_record_post_action 14:10:15 INFO - [mozharness: 2017-05-30 21:10:15.228610Z] Finished run-tests step (success) 14:10:15 INFO - Running post-run listener: _resource_record_post_run 14:10:15 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403296256; Read time: 12; Write time: 281556 14:10:15 INFO - TinderboxPrint: CPU usage
12.6% 14:10:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:10:15 INFO - TinderboxPrint: I/O write bytes / time
403,296,256 / 281,556 14:10:15 INFO - TinderboxPrint: CPU idle
8,755.8 (87.3%) 14:10:15 INFO - TinderboxPrint: CPU user
1,217.2 (12.1%) 14:10:15 INFO - TinderboxPrint: Swap in / out
0 / 0 14:10:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97685504; Read time: 0; Write time: 101620 14:10:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:10:15 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305610752; Read time: 12; Write time: 179936 14:10:15 INFO - Running post-run listener: _upload_blobber_files 14:10:15 INFO - Blob upload gear active. 14:10:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:10:15 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 14:10:15 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'] 14:10:15 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 14:10:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:10:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:17 INFO - (blobuploader) - INFO - Done attempting. 14:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:18 INFO - (blobuploader) - INFO - Done attempting. 14:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:25 INFO - (blobuploader) - INFO - Done attempting. 14:10:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:10:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:10:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:26 INFO - (blobuploader) - INFO - Done attempting. 14:10:26 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:26 INFO - Return code: 0 14:10:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:26 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76423c9dd2fb4243db3a859fb17c8329e39cb2de222e22565cda57ea5a7b5c2b86d8629584bcdc33cfc5aa1ea38511dcfde599a9afb939131df5096813ecea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d20dc7aff8aded3e18360c0d8d9146a664bb53c119151a3510d9b74cec59ff5d345b724f1501ca802e885c0366a862132a6b11d245b343279b09292dd1c8c643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787b607ab98de33bb8b8bf87dd09242dedfa30b42f7c31655a3776b0cbc102cdfa19bf67e8df4088c28a7977ce3e91c3bfd2f4e13deaac5414f3f4e42baf0c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/774c22a4e13fc6e2568a659052f7ce87eaa6e7576a76ba943ede66626430c1e6bdf2278abe138f6bd17ce979606e3f43c697dad2bba338aa68217127278227f1"} 14:10:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:26 INFO - Contents: 14:10:26 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76423c9dd2fb4243db3a859fb17c8329e39cb2de222e22565cda57ea5a7b5c2b86d8629584bcdc33cfc5aa1ea38511dcfde599a9afb939131df5096813ecea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d20dc7aff8aded3e18360c0d8d9146a664bb53c119151a3510d9b74cec59ff5d345b724f1501ca802e885c0366a862132a6b11d245b343279b09292dd1c8c643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787b607ab98de33bb8b8bf87dd09242dedfa30b42f7c31655a3776b0cbc102cdfa19bf67e8df4088c28a7977ce3e91c3bfd2f4e13deaac5414f3f4e42baf0c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/774c22a4e13fc6e2568a659052f7ce87eaa6e7576a76ba943ede66626430c1e6bdf2278abe138f6bd17ce979606e3f43c697dad2bba338aa68217127278227f1"} 14:10:26 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:26 INFO - Copying logs to upload dir... 14:10:26 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.666235 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-30 14:10:26.279757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:10:26.283883) ========= 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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 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/3a76423c9dd2fb4243db3a859fb17c8329e39cb2de222e22565cda57ea5a7b5c2b86d8629584bcdc33cfc5aa1ea38511dcfde599a9afb939131df5096813ecea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d20dc7aff8aded3e18360c0d8d9146a664bb53c119151a3510d9b74cec59ff5d345b724f1501ca802e885c0366a862132a6b11d245b343279b09292dd1c8c643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787b607ab98de33bb8b8bf87dd09242dedfa30b42f7c31655a3776b0cbc102cdfa19bf67e8df4088c28a7977ce3e91c3bfd2f4e13deaac5414f3f4e42baf0c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/774c22a4e13fc6e2568a659052f7ce87eaa6e7576a76ba943ede66626430c1e6bdf2278abe138f6bd17ce979606e3f43c697dad2bba338aa68217127278227f1"} build_url:https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/PZVsRlzkQW29UrG0ZBaGEg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3a76423c9dd2fb4243db3a859fb17c8329e39cb2de222e22565cda57ea5a7b5c2b86d8629584bcdc33cfc5aa1ea38511dcfde599a9afb939131df5096813ecea", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d20dc7aff8aded3e18360c0d8d9146a664bb53c119151a3510d9b74cec59ff5d345b724f1501ca802e885c0366a862132a6b11d245b343279b09292dd1c8c643", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/787b607ab98de33bb8b8bf87dd09242dedfa30b42f7c31655a3776b0cbc102cdfa19bf67e8df4088c28a7977ce3e91c3bfd2f4e13deaac5414f3f4e42baf0c0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/774c22a4e13fc6e2568a659052f7ce87eaa6e7576a76ba943ede66626430c1e6bdf2278abe138f6bd17ce979606e3f43c697dad2bba338aa68217127278227f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 14:10:26.312183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:10:26.312534) ========= 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=a0d2d2de893abaa8702a9954000001a7-1496174837.444519-1414302912 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 14:10:26.396278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:10:26.396619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 14:10:26.396946) ========= ========= Total master_lag: 0.17 =========