builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1496337229.06 results: success (0) revision: 0e9853e31da9848ab638bdd0df4eb734a5ebc232 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.059230) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.059895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.060190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.118032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.118428) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 10:13:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.4M=0s 2017-06-01 10:13:49 (25.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.281602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.281933) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014747 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:49.338144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 10:13:49.338481) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0e9853e31da9848ab638bdd0df4eb734a5ebc232 --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 0e9853e31da9848ab638bdd0df4eb734a5ebc232 --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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 10:13:50,013 truncating revision to first 12 chars 2017-06-01 10:13:50,013 Setting DEBUG logging. 2017-06-01 10:13:50,013 attempt 1/10 2017-06-01 10:13:50,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0e9853e31da9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 10:13:51,015 unpacking tar archive at: mozilla-central-0e9853e31da9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.291224 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 10:13:50.645484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:50.645894) ========= script_repo_revision: 0e9853e31da9848ab638bdd0df4eb734a5ebc232 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:50.646354) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:50.646623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 10:13:50.665106) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-01 10:13:50.665533) ========= /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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:13:51 INFO - MultiFileLogger online at 20170601 10:13:51 in /builds/slave/test 10:13:51 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 10:13:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:13:51 INFO - {'append_to_log': False, 10:13:51 INFO - 'base_work_dir': '/builds/slave/test', 10:13:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:13:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:13:51 INFO - 'branch': 'Firefox-Non-PGO', 10:13:51 INFO - 'buildbot_json_path': 'buildprops.json', 10:13:51 INFO - 'config_files': ('talos/linux_config.py',), 10:13:51 INFO - 'default_actions': ('clobber', 10:13:51 INFO - 'read-buildbot-config', 10:13:51 INFO - 'download-and-extract', 10:13:51 INFO - 'populate-webroot', 10:13:51 INFO - 'create-virtualenv', 10:13:51 INFO - 'install', 10:13:51 INFO - 'setup-mitmproxy', 10:13:51 INFO - 'run-tests'), 10:13:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:13:51 INFO - 'download_minidump_stackwalk': True, 10:13:51 INFO - 'download_symbols': 'ondemand', 10:13:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:13:51 INFO - 'tooltool.py': '/tools/tooltool.py', 10:13:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:13:51 INFO - '/tools/misc-python/virtualenv.py')}, 10:13:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:13:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:13:51 INFO - 'gecko_profile': False, 10:13:51 INFO - 'gecko_profile_interval': 0, 10:13:51 INFO - 'installer_path': 'installer.exe', 10:13:51 INFO - 'log_level': 'info', 10:13:51 INFO - 'log_name': 'talos', 10:13:51 INFO - 'log_to_console': True, 10:13:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:13:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:13:51 INFO - 'opt_config_files': (), 10:13:51 INFO - 'pip_index': False, 10:13:51 INFO - 'suite': 'dromaeojs-e10s', 10:13:51 INFO - 'system_bits': '32', 10:13:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:13:51 INFO - 'title': 'talos-linux64-ix-060', 10:13:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:13:51 INFO - 'use_talos_json': True, 10:13:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:13:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:13:51 INFO - 'work_dir': 'build'} 10:13:51 INFO - [mozharness: 2017-06-01 17:13:51.444674Z] Running clobber step. 10:13:51 INFO - Running pre-action listener: _resource_record_pre_action 10:13:51 INFO - Running main action method: clobber 10:13:51 INFO - rmtree: /builds/slave/test/build 10:13:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:13:52 INFO - Running post-action listener: _resource_record_post_action 10:13:52 INFO - [mozharness: 2017-06-01 17:13:52.476028Z] Finished clobber step (success) 10:13:52 INFO - [mozharness: 2017-06-01 17:13:52.476129Z] Running read-buildbot-config step. 10:13:52 INFO - Running pre-action listener: _resource_record_pre_action 10:13:52 INFO - Running main action method: read_buildbot_config 10:13:52 INFO - Using buildbot properties: 10:13:52 INFO - { 10:13:52 INFO - "project": "", 10:13:52 INFO - "product": "firefox", 10:13:52 INFO - "who": "ryanvm@gmail.com", 10:13:52 INFO - "installer_path": "public/build/target.tar.bz2", 10:13:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:13:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:13:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:13:52 INFO - "stage_platform": "linux64", 10:13:52 INFO - "basedir": "/builds/slave/test", 10:13:52 INFO - "buildnumber": 880, 10:13:52 INFO - "platform": "ubuntu64_hw", 10:13:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:13:52 INFO - "slavebuilddir": "test", 10:13:52 INFO - "taskId": "W1szwVf8RkW8YAykL9-3Yg", 10:13:52 INFO - "branch": "mozilla-central", 10:13:52 INFO - "script_repo_revision": "production", 10:13:52 INFO - "revision": "0e9853e31da9848ab638bdd0df4eb734a5ebc232", 10:13:52 INFO - "slavename": "talos-linux64-ix-060", 10:13:52 INFO - "repo_path": "mozilla-central" 10:13:52 INFO - } 10:13:52 INFO - Finding installer, test and symbols from parent task. 10:13:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1szwVf8RkW8YAykL9-3Yg'}, attempt #1 10:13:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W1szwVf8RkW8YAykL9-3Yg'}, attempt #1 10:13:53 INFO - Task dependencies: fzRGqGS9RgCa0MzzHgk90w 10:13:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w'}, attempt #1 10:13:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 10:13:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/test_packages.json 10:13:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.crashreporter-symbols.zip 10:13:53 INFO - Running post-action listener: _resource_record_post_action 10:13:53 INFO - [mozharness: 2017-06-01 17:13:53.873667Z] Finished read-buildbot-config step (success) 10:13:53 INFO - [mozharness: 2017-06-01 17:13:53.873887Z] Running download-and-extract step. 10:13:53 INFO - Running pre-action listener: _resource_record_pre_action 10:13:53 INFO - Running main action method: download_and_extract 10:13:53 INFO - mkdir: /builds/slave/test/build/tests 10:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:53 INFO - trying https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.test_packages.json 10:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:13:54 INFO - Downloaded 986 bytes. 10:13:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:13:54 INFO - Using the following test package requirements: 10:13:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:13:54 INFO - u'common': [u'target.common.tests.zip'], 10:13:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:13:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:13:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:13:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:13:54 INFO - u'mozbase': [u'target.common.tests.zip'], 10:13:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:13:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:13:54 INFO - u'web-platform': [u'target.common.tests.zip', 10:13:54 INFO - u'target.web-platform.tests.zip'], 10:13:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:13:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:13:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip 10:13:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:13:54 INFO - Fetch https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip into memory 10:13:56 INFO - Content-Length response header: 63535445 10:13:56 INFO - Bytes received: 63535445 10:14:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:14:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip 10:14:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:14:07 INFO - Fetch https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.common.tests.zip into memory 10:14:09 INFO - Content-Length response header: 63535445 10:14:09 INFO - Bytes received: 63535445 10:14:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.talos.tests.zip 10:14:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:14:21 INFO - Fetch https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.talos.tests.zip into memory 10:14:22 INFO - Content-Length response header: 14447425 10:14:22 INFO - Bytes received: 14447425 10:14:22 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')]} 10:14:22 INFO - trying https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 10:14:22 INFO - Downloading https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:14:24 INFO - Downloaded 54139855 bytes. 10:14:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 10:14:24 INFO - mkdir: /builds/slave/test/properties 10:14:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:24 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:24 INFO - Contents: 10:14:24 INFO - build_url:https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 10:14:24 INFO - Running post-action listener: _resource_record_post_action 10:14:24 INFO - Running post-action listener: set_extra_try_arguments 10:14:24 INFO - [mozharness: 2017-06-01 17:14:24.852206Z] Finished download-and-extract step (success) 10:14:24 INFO - [mozharness: 2017-06-01 17:14:24.852432Z] Running populate-webroot step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: populate_webroot 10:14:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:24 INFO - '--tppagecycles', 10:14:24 INFO - '7'], 10:14:24 INFO - 'tests': ['tsvgm']}}, 10:14:24 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['damp', 'tps']}, 10:14:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'tests': ['damp', 'tps']}, 10:14:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['dromaeo_dom']}, 10:14:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:14:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:14:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:14:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['a11yr', 10:14:24 INFO - 'ts_paint', 10:14:24 INFO - 'tpaint', 10:14:24 INFO - 'sessionrestore', 10:14:24 INFO - 'sessionrestore_no_auto_restore', 10:14:24 INFO - 'tabpaint']}, 10:14:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:14:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:14:24 INFO - 'bloom_basic_ref']}, 10:14:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:14:24 INFO - 'talos_options': ['--mitmproxy', 10:14:24 INFO - 'mitmproxy-recording-1.mp', 10:14:24 INFO - '--firstNonBlankPaint'], 10:14:24 INFO - 'tests': ['Quantum_1']}, 10:14:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['tsvgx', 10:14:24 INFO - 'tsvgr_opacity', 10:14:24 INFO - 'tart', 10:14:24 INFO - 'tscrollx', 10:14:24 INFO - 'cart', 10:14:24 INFO - 'tsvg_static']}, 10:14:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:24 INFO - 'tsvgr_opacity', 10:14:24 INFO - 'tart', 10:14:24 INFO - 'tscrollx', 10:14:24 INFO - 'cart', 10:14:24 INFO - 'tsvg_static']}, 10:14:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'talos_options': ['--disable-e10s'], 10:14:24 INFO - 'tests': ['tp5o']}, 10:14:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:14:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'talos_options': ['--disable-e10s', 10:14:24 INFO - '--xperf_path', 10:14:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:24 INFO - 'tests': ['tp5n']}, 10:14:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:14:24 INFO - 'talos_options': ['--xperf_path', 10:14:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:24 INFO - 'tests': ['tp5n']}}, 10:14:24 INFO - 'talos.zip': {'path': '', 10:14:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:24 INFO - Running post-action listener: _resource_record_post_action 10:14:24 INFO - [mozharness: 2017-06-01 17:14:24.872272Z] Finished populate-webroot step (success) 10:14:24 INFO - [mozharness: 2017-06-01 17:14:24.872366Z] Running create-virtualenv step. 10:14:24 INFO - Running pre-action listener: _resource_record_pre_action 10:14:24 INFO - Running main action method: create_virtualenv 10:14:24 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:14:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:14:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:24 INFO - Using real prefix '/usr' 10:14:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:27 INFO - Installing pip.................done. 10:14:27 INFO - Return code: 0 10:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:14:27 INFO - Reading from file tmpfile_stdout 10:14:27 INFO - Output received: 10:14:27 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) 10:14:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14:27 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')]} 10:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:27 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')]} 10:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:27 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:27 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 10:14:27 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 10:14:27 INFO - Using env: {'DISPLAY': ':0', 10:14:27 INFO - 'HOME': '/home/cltbld', 10:14:27 INFO - 'LANG': 'en_US.UTF-8', 10:14:27 INFO - 'LANGUAGE': 'en_US:en', 10:14:27 INFO - 'LOGNAME': 'cltbld', 10:14:27 INFO - 'MAIL': '/var/mail/cltbld', 10:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:27 INFO - 'MOZ_NO_REMOTE': '1', 10:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:27 INFO - 'NO_EM_RESTART': '1', 10:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:27 INFO - 'PWD': '/builds/slave/test', 10:14:27 INFO - 'SHELL': '/bin/bash', 10:14:27 INFO - 'SHLVL': '1', 10:14:27 INFO - 'TERM': 'linux', 10:14:27 INFO - 'TMOUT': '86400', 10:14:27 INFO - 'USER': 'cltbld', 10:14:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:27 INFO - '_': '/tools/buildbot/bin/python'} 10:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:27 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 10:14:27 INFO - Cleaning up... 10:14:27 INFO - Return code: 0 10:14:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:27 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')]} 10:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:27 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')]} 10:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:27 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:27 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 10:14:27 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 10:14:27 INFO - Using env: {'DISPLAY': ':0', 10:14:27 INFO - 'HOME': '/home/cltbld', 10:14:27 INFO - 'LANG': 'en_US.UTF-8', 10:14:27 INFO - 'LANGUAGE': 'en_US:en', 10:14:27 INFO - 'LOGNAME': 'cltbld', 10:14:27 INFO - 'MAIL': '/var/mail/cltbld', 10:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:27 INFO - 'MOZ_NO_REMOTE': '1', 10:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:27 INFO - 'NO_EM_RESTART': '1', 10:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:27 INFO - 'PWD': '/builds/slave/test', 10:14:27 INFO - 'SHELL': '/bin/bash', 10:14:27 INFO - 'SHLVL': '1', 10:14:27 INFO - 'TERM': 'linux', 10:14:27 INFO - 'TMOUT': '86400', 10:14:27 INFO - 'USER': 'cltbld', 10:14:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:27 INFO - '_': '/tools/buildbot/bin/python'} 10:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:28 INFO - Downloading/unpacking psutil>=3.1.1 10:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:29 INFO - Installing collected packages: psutil 10:14:29 INFO - Running setup.py install for psutil 10:14:29 INFO - building 'psutil._psutil_linux' extension 10:14:29 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 10:14:29 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 10:14:29 INFO - building 'psutil._psutil_posix' extension 10:14:29 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 10:14:29 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 10:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:29 INFO - Successfully installed psutil 10:14:29 INFO - Cleaning up... 10:14:29 INFO - Return code: 0 10:14:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:29 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')]} 10:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:29 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')]} 10:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:30 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:30 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 10:14:30 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 10:14:30 INFO - Using env: {'DISPLAY': ':0', 10:14:30 INFO - 'HOME': '/home/cltbld', 10:14:30 INFO - 'LANG': 'en_US.UTF-8', 10:14:30 INFO - 'LANGUAGE': 'en_US:en', 10:14:30 INFO - 'LOGNAME': 'cltbld', 10:14:30 INFO - 'MAIL': '/var/mail/cltbld', 10:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:30 INFO - 'MOZ_NO_REMOTE': '1', 10:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:30 INFO - 'NO_EM_RESTART': '1', 10:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:30 INFO - 'PWD': '/builds/slave/test', 10:14:30 INFO - 'SHELL': '/bin/bash', 10:14:30 INFO - 'SHLVL': '1', 10:14:30 INFO - 'TERM': 'linux', 10:14:30 INFO - 'TMOUT': '86400', 10:14:30 INFO - 'USER': 'cltbld', 10:14:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:30 INFO - '_': '/tools/buildbot/bin/python'} 10:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:31 INFO - Installing collected packages: mozsystemmonitor 10:14:31 INFO - Running setup.py install for mozsystemmonitor 10:14:31 INFO - Successfully installed mozsystemmonitor 10:14:31 INFO - Cleaning up... 10:14:31 INFO - Return code: 0 10:14:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14: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')]} 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14: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')]} 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:14:31 INFO - Using env: {'DISPLAY': ':0', 10:14:31 INFO - 'HOME': '/home/cltbld', 10:14:31 INFO - 'LANG': 'en_US.UTF-8', 10:14:31 INFO - 'LANGUAGE': 'en_US:en', 10:14:31 INFO - 'LOGNAME': 'cltbld', 10:14:31 INFO - 'MAIL': '/var/mail/cltbld', 10:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:31 INFO - 'MOZ_NO_REMOTE': '1', 10:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:31 INFO - 'NO_EM_RESTART': '1', 10:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:31 INFO - 'PWD': '/builds/slave/test', 10:14:31 INFO - 'SHELL': '/bin/bash', 10:14:31 INFO - 'SHLVL': '1', 10:14:31 INFO - 'TERM': 'linux', 10:14:31 INFO - 'TMOUT': '86400', 10:14:31 INFO - 'USER': 'cltbld', 10:14:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:31 INFO - '_': '/tools/buildbot/bin/python'} 10:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:31 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:32 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:32 INFO - warning: no files found matching '*.txt' 10:14:32 INFO - no previously-included directories found matching 'build' 10:14:32 INFO - no previously-included directories found matching 'dist' 10:14:32 INFO - no previously-included directories found matching '.git*' 10:14:32 INFO - Installing collected packages: jsonschema, functools32 10:14:33 INFO - Running setup.py install for functools32 10:14:33 INFO - warning: no files found matching '*.txt' 10:14:33 INFO - no previously-included directories found matching 'build' 10:14:33 INFO - no previously-included directories found matching 'dist' 10:14:33 INFO - no previously-included directories found matching '.git*' 10:14:33 INFO - Successfully installed jsonschema functools32 10:14:33 INFO - Cleaning up... 10:14:33 INFO - Return code: 0 10:14:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:14:33 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')]} 10:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:33 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')]} 10:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:33 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:33 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 10:14:33 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 10:14:33 INFO - Using env: {'DISPLAY': ':0', 10:14:33 INFO - 'HOME': '/home/cltbld', 10:14:33 INFO - 'LANG': 'en_US.UTF-8', 10:14:33 INFO - 'LANGUAGE': 'en_US:en', 10:14:33 INFO - 'LOGNAME': 'cltbld', 10:14:33 INFO - 'MAIL': '/var/mail/cltbld', 10:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:33 INFO - 'MOZ_NO_REMOTE': '1', 10:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:33 INFO - 'NO_EM_RESTART': '1', 10:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:33 INFO - 'PWD': '/builds/slave/test', 10:14:33 INFO - 'SHELL': '/bin/bash', 10:14:33 INFO - 'SHLVL': '1', 10:14:33 INFO - 'TERM': 'linux', 10:14:33 INFO - 'TMOUT': '86400', 10:14:33 INFO - 'USER': 'cltbld', 10:14:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:33 INFO - '_': '/tools/buildbot/bin/python'} 10:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:14:33 INFO - Cleaning up... 10:14:33 INFO - Return code: 0 10:14:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:33 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')]} 10:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:33 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')]} 10:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:33 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:33 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 10:14:33 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 10:14:33 INFO - Using env: {'DISPLAY': ':0', 10:14:33 INFO - 'HOME': '/home/cltbld', 10:14:33 INFO - 'LANG': 'en_US.UTF-8', 10:14:33 INFO - 'LANGUAGE': 'en_US:en', 10:14:33 INFO - 'LOGNAME': 'cltbld', 10:14:33 INFO - 'MAIL': '/var/mail/cltbld', 10:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:33 INFO - 'MOZ_NO_REMOTE': '1', 10:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:33 INFO - 'NO_EM_RESTART': '1', 10:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:33 INFO - 'PWD': '/builds/slave/test', 10:14:33 INFO - 'SHELL': '/bin/bash', 10:14:33 INFO - 'SHLVL': '1', 10:14:33 INFO - 'TERM': 'linux', 10:14:33 INFO - 'TMOUT': '86400', 10:14:33 INFO - 'USER': 'cltbld', 10:14:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:33 INFO - '_': '/tools/buildbot/bin/python'} 10:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:33 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:33 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 10:14:33 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 10:14:33 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 10:14:33 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 10:14:34 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:35 INFO - Downloading docopt-0.6.1.tar.gz 10:14:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:35 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:35 INFO - Running setup.py install for blobuploader 10:14:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:35 INFO - Running setup.py install for requests 10:14:35 INFO - Running setup.py install for docopt 10:14:35 INFO - Successfully installed blobuploader requests docopt 10:14:35 INFO - Cleaning up... 10:14:35 INFO - Return code: 0 10:14:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:35 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:35 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 10:14:35 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 10:14:35 INFO - Using env: {'DISPLAY': ':0', 10:14:35 INFO - 'HOME': '/home/cltbld', 10:14:35 INFO - 'LANG': 'en_US.UTF-8', 10:14:35 INFO - 'LANGUAGE': 'en_US:en', 10:14:35 INFO - 'LOGNAME': 'cltbld', 10:14:35 INFO - 'MAIL': '/var/mail/cltbld', 10:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:35 INFO - 'MOZ_NO_REMOTE': '1', 10:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:35 INFO - 'NO_EM_RESTART': '1', 10:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:35 INFO - 'PWD': '/builds/slave/test', 10:14:35 INFO - 'SHELL': '/bin/bash', 10:14:35 INFO - 'SHLVL': '1', 10:14:35 INFO - 'TERM': 'linux', 10:14:35 INFO - 'TMOUT': '86400', 10:14:35 INFO - 'USER': 'cltbld', 10:14:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:35 INFO - '_': '/tools/buildbot/bin/python'} 10:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:36 INFO - Running setup.py (path:/tmp/pip-Py_lBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:36 INFO - Running setup.py (path:/tmp/pip-ua3Zhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:36 INFO - Running setup.py (path:/tmp/pip-FxkpNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:36 INFO - Running setup.py (path:/tmp/pip-bTeOFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:36 INFO - Running setup.py (path:/tmp/pip-M9UEnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:36 INFO - Running setup.py (path:/tmp/pip-wNKmf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:36 INFO - Running setup.py (path:/tmp/pip-IlaPqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:36 INFO - Running setup.py (path:/tmp/pip-Drskud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:36 INFO - Running setup.py (path:/tmp/pip-9eE2bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:36 INFO - Running setup.py (path:/tmp/pip-hb91Vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:36 INFO - Running setup.py (path:/tmp/pip-5YMsqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:36 INFO - Running setup.py (path:/tmp/pip-rByWHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:36 INFO - Running setup.py (path:/tmp/pip-yXjrve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:36 INFO - Running setup.py (path:/tmp/pip-FIjUpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:37 INFO - Running setup.py (path:/tmp/pip-42jP4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:37 INFO - Running setup.py (path:/tmp/pip-HXZD7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:37 INFO - Running setup.py (path:/tmp/pip-Fv9U04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:37 INFO - Running setup.py install for manifestparser 10:14:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:37 INFO - Running setup.py install for mozcrash 10:14:37 INFO - Running setup.py install for mozdebug 10:14:37 INFO - Running setup.py install for mozdevice 10:14:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:37 INFO - Running setup.py install for mozfile 10:14:37 INFO - Running setup.py install for mozhttpd 10:14:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:37 INFO - Running setup.py install for mozinfo 10:14:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:37 INFO - Running setup.py install for mozInstall 10:14:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Running setup.py install for mozleak 10:14:38 INFO - Running setup.py install for mozlog 10:14:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Running setup.py install for moznetwork 10:14:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Running setup.py install for mozprocess 10:14:38 INFO - Running setup.py install for mozprofile 10:14:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Running setup.py install for mozrunner 10:14:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:38 INFO - Running setup.py install for mozscreenshot 10:14:38 INFO - Running setup.py install for moztest 10:14:38 INFO - Running setup.py install for mozversion 10:14:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:39 INFO - Cleaning up... 10:14:39 INFO - Return code: 0 10:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:39 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')]} 10:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:39 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')]} 10:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:39 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:39 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 10:14:39 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 10:14:39 INFO - Using env: {'DISPLAY': ':0', 10:14:39 INFO - 'HOME': '/home/cltbld', 10:14:39 INFO - 'LANG': 'en_US.UTF-8', 10:14:39 INFO - 'LANGUAGE': 'en_US:en', 10:14:39 INFO - 'LOGNAME': 'cltbld', 10:14:39 INFO - 'MAIL': '/var/mail/cltbld', 10:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:39 INFO - 'MOZ_NO_REMOTE': '1', 10:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:39 INFO - 'NO_EM_RESTART': '1', 10:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:39 INFO - 'PWD': '/builds/slave/test', 10:14:39 INFO - 'SHELL': '/bin/bash', 10:14:39 INFO - 'SHLVL': '1', 10:14:39 INFO - 'TERM': 'linux', 10:14:39 INFO - 'TMOUT': '86400', 10:14:39 INFO - 'USER': 'cltbld', 10:14:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:39 INFO - '_': '/tools/buildbot/bin/python'} 10:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:39 INFO - Running setup.py (path:/tmp/pip-QqTKRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:39 INFO - Running setup.py (path:/tmp/pip-hAkjjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:39 INFO - Running setup.py (path:/tmp/pip-X_BV2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:39 INFO - Running setup.py (path:/tmp/pip-8EaQA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:39 INFO - Running setup.py (path:/tmp/pip-SAj_ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:39 INFO - Running setup.py (path:/tmp/pip-fsE2Ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:39 INFO - Running setup.py (path:/tmp/pip-eKugR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:39 INFO - Running setup.py (path:/tmp/pip-_qIAJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:39 INFO - Running setup.py (path:/tmp/pip-Bxd9Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:39 INFO - Running setup.py (path:/tmp/pip-JXXZky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:39 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)) 10:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:39 INFO - Running setup.py (path:/tmp/pip-3zOuBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:40 INFO - Running setup.py (path:/tmp/pip-cr0Db1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:40 INFO - Running setup.py (path:/tmp/pip-yt6CYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:40 INFO - Running setup.py (path:/tmp/pip-LDcKZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:40 INFO - Running setup.py (path:/tmp/pip-uTZBJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:40 INFO - Running setup.py (path:/tmp/pip-56WQQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:40 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)) 10:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:40 INFO - Running setup.py (path:/tmp/pip-cjJxfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:40 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)) 10:14:40 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)) 10:14:40 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)) 10:14:40 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)) 10:14:40 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)) 10:14:40 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)) 10:14:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:41 INFO - Downloading blessings-1.6.tar.gz 10:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:41 INFO - Installing collected packages: blessings 10:14:41 INFO - Running setup.py install for blessings 10:14:41 INFO - Successfully installed blessings 10:14:41 INFO - Cleaning up... 10:14:41 INFO - Return code: 0 10:14:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:42 INFO - Reading from file tmpfile_stdout 10:14:42 INFO - Current package versions: 10:14:42 INFO - argparse == 1.2.1 10:14:42 INFO - blessings == 1.6 10:14:42 INFO - blobuploader == 1.2.4 10:14:42 INFO - docopt == 0.6.1 10:14:42 INFO - functools32 == 3.2.3-2 10:14:42 INFO - jsonschema == 2.5.1 10:14:42 INFO - manifestparser == 1.1 10:14:42 INFO - mozInstall == 1.12 10:14:42 INFO - mozcrash == 1.0 10:14:42 INFO - mozdebug == 0.1 10:14:42 INFO - mozdevice == 0.51 10:14:42 INFO - mozfile == 1.2 10:14:42 INFO - mozhttpd == 0.7 10:14:42 INFO - mozinfo == 0.9 10:14:42 INFO - mozleak == 0.1 10:14:42 INFO - mozlog == 3.4 10:14:42 INFO - moznetwork == 0.27 10:14:42 INFO - mozprocess == 0.25 10:14:42 INFO - mozprofile == 0.28 10:14:42 INFO - mozrunner == 6.13 10:14:42 INFO - mozscreenshot == 0.1 10:14:42 INFO - mozsystemmonitor == 0.3 10:14:42 INFO - moztest == 0.8 10:14:42 INFO - mozversion == 1.4 10:14:42 INFO - psutil == 3.1.1 10:14:42 INFO - requests == 1.2.3 10:14:42 INFO - wsgiref == 0.1.2 10:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:42 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 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:42 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 10:14:42 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 10:14:42 INFO - Using env: {'DISPLAY': ':0', 10:14:42 INFO - 'HOME': '/home/cltbld', 10:14:42 INFO - 'LANG': 'en_US.UTF-8', 10:14:42 INFO - 'LANGUAGE': 'en_US:en', 10:14:42 INFO - 'LOGNAME': 'cltbld', 10:14:42 INFO - 'MAIL': '/var/mail/cltbld', 10:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:42 INFO - 'MOZ_NO_REMOTE': '1', 10:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:42 INFO - 'NO_EM_RESTART': '1', 10:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:42 INFO - 'PWD': '/builds/slave/test', 10:14:42 INFO - 'SHELL': '/bin/bash', 10:14:42 INFO - 'SHLVL': '1', 10:14:42 INFO - 'TERM': 'linux', 10:14:42 INFO - 'TMOUT': '86400', 10:14:42 INFO - 'USER': 'cltbld', 10:14:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:42 INFO - '_': '/tools/buildbot/bin/python'} 10:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 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)) 10:14:42 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:43 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:14:43 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)) 10:14:43 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)) 10:14:43 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)) 10:14:43 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)) 10:14:43 INFO - Installing collected packages: marionette-driver 10:14:43 INFO - Running setup.py install for marionette-driver 10:14:43 INFO - Successfully installed marionette-driver 10:14:43 INFO - Cleaning up... 10:14:43 INFO - Return code: 0 10:14:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xaca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xca4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe48dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, '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': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', '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 10:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:14:43 INFO - Using env: {'DISPLAY': ':0', 10:14:43 INFO - 'HOME': '/home/cltbld', 10:14:43 INFO - 'LANG': 'en_US.UTF-8', 10:14:43 INFO - 'LANGUAGE': 'en_US:en', 10:14:43 INFO - 'LOGNAME': 'cltbld', 10:14:43 INFO - 'MAIL': '/var/mail/cltbld', 10:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:43 INFO - 'MOZ_NO_REMOTE': '1', 10:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:43 INFO - 'NO_EM_RESTART': '1', 10:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:43 INFO - 'PWD': '/builds/slave/test', 10:14:43 INFO - 'SHELL': '/bin/bash', 10:14:43 INFO - 'SHLVL': '1', 10:14:43 INFO - 'TERM': 'linux', 10:14:43 INFO - 'TMOUT': '86400', 10:14:43 INFO - 'USER': 'cltbld', 10:14:43 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:43 INFO - '_': '/tools/buildbot/bin/python'} 10:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:43 INFO - Cleaning up... 10:14:43 INFO - Return code: 0 10:14:43 INFO - Running post-action listener: _resource_record_post_action 10:14:43 INFO - Running post-action listener: _start_resource_monitoring 10:14:43 INFO - Starting resource monitoring. 10:14:43 INFO - [mozharness: 2017-06-01 17:14:43.814724Z] Finished create-virtualenv step (success) 10:14:43 INFO - [mozharness: 2017-06-01 17:14:43.815204Z] Running install step. 10:14:43 INFO - Running pre-action listener: _resource_record_pre_action 10:14:43 INFO - Running main action method: install 10:14:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:44 INFO - Reading from file tmpfile_stdout 10:14:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:44 INFO - Reading from file tmpfile_stdout 10:14:44 INFO - Output received: 10:14:44 INFO - Usage: mozinstall [options] installer 10:14:44 INFO - Options: 10:14:44 INFO - -h, --help show this help message and exit 10:14:44 INFO - -d DEST, --destination=DEST 10:14:44 INFO - Directory to install application into. [default: 10:14:44 INFO - "/builds/slave/test"] 10:14:44 INFO - --app=APP Application being installed. [default: firefox] 10:14:44 INFO - mkdir: /builds/slave/test/build/application 10:14:44 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'] 10:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:14:59 INFO - Reading from file tmpfile_stdout 10:14:59 INFO - Output received: 10:14:59 INFO - /builds/slave/test/build/application/firefox/firefox 10:14:59 INFO - Running post-action listener: _resource_record_post_action 10:14:59 INFO - [mozharness: 2017-06-01 17:14:59.671908Z] Finished install step (success) 10:14:59 INFO - [mozharness: 2017-06-01 17:14:59.672186Z] Running setup-mitmproxy step. 10:14:59 INFO - Running pre-action listener: _resource_record_pre_action 10:14:59 INFO - Running main action method: setup_mitmproxy 10:14:59 INFO - Skipping: mitmproxy is not required 10:14:59 INFO - Running post-action listener: _resource_record_post_action 10:14:59 INFO - [mozharness: 2017-06-01 17:14:59.673302Z] Finished setup-mitmproxy step (success) 10:14:59 INFO - [mozharness: 2017-06-01 17:14:59.673587Z] Running run-tests step. 10:14:59 INFO - Running pre-action listener: _resource_record_pre_action 10:14:59 INFO - Running main action method: run_tests 10:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:59 INFO - Python 2.7.3 10:14:59 INFO - Return code: 0 10:14:59 INFO - grabbing minidump binary from tooltool 10:14:59 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')]} 10:14:59 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 0xe45840>, '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 0xe46740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe46bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:59 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 10:14:59 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 10:14:59 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 10:14:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:59 INFO - Return code: 0 10:14:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:14:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:59 INFO - ENV: RUST_BACKTRACE is now 1 10:14:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:14:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:59 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/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 10:14:59 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/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 10:14:59 INFO - Using env: {'DISPLAY': ':0', 10:14:59 INFO - 'HOME': '/home/cltbld', 10:14:59 INFO - 'LANG': 'en_US.UTF-8', 10:14:59 INFO - 'LANGUAGE': 'en_US:en', 10:14:59 INFO - 'LOGNAME': 'cltbld', 10:14:59 INFO - 'MAIL': '/var/mail/cltbld', 10:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:59 INFO - 'MOZ_NO_REMOTE': '1', 10:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:59 INFO - 'NO_EM_RESTART': '1', 10:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:59 INFO - 'PWD': '/builds/slave/test', 10:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:59 INFO - 'RUST_BACKTRACE': '1', 10:14:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:14:59 INFO - 'SHELL': '/bin/bash', 10:14:59 INFO - 'SHLVL': '1', 10:14:59 INFO - 'TERM': 'linux', 10:14:59 INFO - 'TMOUT': '86400', 10:14:59 INFO - 'USER': 'cltbld', 10:14:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905', 10:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:59 INFO - '_': '/tools/buildbot/bin/python'} 10:14:59 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/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 10:14:59 INFO - mozversion application_buildid: 20170601164422 10:14:59 INFO - mozversion application_changeset: 0e9853e31da9848ab638bdd0df4eb734a5ebc232 10:14:59 INFO - mozversion application_display_name: Nightly 10:14:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:59 INFO - mozversion application_name: Firefox 10:14:59 INFO - mozversion application_remotingname: firefox 10:14:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:14:59 INFO - mozversion application_vendor: Mozilla 10:14:59 INFO - mozversion application_version: 55.0a1 10:14:59 INFO - mozversion platform_buildid: 20170601164422 10:14:59 INFO - mozversion platform_changeset: 0e9853e31da9848ab638bdd0df4eb734a5ebc232 10:14:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:14:59 INFO - mozversion platform_version: 55.0a1 10:14:59 INFO - using testdate: 1496337299 10:14:59 INFO - actual date: 1496337299 10:14:59 INFO - starting webserver on 'localhost:51105' 10:14:59 INFO - SUITE-START | Running 2 tests 10:14:59 INFO - TEST-START | dromaeo_css 10:14:59 INFO - operating with platform_type : linux_ 10:14:59 INFO - Initialising browser for dromaeo_css test... 10:15:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51105/getInfo.html -profile /tmp/tmpM2id7i/profile 10:15:00 INFO - TEST-INFO | started process 22514 (/builds/slave/test/build/application/firefox/firefox http://localhost:51105/getInfo.html) 10:15:35 INFO - TEST-INFO | 22514: killed by SIGTERM 10:15:35 INFO - Browser initialized. 10:15:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:35 INFO - TEST-INFO | started process 22723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM2id7i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:47 INFO - PID 22723 | RSS: Main: 184258560 10:15:47 INFO - PID 22723 | 10:18:51 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51105/tests/dromaeo/cssquery-ext.html) 10:18:52 INFO - PID 22723 | RSS: Main: 177954816 10:18:52 INFO - PID 22723 | 10:21:54 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-ext.html (next: http://localhost:51105/tests/dromaeo/cssquery-jquery.html) 10:21:55 INFO - PID 22723 | RSS: Main: 185688064 10:21:55 INFO - PID 22723 | 10:24:57 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51105/tests/dromaeo/cssquery-mootools.html) 10:24:57 INFO - PID 22723 | RSS: Main: 182558720 10:24:57 INFO - PID 22723 | 10:27:59 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51105/tests/dromaeo/cssquery-prototype.html) 10:28:00 INFO - PID 22723 | RSS: Main: 187088896 10:28:00 INFO - PID 22723 | 10:31:03 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51105/tests/dromaeo/cssquery-yui.html) 10:31:04 INFO - PID 22723 | RSS: Main: 183898112 10:31:04 INFO - PID 22723 | 10:34:05 INFO - PID 22723 | Cycle 1(1): loaded http://localhost:51105/tests/dromaeo/cssquery-yui.html (next: http://localhost:51105/tests/dromaeo/cssquery-dojo.html) 10:34:06 INFO - PID 22723 | RSS: Main: 183300096 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | __start_tp_report 10:34:06 INFO - PID 22723 | _x_x_mozilla_page_load 10:34:06 INFO - PID 22723 | _x_x_mozilla_page_load_details 10:34:06 INFO - PID 22723 | |i|pagename|runs| 10:34:06 INFO - PID 22723 | |0;dojo.html;2686.905958291458;2704.3915119098206;2721.4012917158225;2728.222456599869;2728.4679487499934;5255.316808814849;5322.387925388577;5367.248585198071;5377.435369286227;5386.11129163688;5260.342457192851;5328.440513746059;5348.090824559825;5358.678479291236;5404.702741349234;4731.4795372509;4739.526047395268;4763.952360476403;4770.30830529573;4812.903741925159;4785.090832741768;4797.90404191916;4849.854504364875;4850.126977144113;4889.413270407556;4668.486466488684;4694.976525117387;4762.023785124041;4772.665913386064;4848.030393921213;4615.792289346988;4729.408823897013;4740.360051393052;4750.809967601292;4804.063207674505;4735.147673418784;4744.739039352834;4746.52534746526;4756.191447453941;4765;5170.586353091781;5236.423993360727;5278.47215278473;5334.893302133974;5377.7580008899695;5674.3190817101795;5726.398728133528;5780.699342647913;5783.045797443417;5807.535397168216;5860.238169038041;5869.06095024794;5876.853078673024;5882.411758824083;5890.558208134365;5421.728913554307;5434;5440.347158341025;5448.318960129984;5454.290942177491;5702.429757024264;5806.332271788799;5869.383714709979;5950.494207992283;5973.671448070311;5621.80323688669;5663.320401551758;5674.602777805597;5674.773009079673;5692.658440493584;5593.300837395325;5715.599908006399;5722.2561067061015;5727.255456790674;5740.56945729072;5632.971835140798;5679.886402271932;5681.772729090872;5698.458646428583;5702.173184888168;5648.604597678123;5653.378128405872;5660.660360378391;5737;5766.192733017381;4827.782749776268;4847.563719265283;4847.95152048482;4850.490698476609;4867.58625516835;4122.3404255319;4144.33690609501;4157.542670306264;4177.143685544517;4204.579542045833;4804.687695299865;4878.414590249193;4888.975555122272;4893.486183950705;4899.314096026559;5671.064274394678;5702.914456283159;5727.570432217601;5730.512906402919;5822.359540450631;4916.0905232532095;4918.95081049185;4921.729304888266;4928.827491037868;4965.155923493015;5153.7165455900285;5154.871128221749;5157.638965272395;5162.174052151713;5196.090684130338;5252.579793616578;5282.049231138432;5339.519443250126;5354.839354819362;5388;5683.857903552444;5766.019776638065;5800.216970708901;5839.795607153729;5850.473457388685;5155.690658560498;5341.572674186134;5342.626016178986;5350.919736204038;5357.1696387060065;5674.205611214351;5678.3186017678145;5683.374828768915;5728.169415434655;5728.997425450613;5756;5775.884482310415;5793.217915581511;5795.130730390475;5807;5541.224228607917;5593.0771422716425;5601.971990140023;5602.103663413997;5616.550675945996;5636.957162924872;5638.633488823213;5658.632188907708;5661.235733176133;5710.457506536873;5514.696691681996;5542.0855558832345;5555.999920014275;5559.6664200148125;5577.191307260506;5483.506484416422;5526.22632831412;5657.349404818334;5673.517750991212;5694.202811606461;5525.557955363481;5527.309086364205;5554.222408862682;5561.916571251515;5576.052071147996 10:34:06 INFO - PID 22723 | |1;ext.html;711.8505113926075;767.9500832445891;785.1873311122989;1098.9614814000772;1105.0772604874928;32615;33669;33701.157471063176;33750.662493375086;33763.66236337636;35320.47019294706;35655;35696.821515892385;35721;35725.285494290096;6453.8709225815455;6620.569662971891;6911.101556797622;7048;7049.259827718092;6573.1783527059115;6604.735810567596;6664.2002959644915;6666.899996500057;6671.332866713338;6612.43794277487;6629.535932484728;6647.20233571972;6671.532992690513;6673.165854268216;6602.075709400664;6639.302873198317;6642.734290628369;6660.70026848793;6672.699728512229;6560.770373036921;6616.867662646769;6623.072769812182;6627.536072474929;6637.137172167587;31206;31287.84356078205;31311.21721956969;31507.21231969196;31551.684483155102;3060.20434686983;3095.860686269101;3099.7210251077286;3101.6898310169026;3101.922451938697;24442;24444.266671999692;24455.510889782105;24505.50988980228;24523.01907923681;3013.547967804825;3046.6344038715497;3049.2072061264007;3063.0657649416917;3115.361350923078;127162.36418817847;129667.35166324202;137378.6262137376;143341;143631;38739.41890871583;38983.73719547882;39063.41404878929;39107.41338879919;39188.06089543296;40697.38953915694;40715.7964210183;40742.79628601838;40811.79594102011;40866.1826763469;12921.289329086803;12936.547220847226;12936.935315323362;13029.609111726664;13037.282949437682;10471.057604815604;10569.260151789302;10572.52423640938;10575.36547807134;10599.523021464052;12666.366681666064;12687.619371418872;12731.363431828557;12738.55415060487;12948.352582371032;5200.739963001834;5286.20706893969;5312.096943519611;5313.521783039545;5329.360476742816;840.2689659995842;867.7873920889297;879.5558243087328;887.3389324952951;914.7804526913493;19976.10585406585;20334.89832550828;25481.362965926;26931.19206423771;27067.593986090225;938.5541867612966;942.6135284533308;952.1858810716737;955.0393779284302;955.6320816485703;11021.173411994132;11355.54577816878;11365.318080915005;11401.087912966943;11428.657140285804;176719.11640441715;178896;179136.10431947757;179823;180662;40921.590784092376;40995.795021025304;41031.589684103375;41035.7948210263;41067;1196.904247660185;1213.2902252182396;1215.1676101870248;1220.0239808153442;1222.4376786678229;19493.415197544095;19884.304049358205;20129.899350503154;21173.7882621178;24180.879095605113;37009.81495092507;37989.24021519609;38076;38085.80957095197;39433.21133577255;165756;167807.1609641944;167819;167995;168343;29733.405331893675;29949.251268718457;30318.545221822133;30620;30759.2310192247;35637.82181089078;36998.8150059248;37207;37255.44116838304;38041;27299.181024569294;27883;28042;28246.71753282441;28805;27695;27782.166535003984;28279.71720282853;29048;29143.125706228846;31308.686913130576;31357;31362.21594460157;31518;31520.36959260756;25797.581133037864;27248.318792030357;27959.440811184068;27985.720142798313;29607.85196074006;21387.8930605346;22577.548449031256;22927.54144917059;23005.194818181284;23088.53822923566 10:34:06 INFO - PID 22723 | |2;jquery.html;399.59640762829554;402.24620653948796;419.5992826850358;422.9788510574472;434.8608445297504;17374.305027798888;17946.641067178665;17990.37033703822;19457.708134377997;20373;17107.74338384922;17414.738778918327;17416.56458588536;17429.82570174301;17453.7381939271;5655.8586035349135;5795.275590551181;5795.82612521625;5797.884042319151;5809;5615.606907516475;5620.297462817148;5630.71846407678;5633.63381380211;5644.322681278252;5560.944390556103;5602.7758889644365;5615.354234263071;5620.156976453523;5650.0959846424585;4903.362562866804;4905.068037072962;4910.7299098549565;4938.234573641092;4946.109700253953;4429.911401771947;4471.82112715491;4478.529754375776;4489.438820147481;4504.752238626874;23488.53022939549;23656.1720339789;23685;23868.40328991772;23877;1600.9839901601067;1612.290592139455;1613.8547530722174;1630.79615048119;1634.0032580126115;15114.697706045818;15128.470503532324;15474.148921809408;15666.686666266725;15775.13236771977;2012;2031.492126968258;2048.98975505123;2050.1799280287855;2140.882251476168;91312.5434372824;95754.52122739411;99626.50186749092;108932;111830;10731.941396701903;11005.339679619248;11063.74482104534;11084.556617735361;11184.552617895355;14865.2567371631;14997.475088371855;15168;15198.696026079417;15207.847921520864;7552.848943021108;7670.117936437381;7729.381649468029;7765.1846556110795;7862.921370786334;7134.179569349488;7167.89248161278;7190.856182876418;7272.345488906024;7283.053203083671;7187.928120718726;7273.745418910418;7276.544691061808;7316.926830731731;7338.376238019721;1913.1868955693774;1927.8554108441922;1929.7201905723873;1952.5216322000917;2132.508789866101;813.3655748516048;850.4769566716549;856.4005196362447;875.5009644502572;875.6366108065209;17727.29090836352;17974.460766177035;18668.813311866706;18868.24527018904;18870.433886983414;860.5525126933959;869.2698133567833;870.8301881133118;874.7594411536751;884.9424787388799;9737.513124343895;9799.853002204973;9831.950840245896;10089.780248345352;10172.796544069077;387580;390528;392311;392656;398329;86631.56684216538;88377.11622883817;89177.55411222903;89202;89276;907.6596276396351;1003.5985605757755;1027.111548510548;1032.1020711980625;1056.0864851903048;18250;18539.81460185435;18831.15259813284;19190.889002209467;19337.51656208606;42901.78549107235;43265;43407.782961084995;43781;44067.33898991453;53324.73337633442;53485;53799.392097265816;54129.72935135299;54186.72906635442;8702.17254376588;9400.764980875532;9531.094546018394;9536.094071063239;9544.093311135432;16223.675526489167;16286.185690715654;16384.590385240463;16401;16527.173641318128;13885.930570347084;13975.93012034974;13978.860211397756;14016;14128.152310861382;11610.129240306842;11628.94185529067;12420.254784712946;12580.370981450707;12605.495780169058;13132.606021819362;13404.195748255135;13419.530316438877;13449.260290684106;13457.528986485426;9104.271658267455;9431.811363772824;9885.703428897144;9898.802023959337;9986.750331241778;13955.930220349239;13963.30183490801;13969.511067112602;14086.929565352517;14114.36485358182 10:34:06 INFO - PID 22723 | |3;mootools.html;1242.2484396939851;1293.9353032348392;1299.59062895188;1314.290283247047;1314.7567699975505;10396.532156052977;10425.113865321448;10724.088452481528;10929;10931.398773067489;10240.180785537157;10487.58049678012;10507.21195910306;10517.421541815198;10557.366558006524;2069.224040984631;2109.704641350212;2114.6299397605358;2118.766935637079;2125.7767934366902;2078.0856423173755;2108.9156433742633;2113.0913707105938;2117.819985301251;2121;2009.4775358406773;2034.4201902457803;2035.9491012724727;2048.621005114059;2057.423921302038;1988.93038743644;1997.6803711406178;1999.4301624037153;2003.1286390420214;2006.7190593316948;1807.9638407231914;1883.2372888979985;1925.4416219296527;1943.416974907522;2036.6741321388506;10816.837747433794;10887;10901.563937442572;10903.29128606638;10933.18001149909;5487.917681234785;5744.425557444264;5747.568932330092;5753.827385178452;5764.596478246524;3198.296374797541;3326.3181047885128;3380.3577320309064;3381.205416727067;3397.2695870387984;1020.7805321855836;1022.284400919352;1035.6323505155638;1038.948052597367;1040.9843852342221;15736.685266294724;15775.605609859731;15925.044497330313;15945.601359965978;15973.041617502871;4753.33453316536;4893.828715994923;5020.874478138076;5053.292539044537;5073.213651883964;11806.232594881305;11810.527578896748;11822.231554948901;11829;11834.171607987359;5418.485243901823;5564.443555644403;5621.156826476062;5622.212890195376;5632.324121105412;5107.897842043139;5145;5180.844574662766;5186.559142472932;5199.376074870964;3871.9612803872164;3951.5455722591696;4002.69979751514;4056.3915412687743;4084.203580301872;1040.3029969920171;1052.5894900988621;1059.7933402986343;1060.4273692206277;1068.417712346773;650.7462089784988;671.6473851228144;681.3459079283942;691.3294104718415;696.6168607266085;5183.092958732207;5299.602529810202;5322.520973112361;5401.2168235606405;5585.469380408855;516.3055690096813;532.5127508329834;540.6620861961275;541.8591166296791;542.4873494547694;2949.122911576005;3277.655846136169;3433.8626454942023;3445.7243420526297;3539.3629146753833;13430.93284533571;13607.863921360859;13898.374573144232;13991.30043497821;14001.369938352798;13664.863351366557;13673.863261367458;13874.722505549833;13897.513587024405;14037.78943315851;7495.475316727777;7590.1650818409935;7593.240675932362;7630.923690763132;7633.770986870402;5894.204282421818;5952.345242023461;5973.253343332083;6107.9389206109145;6145.446909778141;12009.819852702041;12041.277523348626;12235.32705701195;12266.877331226931;12650.746985060063;12645.93677031609;13121;13130.080894337687;13321.401431828242;13361.933190333986;8648.264897483532;8971.775705607412;8988.325875559229;9000.819983600422;9010.639574417211;9630.951845240728;9787.951060244653;9826.361286516354;9845.45849978258;9851.113399794052;8023.879641805494;8295.83408331818;8303.211194936472;8401.285890699115;8526.78683032929;8026;8226.218509241613;8251.83496330082;8275.586220688821;8323.667053318042;7172.13934327884;7252.057232559733;7257.419406447366;7284.053073100463;7288;4369.519352871245;4849.612031037438;4974.32846565709;5047.217681259411;5107.489251074863;5207.6875387476875;5212.452692467236;5253.9211911820585;5328.3605967284175;5354.330708661418 10:34:06 INFO - PID 22723 | |4;prototype.html;380.73158423311565;383.7122158381216;384.19702821103886;390.3637071573336;392.264504054897;5577.21918931349;5644.266245388099;5692.5161361284345;5708.657480551165;5710.202001019502;5500.1024646497;5634.9718251408685;5640.520555752756;5653.802116925908;5683.914741278873;4174.979125104385;4308;4315.093830295642;4317.740935543861;4335.436393268887;4309.26742453782;4316.54676258993;4320.07118469529;4338.002259480321;4339.023719663066;4283.057727300004;4291.7639529826;4296.892577685551;4297.548757380477;4312.353147027955;4278.315469524892;4281.7002809803325;4297.162053399573;4313.986213239886;4323.762193079379;3773.13217959868;3785.9810700946596;3806.600306967784;3807.9238415231816;3819.5416550014174;5506.174073888908;5509.917351239735;5525.226468294442;5545.944540554624;5582.218489411485;5031.044101620717;5072.873178170538;5078.238264260353;5097.439281679012;5115.360579927509;6004.669743164124;6007.8197654070445;6010.333696445165;6013.278406591194;6016.533221379257;4237.936430953539;4253.659707223414;4256.893577660552;4257.084726783725;4267.4025636410925;5947.1971283876555;6308.842278943017;6312.936870631281;6349.682515874188;6425.421712045892;4235.682323825664;4245.80893859777;4252.617264446215;4267.935980960288;4284.078923031501;4301.827926882889;4312.331588603772;4317.424140188871;4332.1119170569955;4343.741254547617;4821.662483626113;4949.133901567211;4975.800967961313;4979.925301120486;4981.576565991859;5920.940790592039;5944.970275148683;5957.493613042853;5976;5977.760889564369;1512.9697406051816;1518.8708959738326;1526.0462211118052;1526.1834918318646;1528.9235538223045;1000.3447741729179;1006.8187726209206;1033.493588141805;1043.280136705686;1046.4035499765214;5089.491050894881;5109.233614957786;5127.666701664454;5135;5151.922721159111;6099.786507472217;6201.503879689614;6226.62640241587;6229.96885015572;6255.185996061091;5088.516590923857;5095.8726031848755;5116.744162791845;5142.485751424828;5164.948350516522;3242.5460435539044;3287.6876696713775;3291.8683252670103;3303.966960330414;3312.6190488093694;5711.657300561979;5713.6857472838565;5715;5722.570807189478;5725.742341594639;6310.242770867433;6323.27282362525;6333.366663333722;6346.333634968354;6383;5688.383343661879;5691.857703557362;5703.230063941315;5716.742746576331;5725.971370143123;6130.01919692847;6169.413905678954;6200.255969283535;6209.720562574605;6225.3774622537385;6047.455728984412;6102.2067131274425;6107.236595425572;6110.358412366815;6112.751637611817;5306.602004849729;5484.533814625802;5632.464915832989;5686.545076393962;5722.656640601577;4294.613484786384;4302.376155457378;4316.352547117957;4326.65386769064;4328.156009578102;6140.969295153495;6142.539309551712;6152.908011276188;6172.135900973777;6175.197224360804;5748.626339287933;5956.612820166675;5982.581219314607;5984.760609575568;6001.90997135052;5975.16347711312;5983.311919129182;5989.66919441706;5993.6403815769445;6000.309964354155;5885.087811389241;5908.261467316585;5914.852128696817;5918.254115035988;5925.200097986716;6010.2186715726675;6021.969890150521;6024.5481588881885;6029.427204415749;6052.243469566304;5849.766009359578;5868.2077919480325;5868.559858010581;5880.529557635465;5906.940930590639 10:34:06 INFO - PID 22723 | |5;yui.html;736.2821249281955;750.2947229604173;756.8940348351229;766.1457474915471;768.8616049111158;13252.13861099028;13802.654933626653;13982.860171398283;15309.23453827307;16523.66952660946;15069.171195584238;15150.16674082925;15157;15202;15231.92384038081;872.489593587752;886.8536691445904;888.8488956877346;891.7815135291862;893.307686542928;822.0792712162387;881.5988725130082;882.9337799665051;896.6323807239033;902.0303174087882;930.5486838883136;944.117250370902;944.38614900315;944.631593678466;944.7543638653965;933.2300851797261;936.3913456253422;942.1944237676756;944.4050248343568;944.8204841080208;685.7976896815402;690.2476300832117;692.4460431654657;695.9860802783967;696.2271878215178;13752.793708094387;13800.240986745725;13842.30788460583;13887.79168312466;13907.652308692364;15444.382224710998;15951.042937423676;15981;16053.357865685359;16064.518064458085;12902.54841080567;12918.22490650564;13291.667708307274;13323.666908327272;13371.33143342829;3070.892518761855;3079.076277116856;3086.907392778198;3088.258817883714;3091.9072427826977;84813;85405;86842.56578717066;87769;88078.6788198184;12835.550755723505;12952.611421657366;13040.54358097462;13169.868301316865;13227.66930826737;22807.973641186185;23244;23262.53474930492;23265.302040938797;23279.068837246657;6389.488840892717;6401.071844582602;6458.644774537445;6578.80263592093;6601.141851559267;3145.4338219120777;3218.1954511372155;3220.5813244278092;3222.5005124205786;3222.854971526287;4134.338505839111;4371.169477799208;4420.911581768347;4425.535318791481;4429.424174857248;780.2236774409499;790.541485938166;805.899262592176;806.3388021822167;807.3097501636016;556.4546744190716;581.4674611404115;588.9734961926723;588.9764409423575;590.2415396215843;10103.797924041479;10120.848187277197;10543.367397956146;11084.722881928017;11426.714332141762;575.206215422714;578.0606514414077;584.3484514766005;588.3880764005472;598.2223109957125;4761;4985.950140498621;5018.84943451697;5091.338126043591;5108.540231379194;78693.34373218942;78903.21096788958;79073.60463197647;80443.59778201072;90057.09942900487;69868;71158;71200.64399678072;72876.63561682263;73127;60690.696546516985;62065.68967155226;63336;63413;65385.34614653792;10158.12074766141;10382.428966406618;10603.098736607475;10630.043296103078;10778.838317425088;27262.454750905268;27912.58131127994;28155;28259.293517662223;28707.85646071756;34676.65323346734;52917;53653;54664;55478.72260638671;14894;15122.243887805345;15147.54557363281;15338.923305383401;15665.765013525035;16702.248398822325;16707.331706732082;16965.91517042407;17075.48773536796;17316.826831732025;15071.773923390938;15637;15659;16402.425915092914;16725.247363868897;13832;14071.437142514185;14100.506482273071;14250.857491424953;14296.356663949939;14836.7774483385;15720.371185152466;15884.761728573849;16110.838891611404;16278.43025494102;9787.706368808947;9985;10212.08091271789;10271.383716976707;10594.4702764863;10930.453477325942;11237.91841860977;11999.700007499534;12720.74558508843;12846.293453860128 10:34:06 INFO - PID 22723 | __end_tp_report 10:34:06 INFO - PID 22723 | __start_cc_report 10:34:06 INFO - PID 22723 | _x_x_mozilla_cycle_collect,398 10:34:06 INFO - PID 22723 | __end_cc_report 10:34:06 INFO - PID 22723 | __startTimestamp1496338446140__endTimestamp 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | ------- Summary: start ------- 10:34:06 INFO - PID 22723 | Number of tests: 6 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#0] dojo.html Cycles:165 Average:5264.84 Median:5440.35 stddev:622.50 (11.4%) stddev-sans-first:590.65 10:34:06 INFO - PID 22723 | Values: 2686.9 2704.4 2721.4 2728.2 2728.5 5255.3 5322.4 5367.2 5377.4 5386.1 5260.3 5328.4 5348.1 5358.7 5404.7 4731.5 4739.5 4764.0 4770.3 4812.9 4785.1 4797.9 4849.9 4850.1 4889.4 4668.5 4695.0 4762.0 4772.7 4848.0 4615.8 4729.4 4740.4 4750.8 4804.1 4735.1 4744.7 4746.5 4756.2 4765.0 5170.6 5236.4 5278.5 5334.9 5377.8 5674.3 5726.4 5780.7 5783.0 5807.5 5860.2 5869.1 5876.9 5882.4 5890.6 5421.7 5434.0 5440.3 5448.3 5454.3 5702.4 5806.3 5869.4 5950.5 5973.7 5621.8 5663.3 5674.6 5674.8 5692.7 5593.3 5715.6 5722.3 5727.3 5740.6 5633.0 5679.9 5681.8 5698.5 5702.2 5648.6 5653.4 5660.7 5737.0 5766.2 4827.8 4847.6 4848.0 4850.5 4867.6 4122.3 4144.3 4157.5 4177.1 4204.6 4804.7 4878.4 4889.0 4893.5 4899.3 5671.1 5702.9 5727.6 5730.5 5822.4 4916.1 4919.0 4921.7 4928.8 4965.2 5153.7 5154.9 5157.6 5162.2 5196.1 5252.6 5282.0 5339.5 5354.8 5388.0 5683.9 5766.0 5800.2 5839.8 5850.5 5155.7 5341.6 5342.6 5350.9 5357.2 5674.2 5678.3 5683.4 5728.2 5729.0 5756.0 5775.9 5793.2 5795.1 5807.0 5541.2 5593.1 5602.0 5602.1 5616.6 5637.0 5638.6 5658.6 5661.2 5710.5 5514.7 5542.1 5556.0 5559.7 5577.2 5483.5 5526.2 5657.3 5673.5 5694.2 5525.6 5527.3 5554.2 5561.9 5576.1 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#1] ext.html Cycles:180 Average:30929.08 Median:3108.64 stddev:41821.41 (1345.3%) stddev-sans-first:41877.17 10:34:06 INFO - PID 22723 | Values: 711.9 768.0 785.2 1099.0 1105.1 32615.0 33669.0 33701.2 33750.7 33763.7 35320.5 35655.0 35696.8 35721.0 35725.3 6453.9 6620.6 6911.1 7048.0 7049.3 6573.2 6604.7 6664.2 6666.9 6671.3 6612.4 6629.5 6647.2 6671.5 6673.2 6602.1 6639.3 6642.7 6660.7 6672.7 6560.8 6616.9 6623.1 6627.5 6637.1 31206.0 31287.8 31311.2 31507.2 31551.7 3060.2 3095.9 3099.7 3101.7 3101.9 24442.0 24444.3 24455.5 24505.5 24523.0 3013.5 3046.6 3049.2 3063.1 3115.4 127162.4 129667.4 137378.6 143341.0 143631.0 38739.4 38983.7 39063.4 39107.4 39188.1 40697.4 40715.8 40742.8 40811.8 40866.2 12921.3 12936.5 12936.9 13029.6 13037.3 10471.1 10569.3 10572.5 10575.4 10599.5 12666.4 12687.6 12731.4 12738.6 12948.4 5200.7 5286.2 5312.1 5313.5 5329.4 840.3 867.8 879.6 887.3 914.8 19976.1 20334.9 25481.4 26931.2 27067.6 938.6 942.6 952.2 955.0 955.6 11021.2 11355.5 11365.3 11401.1 11428.7 176719.1 178896.0 179136.1 179823.0 180662.0 40921.6 40995.8 41031.6 41035.8 41067.0 1196.9 1213.3 1215.2 1220.0 1222.4 19493.4 19884.3 20129.9 21173.8 24180.9 37009.8 37989.2 38076.0 38085.8 39433.2 165756.0 167807.2 167819.0 167995.0 168343.0 29733.4 29949.3 30318.5 30620.0 30759.2 35637.8 36998.8 37207.0 37255.4 38041.0 27299.2 27883.0 28042.0 28246.7 28805.0 27695.0 27782.2 28279.7 29048.0 29143.1 31308.7 31357.0 31362.2 31518.0 31520.4 25797.6 27248.3 27959.4 27985.7 29607.9 21387.9 22577.5 22927.5 23005.2 23088.5 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#2] jquery.html Cycles:180 Average:27064.52 Median:392483.50 stddev:65712.72 (16.7%) stddev-sans-first:65866.56 10:34:06 INFO - PID 22723 | Values: 399.6 402.2 419.6 423.0 434.9 17374.3 17946.6 17990.4 19457.7 20373.0 17107.7 17414.7 17416.6 17429.8 17453.7 5655.9 5795.3 5795.8 5797.9 5809.0 5615.6 5620.3 5630.7 5633.6 5644.3 5560.9 5602.8 5615.4 5620.2 5650.1 4903.4 4905.1 4910.7 4938.2 4946.1 4429.9 4471.8 4478.5 4489.4 4504.8 23488.5 23656.2 23685.0 23868.4 23877.0 1601.0 1612.3 1613.9 1630.8 1634.0 15114.7 15128.5 15474.1 15666.7 15775.1 2012.0 2031.5 2049.0 2050.2 2140.9 91312.5 95754.5 99626.5 108932.0 111830.0 10731.9 11005.3 11063.7 11084.6 11184.6 14865.3 14997.5 15168.0 15198.7 15207.8 7552.8 7670.1 7729.4 7765.2 7862.9 7134.2 7167.9 7190.9 7272.3 7283.1 7187.9 7273.7 7276.5 7316.9 7338.4 1913.2 1927.9 1929.7 1952.5 2132.5 813.4 850.5 856.4 875.5 875.6 17727.3 17974.5 18668.8 18868.2 18870.4 860.6 869.3 870.8 874.8 884.9 9737.5 9799.9 9832.0 10089.8 10172.8 387580.0 390528.0 392311.0 392656.0 398329.0 86631.6 88377.1 89177.6 89202.0 89276.0 907.7 1003.6 1027.1 1032.1 1056.1 18250.0 18539.8 18831.2 19190.9 19337.5 42901.8 43265.0 43407.8 43781.0 44067.3 53324.7 53485.0 53799.4 54129.7 54186.7 8702.2 9400.8 9531.1 9536.1 9544.1 16223.7 16286.2 16384.6 16401.0 16527.2 13885.9 13975.9 13978.9 14016.0 14128.2 11610.1 11628.9 12420.3 12580.4 12605.5 13132.6 13404.2 13419.5 13449.3 13457.5 9104.3 9431.8 9885.7 9898.8 9986.8 13955.9 13963.3 13969.5 14086.9 14114.4 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#3] mootools.html Cycles:180 Average:6419.75 Median:3389.24 stddev:4328.22 (127.7%) stddev-sans-first:4322.88 10:34:06 INFO - PID 22723 | Values: 1242.2 1293.9 1299.6 1314.3 1314.8 10396.5 10425.1 10724.1 10929.0 10931.4 10240.2 10487.6 10507.2 10517.4 10557.4 2069.2 2109.7 2114.6 2118.8 2125.8 2078.1 2108.9 2113.1 2117.8 2121.0 2009.5 2034.4 2035.9 2048.6 2057.4 1988.9 1997.7 1999.4 2003.1 2006.7 1808.0 1883.2 1925.4 1943.4 2036.7 10816.8 10887.0 10901.6 10903.3 10933.2 5487.9 5744.4 5747.6 5753.8 5764.6 3198.3 3326.3 3380.4 3381.2 3397.3 1020.8 1022.3 1035.6 1038.9 1041.0 15736.7 15775.6 15925.0 15945.6 15973.0 4753.3 4893.8 5020.9 5053.3 5073.2 11806.2 11810.5 11822.2 11829.0 11834.2 5418.5 5564.4 5621.2 5622.2 5632.3 5107.9 5145.0 5180.8 5186.6 5199.4 3872.0 3951.5 4002.7 4056.4 4084.2 1040.3 1052.6 1059.8 1060.4 1068.4 650.7 671.6 681.3 691.3 696.6 5183.1 5299.6 5322.5 5401.2 5585.5 516.3 532.5 540.7 541.9 542.5 2949.1 3277.7 3433.9 3445.7 3539.4 13430.9 13607.9 13898.4 13991.3 14001.4 13664.9 13673.9 13874.7 13897.5 14037.8 7495.5 7590.2 7593.2 7630.9 7633.8 5894.2 5952.3 5973.3 6107.9 6145.4 12009.8 12041.3 12235.3 12266.9 12650.7 12645.9 13121.0 13130.1 13321.4 13361.9 8648.3 8971.8 8988.3 9000.8 9010.6 9631.0 9788.0 9826.4 9845.5 9851.1 8023.9 8295.8 8303.2 8401.3 8526.8 8026.0 8226.2 8251.8 8275.6 8323.7 7172.1 7252.1 7257.4 7284.1 7288.0 4369.5 4849.6 4974.3 5047.2 5107.5 5207.7 5212.5 5253.9 5328.4 5354.3 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#4] prototype.html Cycles:180 Average:4928.01 Median:5535.59 stddev:1448.89 (26.2%) stddev-sans-first:1412.18 10:34:06 INFO - PID 22723 | Values: 380.7 383.7 384.2 390.4 392.3 5577.2 5644.3 5692.5 5708.7 5710.2 5500.1 5635.0 5640.5 5653.8 5683.9 4175.0 4308.0 4315.1 4317.7 4335.4 4309.3 4316.5 4320.1 4338.0 4339.0 4283.1 4291.8 4296.9 4297.5 4312.4 4278.3 4281.7 4297.2 4314.0 4323.8 3773.1 3786.0 3806.6 3807.9 3819.5 5506.2 5509.9 5525.2 5545.9 5582.2 5031.0 5072.9 5078.2 5097.4 5115.4 6004.7 6007.8 6010.3 6013.3 6016.5 4237.9 4253.7 4256.9 4257.1 4267.4 5947.2 6308.8 6312.9 6349.7 6425.4 4235.7 4245.8 4252.6 4267.9 4284.1 4301.8 4312.3 4317.4 4332.1 4343.7 4821.7 4949.1 4975.8 4979.9 4981.6 5920.9 5945.0 5957.5 5976.0 5977.8 1513.0 1518.9 1526.0 1526.2 1528.9 1000.3 1006.8 1033.5 1043.3 1046.4 5089.5 5109.2 5127.7 5135.0 5151.9 6099.8 6201.5 6226.6 6230.0 6255.2 5088.5 5095.9 5116.7 5142.5 5164.9 3242.5 3287.7 3291.9 3304.0 3312.6 5711.7 5713.7 5715.0 5722.6 5725.7 6310.2 6323.3 6333.4 6346.3 6383.0 5688.4 5691.9 5703.2 5716.7 5726.0 6130.0 6169.4 6200.3 6209.7 6225.4 6047.5 6102.2 6107.2 6110.4 6112.8 5306.6 5484.5 5632.5 5686.5 5722.7 4294.6 4302.4 4316.4 4326.7 4328.2 6141.0 6142.5 6152.9 6172.1 6175.2 5748.6 5956.6 5982.6 5984.8 6001.9 5975.2 5983.3 5989.7 5993.6 6000.3 5885.1 5908.3 5914.9 5918.3 5925.2 6010.2 6022.0 6024.5 6029.4 6052.2 5849.8 5868.2 5868.6 5880.5 5906.9 10:34:06 INFO - PID 22723 | 10:34:06 INFO - PID 22723 | [#5] yui.html Cycles:180 Average:17784.93 Median:3221.54 stddev:22924.29 (711.6%) stddev-sans-first:22952.85 10:34:06 INFO - PID 22723 | Values: 736.3 750.3 756.9 766.1 768.9 13252.1 13802.7 13982.9 15309.2 16523.7 15069.2 15150.2 15157.0 15202.0 15231.9 872.5 886.9 888.8 891.8 893.3 822.1 881.6 882.9 896.6 902.0 930.5 944.1 944.4 944.6 944.8 933.2 936.4 942.2 944.4 944.8 685.8 690.2 692.4 696.0 696.2 13752.8 13800.2 13842.3 13887.8 13907.7 15444.4 15951.0 15981.0 16053.4 16064.5 12902.5 12918.2 13291.7 13323.7 13371.3 3070.9 3079.1 3086.9 3088.3 3091.9 84813.0 85405.0 86842.6 87769.0 88078.7 12835.6 12952.6 13040.5 13169.9 13227.7 22808.0 23244.0 23262.5 23265.3 23279.1 6389.5 6401.1 6458.6 6578.8 6601.1 3145.4 3218.2 3220.6 3222.5 3222.9 4134.3 4371.2 4420.9 4425.5 4429.4 780.2 790.5 805.9 806.3 807.3 556.5 581.5 589.0 589.0 590.2 10103.8 10120.8 10543.4 11084.7 11426.7 575.2 578.1 584.3 588.4 598.2 4761.0 4986.0 5018.8 5091.3 5108.5 78693.3 78903.2 79073.6 80443.6 90057.1 69868.0 71158.0 71200.6 72876.6 73127.0 60690.7 62065.7 63336.0 63413.0 65385.3 10158.1 10382.4 10603.1 10630.0 10778.8 27262.5 27912.6 28155.0 28259.3 28707.9 34676.7 52917.0 53653.0 54664.0 55478.7 14894.0 15122.2 15147.5 15338.9 15665.8 16702.2 16707.3 16965.9 17075.5 17316.8 15071.8 15637.0 15659.0 16402.4 16725.2 13832.0 14071.4 14100.5 14250.9 14296.4 14836.8 15720.4 15884.8 16110.8 16278.4 9787.7 9985.0 10212.1 10271.4 10594.5 10930.5 11237.9 11999.7 12720.7 12846.3 10:34:06 INFO - PID 22723 | -------- Summary: end -------- 10:34:06 INFO - PID 22723 | 10:34:07 INFO - TEST-INFO | 22723: exit 0 10:34:07 INFO - TEST-OK | dromaeo_css | took 1147099ms 10:34:07 INFO - TEST-START | kraken 10:34:07 INFO - operating with platform_type : linux_ 10:34:07 INFO - Initialising browser for kraken test... 10:34:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51105/getInfo.html -profile /tmp/tmpIOFKLc/profile 10:34:07 INFO - TEST-INFO | started process 23130 (/builds/slave/test/build/application/firefox/firefox http://localhost:51105/getInfo.html) 10:34:41 INFO - TEST-INFO | 23130: killed by SIGTERM 10:34:42 INFO - Browser initialized. 10:34:42 INFO - Running cycle 1/1 for kraken test... 10:34:42 INFO - TEST-INFO | started process 23335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIOFKLc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:53 INFO - PID 23335 | RSS: Main: 184578048 10:34:53 INFO - PID 23335 | 10:34:56 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51105/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:57 INFO - PID 23335 | RSS: Main: 187883520 10:34:57 INFO - PID 23335 | 10:35:00 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51105/tests/kraken/driver.html?testName=audio-dft) 10:35:00 INFO - PID 23335 | RSS: Main: 186867712 10:35:00 INFO - PID 23335 | 10:35:03 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51105/tests/kraken/driver.html?testName=audio-fft) 10:35:04 INFO - PID 23335 | RSS: Main: 182345728 10:35:04 INFO - PID 23335 | 10:35:06 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51105/tests/kraken/driver.html?testName=audio-oscillator) 10:35:07 INFO - PID 23335 | RSS: Main: 183037952 10:35:07 INFO - PID 23335 | 10:35:09 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:09 INFO - PID 23335 | RSS: Main: 182939648 10:35:09 INFO - PID 23335 | 10:35:13 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51105/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:13 INFO - PID 23335 | RSS: Main: 184311808 10:35:13 INFO - PID 23335 | 10:35:17 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51105/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:17 INFO - PID 23335 | RSS: Main: 183504896 10:35:17 INFO - PID 23335 | 10:35:20 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51105/tests/kraken/driver.html?testName=json-parse-financial) 10:35:21 INFO - PID 23335 | RSS: Main: 183562240 10:35:21 INFO - PID 23335 | 10:35:22 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:23 INFO - PID 23335 | RSS: Main: 183472128 10:35:23 INFO - PID 23335 | 10:35:25 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:26 INFO - PID 23335 | RSS: Main: 183754752 10:35:26 INFO - PID 23335 | 10:35:28 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:29 INFO - PID 23335 | RSS: Main: 183160832 10:35:29 INFO - PID 23335 | 10:35:31 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:32 INFO - PID 23335 | RSS: Main: 183226368 10:35:32 INFO - PID 23335 | 10:35:35 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:36 INFO - PID 23335 | RSS: Main: 182931456 10:35:36 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | Cycle 1(1): loaded http://localhost:51105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51105/tests/kraken/driver.html?testName=ai-astar) 10:35:38 INFO - PID 23335 | RSS: Main: 184692736 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | __start_tp_report 10:35:38 INFO - PID 23335 | _x_x_mozilla_page_load 10:35:38 INFO - PID 23335 | _x_x_mozilla_page_load_details 10:35:38 INFO - PID 23335 | |i|pagename|runs| 10:35:38 INFO - PID 23335 | |0;ai-astar;105;109;111;110;109;112;111;113;117;111 10:35:38 INFO - PID 23335 | |1;audio-beat-detection;151;127;129;184;122;125;125;128;150;128 10:35:38 INFO - PID 23335 | |2;audio-dft;165;165;163;163;167;169;171;165;167;163 10:35:38 INFO - PID 23335 | |3;audio-fft;74;77;72;113;74;74;78;75;92;79 10:35:38 INFO - PID 23335 | |4;audio-oscillator;83;85;118;84;87;84;112;85;83;108 10:35:38 INFO - PID 23335 | |5;imaging-gaussian-blur;114;114;114;114;115;114;115;114;115;114 10:35:38 INFO - PID 23335 | |6;imaging-darkroom;150;151;150;152;149;151;151;159;151;151 10:35:38 INFO - PID 23335 | |7;imaging-desaturate;95;96;96;95;94;95;94;95;94;94 10:35:38 INFO - PID 23335 | |8;json-parse-financial;55;55;55;56;59;62;65;55;56;57 10:35:38 INFO - PID 23335 | |9;json-stringify-tinderbox;57;56;58;56;56;56;56;56;56;57 10:35:38 INFO - PID 23335 | |10;stanford-crypto-aes;87;91;86;92;87;87;91;103;121;88 10:35:38 INFO - PID 23335 | |11;stanford-crypto-ccm;142;139;130;139;133;137;128;131;138;142 10:35:38 INFO - PID 23335 | |12;stanford-crypto-pbkdf2;187;194;193;200;192;190;195;187;194;202 10:35:38 INFO - PID 23335 | |13;stanford-crypto-sha256-iterative;75;75;73;72;73;72;75;73;71;73 10:35:38 INFO - PID 23335 | __end_tp_report 10:35:38 INFO - PID 23335 | __start_cc_report 10:35:38 INFO - PID 23335 | _x_x_mozilla_cycle_collect,1028 10:35:38 INFO - PID 23335 | __end_cc_report 10:35:38 INFO - PID 23335 | __startTimestamp1496338538331__endTimestamp 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | ------- Summary: start ------- 10:35:38 INFO - PID 23335 | Number of tests: 14 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:3.08 (2.8%) stddev-sans-first:2.46 10:35:38 INFO - PID 23335 | Values: 105.0 109.0 111.0 110.0 109.0 112.0 111.0 113.0 117.0 111.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:128.50 stddev:19.47 (15.2%) stddev-sans-first:19.97 10:35:38 INFO - PID 23335 | Values: 151.0 127.0 129.0 184.0 122.0 125.0 125.0 128.0 150.0 128.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#2] audio-dft Cycles:10 Average:165.80 Median:166.00 stddev:2.70 (1.6%) stddev-sans-first:2.85 10:35:38 INFO - PID 23335 | Values: 165.0 165.0 163.0 163.0 167.0 169.0 171.0 165.0 167.0 163.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:12.64 (16.6%) stddev-sans-first:13.16 10:35:38 INFO - PID 23335 | Values: 74.0 77.0 72.0 113.0 74.0 74.0 78.0 75.0 92.0 79.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:84.00 stddev:13.89 (16.5%) stddev-sans-first:14.27 10:35:38 INFO - PID 23335 | Values: 83.0 85.0 118.0 84.0 87.0 84.0 112.0 85.0 83.0 108.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:35:38 INFO - PID 23335 | Values: 114.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 115.0 114.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:2.76 (1.8%) stddev-sans-first:2.87 10:35:38 INFO - PID 23335 | Values: 150.0 151.0 150.0 152.0 149.0 151.0 151.0 159.0 151.0 151.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 10:35:38 INFO - PID 23335 | Values: 95.0 96.0 96.0 95.0 94.0 95.0 94.0 95.0 94.0 94.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:3.47 (6.1%) stddev-sans-first:3.56 10:35:38 INFO - PID 23335 | Values: 55.0 55.0 55.0 56.0 59.0 62.0 65.0 55.0 56.0 57.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 10:35:38 INFO - PID 23335 | Values: 57.0 56.0 58.0 56.0 56.0 56.0 56.0 56.0 56.0 57.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:87.50 stddev:10.92 (12.5%) stddev-sans-first:11.35 10:35:38 INFO - PID 23335 | Values: 87.0 91.0 86.0 92.0 87.0 87.0 91.0 103.0 121.0 88.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:138.50 stddev:5.04 (3.6%) stddev-sans-first:4.84 10:35:38 INFO - PID 23335 | Values: 142.0 139.0 130.0 139.0 133.0 137.0 128.0 131.0 138.0 142.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:194.00 stddev:4.90 (2.5%) stddev-sans-first:4.62 10:35:38 INFO - PID 23335 | Values: 187.0 194.0 193.0 200.0 192.0 190.0 195.0 187.0 194.0 202.0 10:35:38 INFO - PID 23335 | 10:35:38 INFO - PID 23335 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:1.40 (1.9%) stddev-sans-first:1.32 10:35:38 INFO - PID 23335 | Values: 75.0 75.0 73.0 72.0 73.0 72.0 75.0 73.0 71.0 73.0 10:35:38 INFO - PID 23335 | -------- Summary: end -------- 10:35:38 INFO - PID 23335 | 10:35:39 INFO - TEST-INFO | 23335: exit 0 10:35:39 INFO - TEST-OK | kraken | took 92518ms 10:35:39 INFO - SUITE-END | took 1239s 10:35:40 INFO - Completed test suite (00:20:40) 10:35:40 INFO - javascript benchmark 10:35:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6920.704576584404, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.905958291458, 2704.3915119098206, 2721.4012917158225, 2728.222456599869, 2728.4679487499934, 5255.316808814849, 5322.387925388577, 5367.248585198071, 5377.435369286227, 5386.11129163688, 5260.342457192851, 5328.440513746059, 5348.090824559825, 5358.678479291236, 5404.702741349234, 4731.4795372509, 4739.526047395268, 4763.952360476403, 4770.30830529573, 4812.903741925159, 4785.090832741768, 4797.90404191916, 4849.854504364875, 4850.126977144113, 4889.413270407556, 4668.486466488684, 4694.976525117387, 4762.023785124041, 4772.665913386064, 4848.030393921213, 4615.792289346988, 4729.408823897013, 4740.360051393052, 4750.809967601292, 4804.063207674505, 4735.147673418784, 4744.739039352834, 4746.52534746526, 4756.191447453941, 4765.0, 5170.586353091781, 5236.423993360727, 5278.47215278473, 5334.893302133974, 5377.7580008899695, 5674.3190817101795, 5726.398728133528, 5780.699342647913, 5783.045797443417, 5807.535397168216, 5860.238169038041, 5869.06095024794, 5876.853078673024, 5882.411758824083, 5890.558208134365, 5421.728913554307, 5434.0, 5440.347158341025, 5448.318960129984, 5454.290942177491, 5702.429757024264, 5806.332271788799, 5869.383714709979, 5950.494207992283, 5973.671448070311, 5621.80323688669, 5663.320401551758, 5674.602777805597, 5674.773009079673, 5692.658440493584, 5593.300837395325, 5715.599908006399, 5722.2561067061015, 5727.255456790674, 5740.56945729072, 5632.971835140798, 5679.886402271932, 5681.772729090872, 5698.458646428583, 5702.173184888168, 5648.604597678123, 5653.378128405872, 5660.660360378391, 5737.0, 5766.192733017381, 4827.782749776268, 4847.563719265283, 4847.95152048482, 4850.490698476609, 4867.58625516835, 4122.3404255319, 4144.33690609501, 4157.542670306264, 4177.143685544517, 4204.579542045833, 4804.687695299865, 4878.414590249193, 4888.975555122272, 4893.486183950705, 4899.314096026559, 5671.064274394678, 5702.914456283159, 5727.570432217601, 5730.512906402919, 5822.359540450631, 4916.0905232532095, 4918.95081049185, 4921.729304888266, 4928.827491037868, 4965.155923493015, 5153.7165455900285, 5154.871128221749, 5157.638965272395, 5162.174052151713, 5196.090684130338, 5252.579793616578, 5282.049231138432, 5339.519443250126, 5354.839354819362, 5388.0, 5683.857903552444, 5766.019776638065, 5800.216970708901, 5839.795607153729, 5850.473457388685, 5155.690658560498, 5341.572674186134, 5342.626016178986, 5350.919736204038, 5357.1696387060065, 5674.205611214351, 5678.3186017678145, 5683.374828768915, 5728.169415434655, 5728.997425450613, 5756.0, 5775.884482310415, 5793.217915581511, 5795.130730390475, 5807.0, 5541.224228607917, 5593.0771422716425, 5601.971990140023, 5602.103663413997, 5616.550675945996, 5636.957162924872, 5638.633488823213, 5658.632188907708, 5661.235733176133, 5710.457506536873, 5514.696691681996, 5542.0855558832345, 5555.999920014275, 5559.6664200148125, 5577.191307260506, 5483.506484416422, 5526.22632831412, 5657.349404818334, 5673.517750991212, 5694.202811606461, 5525.557955363481, 5527.309086364205, 5554.222408862682, 5561.916571251515, 5576.052071147996], "value": 5218.590981016963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8505113926075, 767.9500832445891, 785.1873311122989, 1098.9614814000772, 1105.0772604874928, 32615.0, 33669.0, 33701.157471063176, 33750.662493375086, 33763.66236337636, 35320.47019294706, 35655.0, 35696.821515892385, 35721.0, 35725.285494290096, 6453.8709225815455, 6620.569662971891, 6911.101556797622, 7048.0, 7049.259827718092, 6573.1783527059115, 6604.735810567596, 6664.2002959644915, 6666.899996500057, 6671.332866713338, 6612.43794277487, 6629.535932484728, 6647.20233571972, 6671.532992690513, 6673.165854268216, 6602.075709400664, 6639.302873198317, 6642.734290628369, 6660.70026848793, 6672.699728512229, 6560.770373036921, 6616.867662646769, 6623.072769812182, 6627.536072474929, 6637.137172167587, 31206.0, 31287.84356078205, 31311.21721956969, 31507.21231969196, 31551.684483155102, 3060.20434686983, 3095.860686269101, 3099.7210251077286, 3101.6898310169026, 3101.922451938697, 24442.0, 24444.266671999692, 24455.510889782105, 24505.50988980228, 24523.01907923681, 3013.547967804825, 3046.6344038715497, 3049.2072061264007, 3063.0657649416917, 3115.361350923078, 127162.36418817847, 129667.35166324202, 137378.6262137376, 143341.0, 143631.0, 38739.41890871583, 38983.73719547882, 39063.41404878929, 39107.41338879919, 39188.06089543296, 40697.38953915694, 40715.7964210183, 40742.79628601838, 40811.79594102011, 40866.1826763469, 12921.289329086803, 12936.547220847226, 12936.935315323362, 13029.609111726664, 13037.282949437682, 10471.057604815604, 10569.260151789302, 10572.52423640938, 10575.36547807134, 10599.523021464052, 12666.366681666064, 12687.619371418872, 12731.363431828557, 12738.55415060487, 12948.352582371032, 5200.739963001834, 5286.20706893969, 5312.096943519611, 5313.521783039545, 5329.360476742816, 840.2689659995842, 867.7873920889297, 879.5558243087328, 887.3389324952951, 914.7804526913493, 19976.10585406585, 20334.89832550828, 25481.362965926, 26931.19206423771, 27067.593986090225, 938.5541867612966, 942.6135284533308, 952.1858810716737, 955.0393779284302, 955.6320816485703, 11021.173411994132, 11355.54577816878, 11365.318080915005, 11401.087912966943, 11428.657140285804, 176719.11640441715, 178896.0, 179136.10431947757, 179823.0, 180662.0, 40921.590784092376, 40995.795021025304, 41031.589684103375, 41035.7948210263, 41067.0, 1196.904247660185, 1213.2902252182396, 1215.1676101870248, 1220.0239808153442, 1222.4376786678229, 19493.415197544095, 19884.304049358205, 20129.899350503154, 21173.7882621178, 24180.879095605113, 37009.81495092507, 37989.24021519609, 38076.0, 38085.80957095197, 39433.21133577255, 165756.0, 167807.1609641944, 167819.0, 167995.0, 168343.0, 29733.405331893675, 29949.251268718457, 30318.545221822133, 30620.0, 30759.2310192247, 35637.82181089078, 36998.8150059248, 37207.0, 37255.44116838304, 38041.0, 27299.181024569294, 27883.0, 28042.0, 28246.71753282441, 28805.0, 27695.0, 27782.166535003984, 28279.71720282853, 29048.0, 29143.125706228846, 31308.686913130576, 31357.0, 31362.21594460157, 31518.0, 31520.36959260756, 25797.581133037864, 27248.318792030357, 27959.440811184068, 27985.720142798313, 29607.85196074006, 21387.8930605346, 22577.548449031256, 22927.54144917059, 23005.194818181284, 23088.53822923566], "value": 14667.046526023574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.59640762829554, 402.24620653948796, 419.5992826850358, 422.9788510574472, 434.8608445297504, 17374.305027798888, 17946.641067178665, 17990.37033703822, 19457.708134377997, 20373.0, 17107.74338384922, 17414.738778918327, 17416.56458588536, 17429.82570174301, 17453.7381939271, 5655.8586035349135, 5795.275590551181, 5795.82612521625, 5797.884042319151, 5809.0, 5615.606907516475, 5620.297462817148, 5630.71846407678, 5633.63381380211, 5644.322681278252, 5560.944390556103, 5602.7758889644365, 5615.354234263071, 5620.156976453523, 5650.0959846424585, 4903.362562866804, 4905.068037072962, 4910.7299098549565, 4938.234573641092, 4946.109700253953, 4429.911401771947, 4471.82112715491, 4478.529754375776, 4489.438820147481, 4504.752238626874, 23488.53022939549, 23656.1720339789, 23685.0, 23868.40328991772, 23877.0, 1600.9839901601067, 1612.290592139455, 1613.8547530722174, 1630.79615048119, 1634.0032580126115, 15114.697706045818, 15128.470503532324, 15474.148921809408, 15666.686666266725, 15775.13236771977, 2012.0, 2031.492126968258, 2048.98975505123, 2050.1799280287855, 2140.882251476168, 91312.5434372824, 95754.52122739411, 99626.50186749092, 108932.0, 111830.0, 10731.941396701903, 11005.339679619248, 11063.74482104534, 11084.556617735361, 11184.552617895355, 14865.2567371631, 14997.475088371855, 15168.0, 15198.696026079417, 15207.847921520864, 7552.848943021108, 7670.117936437381, 7729.381649468029, 7765.1846556110795, 7862.921370786334, 7134.179569349488, 7167.89248161278, 7190.856182876418, 7272.345488906024, 7283.053203083671, 7187.928120718726, 7273.745418910418, 7276.544691061808, 7316.926830731731, 7338.376238019721, 1913.1868955693774, 1927.8554108441922, 1929.7201905723873, 1952.5216322000917, 2132.508789866101, 813.3655748516048, 850.4769566716549, 856.4005196362447, 875.5009644502572, 875.6366108065209, 17727.29090836352, 17974.460766177035, 18668.813311866706, 18868.24527018904, 18870.433886983414, 860.5525126933959, 869.2698133567833, 870.8301881133118, 874.7594411536751, 884.9424787388799, 9737.513124343895, 9799.853002204973, 9831.950840245896, 10089.780248345352, 10172.796544069077, 387580.0, 390528.0, 392311.0, 392656.0, 398329.0, 86631.56684216538, 88377.11622883817, 89177.55411222903, 89202.0, 89276.0, 907.6596276396351, 1003.5985605757755, 1027.111548510548, 1032.1020711980625, 1056.0864851903048, 18250.0, 18539.81460185435, 18831.15259813284, 19190.889002209467, 19337.51656208606, 42901.78549107235, 43265.0, 43407.782961084995, 43781.0, 44067.33898991453, 53324.73337633442, 53485.0, 53799.392097265816, 54129.72935135299, 54186.72906635442, 8702.17254376588, 9400.764980875532, 9531.094546018394, 9536.094071063239, 9544.093311135432, 16223.675526489167, 16286.185690715654, 16384.590385240463, 16401.0, 16527.173641318128, 13885.930570347084, 13975.93012034974, 13978.860211397756, 14016.0, 14128.152310861382, 11610.129240306842, 11628.94185529067, 12420.254784712946, 12580.370981450707, 12605.495780169058, 13132.606021819362, 13404.195748255135, 13419.530316438877, 13449.260290684106, 13457.528986485426, 9104.271658267455, 9431.811363772824, 9885.703428897144, 9898.802023959337, 9986.750331241778, 13955.930220349239, 13963.30183490801, 13969.511067112602, 14086.929565352517, 14114.36485358182], "value": 9347.086282124035, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.2484396939851, 1293.9353032348392, 1299.59062895188, 1314.290283247047, 1314.7567699975505, 10396.532156052977, 10425.113865321448, 10724.088452481528, 10929.0, 10931.398773067489, 10240.180785537157, 10487.58049678012, 10507.21195910306, 10517.421541815198, 10557.366558006524, 2069.224040984631, 2109.704641350212, 2114.6299397605358, 2118.766935637079, 2125.7767934366902, 2078.0856423173755, 2108.9156433742633, 2113.0913707105938, 2117.819985301251, 2121.0, 2009.4775358406773, 2034.4201902457803, 2035.9491012724727, 2048.621005114059, 2057.423921302038, 1988.93038743644, 1997.6803711406178, 1999.4301624037153, 2003.1286390420214, 2006.7190593316948, 1807.9638407231914, 1883.2372888979985, 1925.4416219296527, 1943.416974907522, 2036.6741321388506, 10816.837747433794, 10887.0, 10901.563937442572, 10903.29128606638, 10933.18001149909, 5487.917681234785, 5744.425557444264, 5747.568932330092, 5753.827385178452, 5764.596478246524, 3198.296374797541, 3326.3181047885128, 3380.3577320309064, 3381.205416727067, 3397.2695870387984, 1020.7805321855836, 1022.284400919352, 1035.6323505155638, 1038.948052597367, 1040.9843852342221, 15736.685266294724, 15775.605609859731, 15925.044497330313, 15945.601359965978, 15973.041617502871, 4753.33453316536, 4893.828715994923, 5020.874478138076, 5053.292539044537, 5073.213651883964, 11806.232594881305, 11810.527578896748, 11822.231554948901, 11829.0, 11834.171607987359, 5418.485243901823, 5564.443555644403, 5621.156826476062, 5622.212890195376, 5632.324121105412, 5107.897842043139, 5145.0, 5180.844574662766, 5186.559142472932, 5199.376074870964, 3871.9612803872164, 3951.5455722591696, 4002.69979751514, 4056.3915412687743, 4084.203580301872, 1040.3029969920171, 1052.5894900988621, 1059.7933402986343, 1060.4273692206277, 1068.417712346773, 650.7462089784988, 671.6473851228144, 681.3459079283942, 691.3294104718415, 696.6168607266085, 5183.092958732207, 5299.602529810202, 5322.520973112361, 5401.2168235606405, 5585.469380408855, 516.3055690096813, 532.5127508329834, 540.6620861961275, 541.8591166296791, 542.4873494547694, 2949.122911576005, 3277.655846136169, 3433.8626454942023, 3445.7243420526297, 3539.3629146753833, 13430.93284533571, 13607.863921360859, 13898.374573144232, 13991.30043497821, 14001.369938352798, 13664.863351366557, 13673.863261367458, 13874.722505549833, 13897.513587024405, 14037.78943315851, 7495.475316727777, 7590.1650818409935, 7593.240675932362, 7630.923690763132, 7633.770986870402, 5894.204282421818, 5952.345242023461, 5973.253343332083, 6107.9389206109145, 6145.446909778141, 12009.819852702041, 12041.277523348626, 12235.32705701195, 12266.877331226931, 12650.746985060063, 12645.93677031609, 13121.0, 13130.080894337687, 13321.401431828242, 13361.933190333986, 8648.264897483532, 8971.775705607412, 8988.325875559229, 9000.819983600422, 9010.639574417211, 9630.951845240728, 9787.951060244653, 9826.361286516354, 9845.45849978258, 9851.113399794052, 8023.879641805494, 8295.83408331818, 8303.211194936472, 8401.285890699115, 8526.78683032929, 8026.0, 8226.218509241613, 8251.83496330082, 8275.586220688821, 8323.667053318042, 7172.13934327884, 7252.057232559733, 7257.419406447366, 7284.053073100463, 7288.0, 4369.519352871245, 4849.612031037438, 4974.32846565709, 5047.217681259411, 5107.489251074863, 5207.6875387476875, 5212.452692467236, 5253.9211911820585, 5328.3605967284175, 5354.330708661418], "value": 4667.396341238759, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.73158423311565, 383.7122158381216, 384.19702821103886, 390.3637071573336, 392.264504054897, 5577.21918931349, 5644.266245388099, 5692.5161361284345, 5708.657480551165, 5710.202001019502, 5500.1024646497, 5634.9718251408685, 5640.520555752756, 5653.802116925908, 5683.914741278873, 4174.979125104385, 4308.0, 4315.093830295642, 4317.740935543861, 4335.436393268887, 4309.26742453782, 4316.54676258993, 4320.07118469529, 4338.002259480321, 4339.023719663066, 4283.057727300004, 4291.7639529826, 4296.892577685551, 4297.548757380477, 4312.353147027955, 4278.315469524892, 4281.7002809803325, 4297.162053399573, 4313.986213239886, 4323.762193079379, 3773.13217959868, 3785.9810700946596, 3806.600306967784, 3807.9238415231816, 3819.5416550014174, 5506.174073888908, 5509.917351239735, 5525.226468294442, 5545.944540554624, 5582.218489411485, 5031.044101620717, 5072.873178170538, 5078.238264260353, 5097.439281679012, 5115.360579927509, 6004.669743164124, 6007.8197654070445, 6010.333696445165, 6013.278406591194, 6016.533221379257, 4237.936430953539, 4253.659707223414, 4256.893577660552, 4257.084726783725, 4267.4025636410925, 5947.1971283876555, 6308.842278943017, 6312.936870631281, 6349.682515874188, 6425.421712045892, 4235.682323825664, 4245.80893859777, 4252.617264446215, 4267.935980960288, 4284.078923031501, 4301.827926882889, 4312.331588603772, 4317.424140188871, 4332.1119170569955, 4343.741254547617, 4821.662483626113, 4949.133901567211, 4975.800967961313, 4979.925301120486, 4981.576565991859, 5920.940790592039, 5944.970275148683, 5957.493613042853, 5976.0, 5977.760889564369, 1512.9697406051816, 1518.8708959738326, 1526.0462211118052, 1526.1834918318646, 1528.9235538223045, 1000.3447741729179, 1006.8187726209206, 1033.493588141805, 1043.280136705686, 1046.4035499765214, 5089.491050894881, 5109.233614957786, 5127.666701664454, 5135.0, 5151.922721159111, 6099.786507472217, 6201.503879689614, 6226.62640241587, 6229.96885015572, 6255.185996061091, 5088.516590923857, 5095.8726031848755, 5116.744162791845, 5142.485751424828, 5164.948350516522, 3242.5460435539044, 3287.6876696713775, 3291.8683252670103, 3303.966960330414, 3312.6190488093694, 5711.657300561979, 5713.6857472838565, 5715.0, 5722.570807189478, 5725.742341594639, 6310.242770867433, 6323.27282362525, 6333.366663333722, 6346.333634968354, 6383.0, 5688.383343661879, 5691.857703557362, 5703.230063941315, 5716.742746576331, 5725.971370143123, 6130.01919692847, 6169.413905678954, 6200.255969283535, 6209.720562574605, 6225.3774622537385, 6047.455728984412, 6102.2067131274425, 6107.236595425572, 6110.358412366815, 6112.751637611817, 5306.602004849729, 5484.533814625802, 5632.464915832989, 5686.545076393962, 5722.656640601577, 4294.613484786384, 4302.376155457378, 4316.352547117957, 4326.65386769064, 4328.156009578102, 6140.969295153495, 6142.539309551712, 6152.908011276188, 6172.135900973777, 6175.197224360804, 5748.626339287933, 5956.612820166675, 5982.581219314607, 5984.760609575568, 6001.90997135052, 5975.16347711312, 5983.311919129182, 5989.66919441706, 5993.6403815769445, 6000.309964354155, 5885.087811389241, 5908.261467316585, 5914.852128696817, 5918.254115035988, 5925.200097986716, 6010.2186715726675, 6021.969890150521, 6024.5481588881885, 6029.427204415749, 6052.243469566304, 5849.766009359578, 5868.2077919480325, 5868.559858010581, 5880.529557635465, 5906.940930590639], "value": 4480.7301939165045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.2821249281955, 750.2947229604173, 756.8940348351229, 766.1457474915471, 768.8616049111158, 13252.13861099028, 13802.654933626653, 13982.860171398283, 15309.23453827307, 16523.66952660946, 15069.171195584238, 15150.16674082925, 15157.0, 15202.0, 15231.92384038081, 872.489593587752, 886.8536691445904, 888.8488956877346, 891.7815135291862, 893.307686542928, 822.0792712162387, 881.5988725130082, 882.9337799665051, 896.6323807239033, 902.0303174087882, 930.5486838883136, 944.117250370902, 944.38614900315, 944.631593678466, 944.7543638653965, 933.2300851797261, 936.3913456253422, 942.1944237676756, 944.4050248343568, 944.8204841080208, 685.7976896815402, 690.2476300832117, 692.4460431654657, 695.9860802783967, 696.2271878215178, 13752.793708094387, 13800.240986745725, 13842.30788460583, 13887.79168312466, 13907.652308692364, 15444.382224710998, 15951.042937423676, 15981.0, 16053.357865685359, 16064.518064458085, 12902.54841080567, 12918.22490650564, 13291.667708307274, 13323.666908327272, 13371.33143342829, 3070.892518761855, 3079.076277116856, 3086.907392778198, 3088.258817883714, 3091.9072427826977, 84813.0, 85405.0, 86842.56578717066, 87769.0, 88078.6788198184, 12835.550755723505, 12952.611421657366, 13040.54358097462, 13169.868301316865, 13227.66930826737, 22807.973641186185, 23244.0, 23262.53474930492, 23265.302040938797, 23279.068837246657, 6389.488840892717, 6401.071844582602, 6458.644774537445, 6578.80263592093, 6601.141851559267, 3145.4338219120777, 3218.1954511372155, 3220.5813244278092, 3222.5005124205786, 3222.854971526287, 4134.338505839111, 4371.169477799208, 4420.911581768347, 4425.535318791481, 4429.424174857248, 780.2236774409499, 790.541485938166, 805.899262592176, 806.3388021822167, 807.3097501636016, 556.4546744190716, 581.4674611404115, 588.9734961926723, 588.9764409423575, 590.2415396215843, 10103.797924041479, 10120.848187277197, 10543.367397956146, 11084.722881928017, 11426.714332141762, 575.206215422714, 578.0606514414077, 584.3484514766005, 588.3880764005472, 598.2223109957125, 4761.0, 4985.950140498621, 5018.84943451697, 5091.338126043591, 5108.540231379194, 78693.34373218942, 78903.21096788958, 79073.60463197647, 80443.59778201072, 90057.09942900487, 69868.0, 71158.0, 71200.64399678072, 72876.63561682263, 73127.0, 60690.696546516985, 62065.68967155226, 63336.0, 63413.0, 65385.34614653792, 10158.12074766141, 10382.428966406618, 10603.098736607475, 10630.043296103078, 10778.838317425088, 27262.454750905268, 27912.58131127994, 28155.0, 28259.293517662223, 28707.85646071756, 34676.65323346734, 52917.0, 53653.0, 54664.0, 55478.72260638671, 14894.0, 15122.243887805345, 15147.54557363281, 15338.923305383401, 15665.765013525035, 16702.248398822325, 16707.331706732082, 16965.91517042407, 17075.48773536796, 17316.826831732025, 15071.773923390938, 15637.0, 15659.0, 16402.425915092914, 16725.247363868897, 13832.0, 14071.437142514185, 14100.506482273071, 14250.857491424953, 14296.356663949939, 14836.7774483385, 15720.371185152466, 15884.761728573849, 16110.838891611404, 16278.43025494102, 9787.706368808947, 9985.0, 10212.08091271789, 10271.383716976707, 10594.4702764863, 10930.453477325942, 11237.91841860977, 11999.700007499534, 12720.74558508843, 12846.293453860128], "value": 7343.013475190248, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 109.0, 111.0, 110.0, 109.0, 112.0, 111.0, 113.0, 117.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 129.0, 184.0, 122.0, 125.0, 125.0, 128.0, 150.0, 128.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 163.0, 167.0, 169.0, 171.0, 165.0, 167.0, 163.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 113.0, 74.0, 74.0, 78.0, 75.0, 92.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 118.0, 84.0, 87.0, 84.0, 112.0, 85.0, 83.0, 108.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 152.0, 149.0, 151.0, 151.0, 159.0, 151.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 59.0, 62.0, 65.0, 55.0, 56.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 86.0, 92.0, 87.0, 87.0, 91.0, 103.0, 121.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 130.0, 139.0, 133.0, 137.0, 128.0, 131.0, 138.0, 142.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 194.0, 193.0, 200.0, 192.0, 190.0, 195.0, 187.0, 194.0, 202.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 72.0, 73.0, 72.0, 75.0, 73.0, 71.0, 73.0], "value": 73.2, "unit": "score"}]}]} 10:35:40 INFO - Return code: 0 10:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:40 INFO - # TBPL SUCCESS # 10:35:40 INFO - Running post-action listener: _resource_record_post_action 10:35:40 INFO - [mozharness: 2017-06-01 17:35:40.237052Z] Finished run-tests step (success) 10:35:40 INFO - Running post-run listener: _resource_record_post_run 10:35:40 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403484672; Read time: 12; Write time: 198844 10:35:40 INFO - TinderboxPrint: CPU usage
12.7% 10:35:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:35:40 INFO - TinderboxPrint: I/O write bytes / time
403,484,672 / 198,844 10:35:40 INFO - TinderboxPrint: CPU idle
8,755.3 (87.3%) 10:35:40 INFO - TinderboxPrint: CPU user
1,218.6 (12.2%) 10:35:40 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84754432; Read time: 0; Write time: 46680 10:35:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:35:40 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305991680; Read time: 12; Write time: 148028 10:35:40 INFO - Running post-run listener: _upload_blobber_files 10:35:40 INFO - Blob upload gear active. 10:35:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:40 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 10:35:40 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'] 10:35:40 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 10:35:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:42 INFO - (blobuploader) - INFO - Done attempting. 10:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:35:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:43 INFO - (blobuploader) - INFO - Done attempting. 10:35:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:48 INFO - (blobuploader) - INFO - Done attempting. 10:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:49 INFO - (blobuploader) - INFO - Done attempting. 10:35:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:49 INFO - Return code: 0 10:35:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:49 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeedbdaf514a1a5fa3772693e10e24f92c5b0ebc617b8868467462f5d0c3dfeb77d686b6d978a0b109c2b60cf9f4fd36542801a41e08461209a1a721f0fc25ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f572c4752b444ffe86f7e2b9a340fa5d4f335ef853d99881c20ffa7446184049a2012feb5fbd416e73536e2fd16d14cdfe9ace028b21d7e9ce806a32f544cc4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d4b26f6beb4309b2f5d9a66a9a2814487d8712406d9fb0e8eeb25f98f73bf8c3b9bbf06c991fa50d38597153e5d5504a8341b2f5f18100fad0a3533e290761", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/938ee0e06a4b19d3a1be4cd54ff74c6ba11b849aa1a2efbf0bf9f423898b357a40178f798a66e10bcd9d44870c7860a3f49d734beb4540e7ce9bc4d6761e2bd5"} 10:35:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:49 INFO - Contents: 10:35:49 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeedbdaf514a1a5fa3772693e10e24f92c5b0ebc617b8868467462f5d0c3dfeb77d686b6d978a0b109c2b60cf9f4fd36542801a41e08461209a1a721f0fc25ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f572c4752b444ffe86f7e2b9a340fa5d4f335ef853d99881c20ffa7446184049a2012feb5fbd416e73536e2fd16d14cdfe9ace028b21d7e9ce806a32f544cc4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d4b26f6beb4309b2f5d9a66a9a2814487d8712406d9fb0e8eeb25f98f73bf8c3b9bbf06c991fa50d38597153e5d5504a8341b2f5f18100fad0a3533e290761", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/938ee0e06a4b19d3a1be4cd54ff74c6ba11b849aa1a2efbf0bf9f423898b357a40178f798a66e10bcd9d44870c7860a3f49d734beb4540e7ce9bc4d6761e2bd5"} 10:35:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:49 INFO - Copying logs to upload dir... 10:35:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.420530 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-06-01 10:35:49.139488) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 10:35:49.147803) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 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/aeedbdaf514a1a5fa3772693e10e24f92c5b0ebc617b8868467462f5d0c3dfeb77d686b6d978a0b109c2b60cf9f4fd36542801a41e08461209a1a721f0fc25ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f572c4752b444ffe86f7e2b9a340fa5d4f335ef853d99881c20ffa7446184049a2012feb5fbd416e73536e2fd16d14cdfe9ace028b21d7e9ce806a32f544cc4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d4b26f6beb4309b2f5d9a66a9a2814487d8712406d9fb0e8eeb25f98f73bf8c3b9bbf06c991fa50d38597153e5d5504a8341b2f5f18100fad0a3533e290761", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/938ee0e06a4b19d3a1be4cd54ff74c6ba11b849aa1a2efbf0bf9f423898b357a40178f798a66e10bcd9d44870c7860a3f49d734beb4540e7ce9bc4d6761e2bd5"} build_url:https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/fzRGqGS9RgCa0MzzHgk90w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeedbdaf514a1a5fa3772693e10e24f92c5b0ebc617b8868467462f5d0c3dfeb77d686b6d978a0b109c2b60cf9f4fd36542801a41e08461209a1a721f0fc25ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f572c4752b444ffe86f7e2b9a340fa5d4f335ef853d99881c20ffa7446184049a2012feb5fbd416e73536e2fd16d14cdfe9ace028b21d7e9ce806a32f544cc4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f9d4b26f6beb4309b2f5d9a66a9a2814487d8712406d9fb0e8eeb25f98f73bf8c3b9bbf06c991fa50d38597153e5d5504a8341b2f5f18100fad0a3533e290761", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/938ee0e06a4b19d3a1be4cd54ff74c6ba11b849aa1a2efbf0bf9f423898b357a40178f798a66e10bcd9d44870c7860a3f49d734beb4540e7ce9bc4d6761e2bd5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 10:35:49.178448) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:35:49.178779) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496335074.404517-1155763905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 10:35:49.232334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 10:35:49.232647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 10:35:49.232942) ========= ========= Total master_lag: 0.20 =========