builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1496015437.41 results: success (0) revision: 4541134e973a6bd5e667a603e844854c8e5361da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.411633) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.412099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.412376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.427849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.428170) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 16:50:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.7M=0s 2017-05-28 16:50:37 (40.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.581915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.582236) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021985 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:37.633640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-28 16:50:37.636017) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4541134e973a6bd5e667a603e844854c8e5361da --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 4541134e973a6bd5e667a603e844854c8e5361da --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=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 16:50:37,550 truncating revision to first 12 chars 2017-05-28 16:50:37,550 Setting DEBUG logging. 2017-05-28 16:50:37,550 attempt 1/10 2017-05-28 16:50:37,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4541134e973a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 16:50:38,454 unpacking tar archive at: mozilla-central-4541134e973a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.214124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-28 16:50:38.865166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:38.865483) ========= script_repo_revision: 4541134e973a6bd5e667a603e844854c8e5361da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:38.865842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:38.866116) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:50:38.874673) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-05-28 16:50:38.874947) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:38 INFO - MultiFileLogger online at 20170528 16:50:38 in /builds/slave/test 16:50:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:50:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:50:38 INFO - {'append_to_log': False, 16:50:38 INFO - 'base_work_dir': '/builds/slave/test', 16:50:38 INFO - 'blob_upload_branch': 'Firefox', 16:50:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:50:38 INFO - 'branch': 'Firefox', 16:50:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:38 INFO - 'config_files': ('talos/linux_config.py',), 16:50:38 INFO - 'default_actions': ('clobber', 16:50:38 INFO - 'read-buildbot-config', 16:50:38 INFO - 'download-and-extract', 16:50:38 INFO - 'populate-webroot', 16:50:38 INFO - 'create-virtualenv', 16:50:38 INFO - 'install', 16:50:38 INFO - 'setup-mitmproxy', 16:50:38 INFO - 'run-tests'), 16:50:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:38 INFO - 'download_minidump_stackwalk': True, 16:50:38 INFO - 'download_symbols': 'ondemand', 16:50:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:38 INFO - 'gecko_profile': False, 16:50:38 INFO - 'gecko_profile_interval': 0, 16:50:38 INFO - 'installer_path': 'installer.exe', 16:50:38 INFO - 'log_level': 'info', 16:50:38 INFO - 'log_name': 'talos', 16:50:38 INFO - 'log_to_console': True, 16:50:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:38 INFO - 'opt_config_files': (), 16:50:38 INFO - 'pip_index': False, 16:50:38 INFO - 'suite': 'dromaeojs-e10s', 16:50:38 INFO - 'system_bits': '32', 16:50:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:38 INFO - 'title': 'talos-linux64-ix-074', 16:50:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:38 INFO - 'use_talos_json': True, 16:50:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:50:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:38 INFO - 'work_dir': 'build'} 16:50:38 INFO - [mozharness: 2017-05-28 23:50:38.889033Z] Running clobber step. 16:50:38 INFO - Running pre-action listener: _resource_record_pre_action 16:50:38 INFO - Running main action method: clobber 16:50:38 INFO - rmtree: /builds/slave/test/build 16:50:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:50:39 INFO - Running post-action listener: _resource_record_post_action 16:50:39 INFO - [mozharness: 2017-05-28 23:50:39.962800Z] Finished clobber step (success) 16:50:39 INFO - [mozharness: 2017-05-28 23:50:39.962903Z] Running read-buildbot-config step. 16:50:39 INFO - Running pre-action listener: _resource_record_pre_action 16:50:39 INFO - Running main action method: read_buildbot_config 16:50:39 INFO - Using buildbot properties: 16:50:39 INFO - { 16:50:39 INFO - "project": "", 16:50:39 INFO - "product": "firefox", 16:50:39 INFO - "who": "archaeopteryx@coole-files.de", 16:50:39 INFO - "installer_path": "public/build/target.tar.bz2", 16:50:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:50:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:50:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:50:39 INFO - "stage_platform": "linux64-stylosequential", 16:50:39 INFO - "basedir": "/builds/slave/test", 16:50:39 INFO - "buildnumber": 30, 16:50:39 INFO - "platform": "ubuntu64_hw_styloseq", 16:50:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:50:39 INFO - "slavebuilddir": "test", 16:50:39 INFO - "taskId": "H9_XC2EjTkWtKNf1bnCjzw", 16:50:39 INFO - "branch": "mozilla-central", 16:50:39 INFO - "script_repo_revision": "production", 16:50:39 INFO - "revision": "4541134e973a6bd5e667a603e844854c8e5361da", 16:50:39 INFO - "slavename": "talos-linux64-ix-074", 16:50:39 INFO - "repo_path": "mozilla-central" 16:50:39 INFO - } 16:50:39 INFO - Finding installer, test and symbols from parent task. 16:50:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9_XC2EjTkWtKNf1bnCjzw'}, attempt #1 16:50:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H9_XC2EjTkWtKNf1bnCjzw'}, attempt #1 16:50:40 INFO - Task dependencies: JaiVcFo4T_mKzUx68iYZ1Q 16:50:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q'}, attempt #1 16:50:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 16:50:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/test_packages.json 16:50:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.crashreporter-symbols.zip 16:50:41 INFO - Running post-action listener: _resource_record_post_action 16:50:41 INFO - [mozharness: 2017-05-28 23:50:41.316887Z] Finished read-buildbot-config step (success) 16:50:41 INFO - [mozharness: 2017-05-28 23:50:41.317107Z] Running download-and-extract step. 16:50:41 INFO - Running pre-action listener: _resource_record_pre_action 16:50:41 INFO - Running main action method: download_and_extract 16:50:41 INFO - mkdir: /builds/slave/test/build/tests 16:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:41 INFO - trying https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.test_packages.json 16:50:41 INFO - Downloading https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:50:41 INFO - Downloaded 986 bytes. 16:50:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:50:41 INFO - Using the following test package requirements: 16:50:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:50:41 INFO - u'common': [u'target.common.tests.zip'], 16:50:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:50:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:50:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:50:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:50:41 INFO - u'mozbase': [u'target.common.tests.zip'], 16:50:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:50:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:50:41 INFO - u'web-platform': [u'target.common.tests.zip', 16:50:41 INFO - u'target.web-platform.tests.zip'], 16:50:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:50:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:50:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip 16:50:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:50:41 INFO - Fetch https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip into memory 16:50:43 INFO - Content-Length response header: 63527377 16:50:43 INFO - Bytes received: 63527377 16:50:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:50:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip 16:50:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:50:53 INFO - Fetch https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.common.tests.zip into memory 16:50:55 INFO - Content-Length response header: 63527377 16:50:55 INFO - Bytes received: 63527377 16:51:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.talos.tests.zip 16:51:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:51:07 INFO - Fetch https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.talos.tests.zip into memory 16:51:08 INFO - Content-Length response header: 14447425 16:51:08 INFO - Bytes received: 14447425 16:51:08 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')]} 16:51:08 INFO - trying https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 16:51:08 INFO - Downloading https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:51:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:51:09 INFO - Downloaded 55824590 bytes. 16:51:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 16:51:09 INFO - mkdir: /builds/slave/test/properties 16:51:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:51:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:51:09 INFO - Contents: 16:51:09 INFO - build_url:https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 16:51:09 INFO - Running post-action listener: _resource_record_post_action 16:51:09 INFO - Running post-action listener: set_extra_try_arguments 16:51:09 INFO - [mozharness: 2017-05-28 23:51:09.711434Z] Finished download-and-extract step (success) 16:51:09 INFO - [mozharness: 2017-05-28 23:51:09.711529Z] Running populate-webroot step. 16:51:09 INFO - Running pre-action listener: _resource_record_pre_action 16:51:09 INFO - Running main action method: populate_webroot 16:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:51:09 INFO - '--tppagecycles', 16:51:09 INFO - '7'], 16:51:09 INFO - 'tests': ['tsvgm']}}, 16:51:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:51:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:51:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['damp', 'tps']}, 16:51:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'tests': ['damp', 'tps']}, 16:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['dromaeo_dom']}, 16:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:51:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:51:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:51:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['a11yr', 16:51:09 INFO - 'ts_paint', 16:51:09 INFO - 'tpaint', 16:51:09 INFO - 'sessionrestore', 16:51:09 INFO - 'sessionrestore_no_auto_restore', 16:51:09 INFO - 'tabpaint']}, 16:51:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:51:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:51:09 INFO - 'bloom_basic_ref']}, 16:51:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:51:09 INFO - 'talos_options': ['--mitmproxy', 16:51:09 INFO - 'mitmproxy-recording-1.mp', 16:51:09 INFO - '--firstNonBlankPaint'], 16:51:09 INFO - 'tests': ['Quantum_1']}, 16:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['tsvgx', 16:51:09 INFO - 'tsvgr_opacity', 16:51:09 INFO - 'tart', 16:51:09 INFO - 'tscrollx', 16:51:09 INFO - 'cart', 16:51:09 INFO - 'tsvg_static']}, 16:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:51:09 INFO - 'tsvgr_opacity', 16:51:09 INFO - 'tart', 16:51:09 INFO - 'tscrollx', 16:51:09 INFO - 'cart', 16:51:09 INFO - 'tsvg_static']}, 16:51:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'talos_options': ['--disable-e10s'], 16:51:09 INFO - 'tests': ['tp5o']}, 16:51:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:51:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'talos_options': ['--disable-e10s', 16:51:09 INFO - '--xperf_path', 16:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:09 INFO - 'tests': ['tp5n']}, 16:51:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:51:09 INFO - 'talos_options': ['--xperf_path', 16:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:51:09 INFO - 'tests': ['tp5n']}}, 16:51:09 INFO - 'talos.zip': {'path': '', 16:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:51:09 INFO - Running post-action listener: _resource_record_post_action 16:51:09 INFO - [mozharness: 2017-05-28 23:51:09.725871Z] Finished populate-webroot step (success) 16:51:09 INFO - [mozharness: 2017-05-28 23:51:09.725960Z] Running create-virtualenv step. 16:51:09 INFO - Running pre-action listener: _resource_record_pre_action 16:51:09 INFO - Running main action method: create_virtualenv 16:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 16:51:09 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 16:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:51:09 INFO - Using real prefix '/usr' 16:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:51:12 INFO - Installing pip.................done. 16:51:12 INFO - Return code: 0 16:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:51:12 INFO - Reading from file tmpfile_stdout 16:51:12 INFO - Output received: 16:51:12 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) 16:51:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:12 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:12 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 16:51:12 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 16:51:12 INFO - Using env: {'DISPLAY': ':0', 16:51:12 INFO - 'HOME': '/home/cltbld', 16:51:12 INFO - 'LANG': 'en_US.UTF-8', 16:51:12 INFO - 'LANGUAGE': 'en_US:en', 16:51:12 INFO - 'LOGNAME': 'cltbld', 16:51:12 INFO - 'MAIL': '/var/mail/cltbld', 16:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:12 INFO - 'MOZ_NO_REMOTE': '1', 16:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:12 INFO - 'NO_EM_RESTART': '1', 16:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:12 INFO - 'PWD': '/builds/slave/test', 16:51:12 INFO - 'SHELL': '/bin/bash', 16:51:12 INFO - 'SHLVL': '1', 16:51:12 INFO - 'TERM': 'linux', 16:51:12 INFO - 'TMOUT': '86400', 16:51:12 INFO - 'USER': 'cltbld', 16:51:12 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:12 INFO - '_': '/tools/buildbot/bin/python'} 16:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:12 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 16:51:12 INFO - Cleaning up... 16:51:12 INFO - Return code: 0 16:51:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:12 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:12 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 16:51:12 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 16:51:12 INFO - Using env: {'DISPLAY': ':0', 16:51:12 INFO - 'HOME': '/home/cltbld', 16:51:12 INFO - 'LANG': 'en_US.UTF-8', 16:51:12 INFO - 'LANGUAGE': 'en_US:en', 16:51:12 INFO - 'LOGNAME': 'cltbld', 16:51:12 INFO - 'MAIL': '/var/mail/cltbld', 16:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:12 INFO - 'MOZ_NO_REMOTE': '1', 16:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:12 INFO - 'NO_EM_RESTART': '1', 16:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:12 INFO - 'PWD': '/builds/slave/test', 16:51:12 INFO - 'SHELL': '/bin/bash', 16:51:12 INFO - 'SHLVL': '1', 16:51:12 INFO - 'TERM': 'linux', 16:51:12 INFO - 'TMOUT': '86400', 16:51:12 INFO - 'USER': 'cltbld', 16:51:12 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:12 INFO - '_': '/tools/buildbot/bin/python'} 16:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:12 INFO - Downloading/unpacking psutil>=3.1.1 16:51:12 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 16:51:12 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 16:51:12 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 16:51:12 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 16:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:14 INFO - Installing collected packages: psutil 16:51:14 INFO - Running setup.py install for psutil 16:51:14 INFO - building 'psutil._psutil_linux' extension 16:51:14 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 16:51:14 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 16:51:14 INFO - building 'psutil._psutil_posix' extension 16:51:14 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 16:51:14 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 16:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:14 INFO - Successfully installed psutil 16:51:14 INFO - Cleaning up... 16:51:14 INFO - Return code: 0 16:51:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:51:14 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')]} 16:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:14 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')]} 16:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:14 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:14 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 16:51:14 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 16:51:14 INFO - Using env: {'DISPLAY': ':0', 16:51:14 INFO - 'HOME': '/home/cltbld', 16:51:14 INFO - 'LANG': 'en_US.UTF-8', 16:51:14 INFO - 'LANGUAGE': 'en_US:en', 16:51:14 INFO - 'LOGNAME': 'cltbld', 16:51:14 INFO - 'MAIL': '/var/mail/cltbld', 16:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:14 INFO - 'MOZ_NO_REMOTE': '1', 16:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:14 INFO - 'NO_EM_RESTART': '1', 16:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:14 INFO - 'PWD': '/builds/slave/test', 16:51:14 INFO - 'SHELL': '/bin/bash', 16:51:14 INFO - 'SHLVL': '1', 16:51:14 INFO - 'TERM': 'linux', 16:51:14 INFO - 'TMOUT': '86400', 16:51:14 INFO - 'USER': 'cltbld', 16:51:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:14 INFO - '_': '/tools/buildbot/bin/python'} 16:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:51:16 INFO - Installing collected packages: mozsystemmonitor 16:51:16 INFO - Running setup.py install for mozsystemmonitor 16:51:16 INFO - Successfully installed mozsystemmonitor 16:51:16 INFO - Cleaning up... 16:51:16 INFO - Return code: 0 16:51:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:16 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:16 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 16:51:16 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 16:51:16 INFO - Using env: {'DISPLAY': ':0', 16:51:16 INFO - 'HOME': '/home/cltbld', 16:51:16 INFO - 'LANG': 'en_US.UTF-8', 16:51:16 INFO - 'LANGUAGE': 'en_US:en', 16:51:16 INFO - 'LOGNAME': 'cltbld', 16:51:16 INFO - 'MAIL': '/var/mail/cltbld', 16:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:16 INFO - 'MOZ_NO_REMOTE': '1', 16:51:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:16 INFO - 'NO_EM_RESTART': '1', 16:51:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:16 INFO - 'PWD': '/builds/slave/test', 16:51:16 INFO - 'SHELL': '/bin/bash', 16:51:16 INFO - 'SHLVL': '1', 16:51:16 INFO - 'TERM': 'linux', 16:51:16 INFO - 'TMOUT': '86400', 16:51:16 INFO - 'USER': 'cltbld', 16:51:16 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:16 INFO - '_': '/tools/buildbot/bin/python'} 16:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:16 INFO - Downloading/unpacking jsonschema==2.5.1 16:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:51:17 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 16:51:17 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 16:51:17 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 16:51:17 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 16:51:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:17 INFO - warning: no files found matching '*.txt' 16:51:17 INFO - no previously-included directories found matching 'build' 16:51:17 INFO - no previously-included directories found matching 'dist' 16:51:17 INFO - no previously-included directories found matching '.git*' 16:51:17 INFO - Installing collected packages: jsonschema, functools32 16:51:17 INFO - Running setup.py install for functools32 16:51:17 INFO - warning: no files found matching '*.txt' 16:51:17 INFO - no previously-included directories found matching 'build' 16:51:17 INFO - no previously-included directories found matching 'dist' 16:51:17 INFO - no previously-included directories found matching '.git*' 16:51:17 INFO - Successfully installed jsonschema functools32 16:51:17 INFO - Cleaning up... 16:51:17 INFO - Return code: 0 16:51:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:17 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 16:51:17 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 16:51:17 INFO - Using env: {'DISPLAY': ':0', 16:51:17 INFO - 'HOME': '/home/cltbld', 16:51:17 INFO - 'LANG': 'en_US.UTF-8', 16:51:17 INFO - 'LANGUAGE': 'en_US:en', 16:51:17 INFO - 'LOGNAME': 'cltbld', 16:51:17 INFO - 'MAIL': '/var/mail/cltbld', 16:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:17 INFO - 'MOZ_NO_REMOTE': '1', 16:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:17 INFO - 'NO_EM_RESTART': '1', 16:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:17 INFO - 'PWD': '/builds/slave/test', 16:51:17 INFO - 'SHELL': '/bin/bash', 16:51:17 INFO - 'SHLVL': '1', 16:51:17 INFO - 'TERM': 'linux', 16:51:17 INFO - 'TMOUT': '86400', 16:51:17 INFO - 'USER': 'cltbld', 16:51:17 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:17 INFO - '_': '/tools/buildbot/bin/python'} 16:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:51:18 INFO - Cleaning up... 16:51:18 INFO - Return code: 0 16:51:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:51:18 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')]} 16:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:18 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')]} 16:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:18 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:18 INFO - Using env: {'DISPLAY': ':0', 16:51:18 INFO - 'HOME': '/home/cltbld', 16:51:18 INFO - 'LANG': 'en_US.UTF-8', 16:51:18 INFO - 'LANGUAGE': 'en_US:en', 16:51:18 INFO - 'LOGNAME': 'cltbld', 16:51:18 INFO - 'MAIL': '/var/mail/cltbld', 16:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:18 INFO - 'MOZ_NO_REMOTE': '1', 16:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:18 INFO - 'NO_EM_RESTART': '1', 16:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:18 INFO - 'PWD': '/builds/slave/test', 16:51:18 INFO - 'SHELL': '/bin/bash', 16:51:18 INFO - 'SHLVL': '1', 16:51:18 INFO - 'TERM': 'linux', 16:51:18 INFO - 'TMOUT': '86400', 16:51:18 INFO - 'USER': 'cltbld', 16:51:18 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:18 INFO - '_': '/tools/buildbot/bin/python'} 16:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:18 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 16:51:18 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 16:51:18 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 16:51:18 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 16:51:19 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:19 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 16:51:19 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 16:51:19 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 16:51:19 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 16:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:19 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 16:51:19 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 16:51:19 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 16:51:19 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 16:51:19 INFO - Downloading docopt-0.6.1.tar.gz 16:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:19 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:19 INFO - Running setup.py install for blobuploader 16:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:20 INFO - Running setup.py install for requests 16:51:20 INFO - Running setup.py install for docopt 16:51:20 INFO - Successfully installed blobuploader requests docopt 16:51:20 INFO - Cleaning up... 16:51:20 INFO - Return code: 0 16:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:20 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')]} 16:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:20 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')]} 16:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:20 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:20 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 16:51:20 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 16:51:20 INFO - Using env: {'DISPLAY': ':0', 16:51:20 INFO - 'HOME': '/home/cltbld', 16:51:20 INFO - 'LANG': 'en_US.UTF-8', 16:51:20 INFO - 'LANGUAGE': 'en_US:en', 16:51:20 INFO - 'LOGNAME': 'cltbld', 16:51:20 INFO - 'MAIL': '/var/mail/cltbld', 16:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:20 INFO - 'MOZ_NO_REMOTE': '1', 16:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:20 INFO - 'NO_EM_RESTART': '1', 16:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:20 INFO - 'PWD': '/builds/slave/test', 16:51:20 INFO - 'SHELL': '/bin/bash', 16:51:20 INFO - 'SHLVL': '1', 16:51:20 INFO - 'TERM': 'linux', 16:51:20 INFO - 'TMOUT': '86400', 16:51:20 INFO - 'USER': 'cltbld', 16:51:20 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:20 INFO - '_': '/tools/buildbot/bin/python'} 16:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:20 INFO - Running setup.py (path:/tmp/pip-Hp4bK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:20 INFO - Running setup.py (path:/tmp/pip-Vjji8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:20 INFO - Running setup.py (path:/tmp/pip-2_uSxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:20 INFO - Running setup.py (path:/tmp/pip-Qopdvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:21 INFO - Running setup.py (path:/tmp/pip-hEi5eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:21 INFO - Running setup.py (path:/tmp/pip-CwZ1nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:21 INFO - Running setup.py (path:/tmp/pip-vKXstW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:21 INFO - Running setup.py (path:/tmp/pip-2E3gW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:21 INFO - Running setup.py (path:/tmp/pip-rokEKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:21 INFO - Running setup.py (path:/tmp/pip-kq9u2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:21 INFO - Running setup.py (path:/tmp/pip-2fpaTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:21 INFO - Running setup.py (path:/tmp/pip-kz_J8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:21 INFO - Running setup.py (path:/tmp/pip-Z7m9as-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:21 INFO - Running setup.py (path:/tmp/pip-bR82sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:21 INFO - Running setup.py (path:/tmp/pip-A0guSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:21 INFO - Running setup.py (path:/tmp/pip-eGypj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:21 INFO - Running setup.py (path:/tmp/pip-_bNlfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:21 INFO - Running setup.py install for manifestparser 16:51:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for mozcrash 16:51:22 INFO - Running setup.py install for mozdebug 16:51:22 INFO - Running setup.py install for mozdevice 16:51:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for mozfile 16:51:22 INFO - Running setup.py install for mozhttpd 16:51:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for mozinfo 16:51:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for mozInstall 16:51:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for mozleak 16:51:22 INFO - Running setup.py install for mozlog 16:51:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:22 INFO - Running setup.py install for moznetwork 16:51:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Running setup.py install for mozprocess 16:51:23 INFO - Running setup.py install for mozprofile 16:51:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Running setup.py install for mozrunner 16:51:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Running setup.py install for mozscreenshot 16:51:23 INFO - Running setup.py install for moztest 16:51:23 INFO - Running setup.py install for mozversion 16:51:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:23 INFO - Cleaning up... 16:51:23 INFO - Return code: 0 16:51:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:23 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:23 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 16:51:23 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 16:51:23 INFO - Using env: {'DISPLAY': ':0', 16:51:23 INFO - 'HOME': '/home/cltbld', 16:51:23 INFO - 'LANG': 'en_US.UTF-8', 16:51:23 INFO - 'LANGUAGE': 'en_US:en', 16:51:23 INFO - 'LOGNAME': 'cltbld', 16:51:23 INFO - 'MAIL': '/var/mail/cltbld', 16:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:23 INFO - 'MOZ_NO_REMOTE': '1', 16:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:23 INFO - 'NO_EM_RESTART': '1', 16:51:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:23 INFO - 'PWD': '/builds/slave/test', 16:51:23 INFO - 'SHELL': '/bin/bash', 16:51:23 INFO - 'SHLVL': '1', 16:51:23 INFO - 'TERM': 'linux', 16:51:23 INFO - 'TMOUT': '86400', 16:51:23 INFO - 'USER': 'cltbld', 16:51:23 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:23 INFO - '_': '/tools/buildbot/bin/python'} 16:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:23 INFO - Running setup.py (path:/tmp/pip-u4Ljex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:24 INFO - Running setup.py (path:/tmp/pip-kbbL1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:24 INFO - Running setup.py (path:/tmp/pip-itWMVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:24 INFO - Running setup.py (path:/tmp/pip-CTKBaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:24 INFO - Running setup.py (path:/tmp/pip-wNa7Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:24 INFO - Running setup.py (path:/tmp/pip-NAmoYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:24 INFO - Running setup.py (path:/tmp/pip-FcvxpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:24 INFO - Running setup.py (path:/tmp/pip-VlnJ7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:24 INFO - Running setup.py (path:/tmp/pip-J9f8J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:24 INFO - Running setup.py (path:/tmp/pip-XUjYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:24 INFO - Running setup.py (path:/tmp/pip-2D_KPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:24 INFO - Running setup.py (path:/tmp/pip-WCjXQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:24 INFO - Running setup.py (path:/tmp/pip-RO6wNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:24 INFO - Running setup.py (path:/tmp/pip-uAp4sQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:24 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)) 16:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:24 INFO - Running setup.py (path:/tmp/pip-fotfOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:25 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)) 16:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:25 INFO - Running setup.py (path:/tmp/pip-9VS2AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:25 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)) 16:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:25 INFO - Running setup.py (path:/tmp/pip-fQ9scj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:25 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)) 16:51:25 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)) 16:51:25 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)) 16:51:25 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)) 16:51:25 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)) 16:51:25 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)) 16:51:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:25 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 16:51:25 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 16:51:25 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 16:51:25 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 16:51:26 INFO - Downloading blessings-1.6.tar.gz 16:51:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:26 INFO - Installing collected packages: blessings 16:51:26 INFO - Running setup.py install for blessings 16:51:26 INFO - Successfully installed blessings 16:51:26 INFO - Cleaning up... 16:51:26 INFO - Return code: 0 16:51:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:26 INFO - Reading from file tmpfile_stdout 16:51:26 INFO - Current package versions: 16:51:26 INFO - argparse == 1.2.1 16:51:26 INFO - blessings == 1.6 16:51:26 INFO - blobuploader == 1.2.4 16:51:26 INFO - docopt == 0.6.1 16:51:26 INFO - functools32 == 3.2.3-2 16:51:26 INFO - jsonschema == 2.5.1 16:51:26 INFO - manifestparser == 1.1 16:51:26 INFO - mozInstall == 1.12 16:51:26 INFO - mozcrash == 1.0 16:51:26 INFO - mozdebug == 0.1 16:51:26 INFO - mozdevice == 0.51 16:51:26 INFO - mozfile == 1.2 16:51:26 INFO - mozhttpd == 0.7 16:51:26 INFO - mozinfo == 0.9 16:51:26 INFO - mozleak == 0.1 16:51:26 INFO - mozlog == 3.4 16:51:26 INFO - moznetwork == 0.27 16:51:26 INFO - mozprocess == 0.25 16:51:26 INFO - mozprofile == 0.28 16:51:26 INFO - mozrunner == 6.13 16:51:26 INFO - mozscreenshot == 0.1 16:51:26 INFO - mozsystemmonitor == 0.3 16:51:26 INFO - moztest == 0.8 16:51:26 INFO - mozversion == 1.4 16:51:26 INFO - psutil == 3.1.1 16:51:26 INFO - requests == 1.2.3 16:51:26 INFO - wsgiref == 0.1.2 16:51:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:26 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')]} 16:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:26 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')]} 16:51:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:26 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 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:26 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 16:51:26 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 16:51:26 INFO - Using env: {'DISPLAY': ':0', 16:51:26 INFO - 'HOME': '/home/cltbld', 16:51:26 INFO - 'LANG': 'en_US.UTF-8', 16:51:26 INFO - 'LANGUAGE': 'en_US:en', 16:51:26 INFO - 'LOGNAME': 'cltbld', 16:51:26 INFO - 'MAIL': '/var/mail/cltbld', 16:51:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:26 INFO - 'MOZ_NO_REMOTE': '1', 16:51:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:26 INFO - 'NO_EM_RESTART': '1', 16:51:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:26 INFO - 'PWD': '/builds/slave/test', 16:51:26 INFO - 'SHELL': '/bin/bash', 16:51:26 INFO - 'SHLVL': '1', 16:51:26 INFO - 'TERM': 'linux', 16:51:26 INFO - 'TMOUT': '86400', 16:51:26 INFO - 'USER': 'cltbld', 16:51:26 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:26 INFO - '_': '/tools/buildbot/bin/python'} 16:51:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 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)) 16:51:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:51:26 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 16:51:26 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 16:51:26 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 16:51:26 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 16:51:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:51:28 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)) 16:51:28 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)) 16:51:28 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)) 16:51:28 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)) 16:51:28 INFO - Installing collected packages: marionette-driver 16:51:28 INFO - Running setup.py install for marionette-driver 16:51:28 INFO - Successfully installed marionette-driver 16:51:28 INFO - Cleaning up... 16:51:28 INFO - Return code: 0 16:51:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21813b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x235ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24feef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, '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': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', '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 16:51:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:51:28 INFO - Using env: {'DISPLAY': ':0', 16:51:28 INFO - 'HOME': '/home/cltbld', 16:51:28 INFO - 'LANG': 'en_US.UTF-8', 16:51:28 INFO - 'LANGUAGE': 'en_US:en', 16:51:28 INFO - 'LOGNAME': 'cltbld', 16:51:28 INFO - 'MAIL': '/var/mail/cltbld', 16:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:28 INFO - 'MOZ_NO_REMOTE': '1', 16:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:28 INFO - 'NO_EM_RESTART': '1', 16:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:28 INFO - 'PWD': '/builds/slave/test', 16:51:28 INFO - 'SHELL': '/bin/bash', 16:51:28 INFO - 'SHLVL': '1', 16:51:28 INFO - 'TERM': 'linux', 16:51:28 INFO - 'TMOUT': '86400', 16:51:28 INFO - 'USER': 'cltbld', 16:51:28 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:28 INFO - '_': '/tools/buildbot/bin/python'} 16:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:28 INFO - Cleaning up... 16:51:28 INFO - Return code: 0 16:51:28 INFO - Running post-action listener: _resource_record_post_action 16:51:28 INFO - Running post-action listener: _start_resource_monitoring 16:51:28 INFO - Starting resource monitoring. 16:51:28 INFO - [mozharness: 2017-05-28 23:51:28.519385Z] Finished create-virtualenv step (success) 16:51:28 INFO - [mozharness: 2017-05-28 23:51:28.519900Z] Running install step. 16:51:28 INFO - Running pre-action listener: _resource_record_pre_action 16:51:28 INFO - Running main action method: install 16:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:28 INFO - Reading from file tmpfile_stdout 16:51:28 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:28 INFO - Reading from file tmpfile_stdout 16:51:28 INFO - Output received: 16:51:28 INFO - Usage: mozinstall [options] installer 16:51:28 INFO - Options: 16:51:28 INFO - -h, --help show this help message and exit 16:51:28 INFO - -d DEST, --destination=DEST 16:51:28 INFO - Directory to install application into. [default: 16:51:28 INFO - "/builds/slave/test"] 16:51:28 INFO - --app=APP Application being installed. [default: firefox] 16:51:28 INFO - mkdir: /builds/slave/test/build/application 16:51:28 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'] 16:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:51:44 INFO - Reading from file tmpfile_stdout 16:51:44 INFO - Output received: 16:51:44 INFO - /builds/slave/test/build/application/firefox/firefox 16:51:44 INFO - Running post-action listener: _resource_record_post_action 16:51:44 INFO - [mozharness: 2017-05-28 23:51:44.949882Z] Finished install step (success) 16:51:44 INFO - [mozharness: 2017-05-28 23:51:44.950162Z] Running setup-mitmproxy step. 16:51:44 INFO - Running pre-action listener: _resource_record_pre_action 16:51:44 INFO - Running main action method: setup_mitmproxy 16:51:44 INFO - Skipping: mitmproxy is not required 16:51:44 INFO - Running post-action listener: _resource_record_post_action 16:51:44 INFO - [mozharness: 2017-05-28 23:51:44.951312Z] Finished setup-mitmproxy step (success) 16:51:44 INFO - [mozharness: 2017-05-28 23:51:44.951533Z] Running run-tests step. 16:51:44 INFO - Running pre-action listener: _resource_record_pre_action 16:51:44 INFO - Running main action method: run_tests 16:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:44 INFO - Python 2.7.3 16:51:44 INFO - Return code: 0 16:51:44 INFO - grabbing minidump binary from tooltool 16:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:44 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 0x24fbe40>, '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 0x24fcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24fd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:44 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 16:51:44 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 16:51:44 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 16:51:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:45 INFO - Return code: 0 16:51:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:51:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:45 INFO - ENV: RUST_BACKTRACE is now 1 16:51:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:51:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 16:51:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 16:51:45 INFO - Using env: {'DISPLAY': ':0', 16:51:45 INFO - 'HOME': '/home/cltbld', 16:51:45 INFO - 'LANG': 'en_US.UTF-8', 16:51:45 INFO - 'LANGUAGE': 'en_US:en', 16:51:45 INFO - 'LOGNAME': 'cltbld', 16:51:45 INFO - 'MAIL': '/var/mail/cltbld', 16:51:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:45 INFO - 'MOZ_NO_REMOTE': '1', 16:51:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:45 INFO - 'NO_EM_RESTART': '1', 16:51:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:45 INFO - 'PWD': '/builds/slave/test', 16:51:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:45 INFO - 'RUST_BACKTRACE': '1', 16:51:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:51:45 INFO - 'SHELL': '/bin/bash', 16:51:45 INFO - 'SHLVL': '1', 16:51:45 INFO - 'TERM': 'linux', 16:51:45 INFO - 'TMOUT': '86400', 16:51:45 INFO - 'USER': 'cltbld', 16:51:45 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678', 16:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:45 INFO - '_': '/tools/buildbot/bin/python'} 16:51:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 16:51:45 INFO - mozversion application_buildid: 20170528225122 16:51:45 INFO - mozversion application_changeset: 4541134e973a6bd5e667a603e844854c8e5361da 16:51:45 INFO - mozversion application_display_name: Nightly 16:51:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:45 INFO - mozversion application_name: Firefox 16:51:45 INFO - mozversion application_remotingname: firefox 16:51:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:51:45 INFO - mozversion application_vendor: Mozilla 16:51:45 INFO - mozversion application_version: 55.0a1 16:51:45 INFO - mozversion platform_buildid: 20170528225122 16:51:45 INFO - mozversion platform_changeset: 4541134e973a6bd5e667a603e844854c8e5361da 16:51:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:51:45 INFO - mozversion platform_version: 55.0a1 16:51:45 INFO - using testdate: 1496015505 16:51:45 INFO - actual date: 1496015505 16:51:45 INFO - starting webserver on 'localhost:49583' 16:51:45 INFO - SUITE-START | Running 2 tests 16:51:45 INFO - TEST-START | dromaeo_css 16:51:45 INFO - operating with platform_type : linux_ 16:51:45 INFO - Initialising browser for dromaeo_css test... 16:51:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49583/getInfo.html -profile /tmp/tmpvZBdDS/profile 16:51:45 INFO - TEST-INFO | started process 10247 (/builds/slave/test/build/application/firefox/firefox http://localhost:49583/getInfo.html) 16:52:20 INFO - TEST-INFO | 10247: killed by SIGTERM 16:52:20 INFO - Browser initialized. 16:52:20 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:20 INFO - TEST-INFO | started process 10468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvZBdDS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:32 INFO - PID 10468 | RSS: Main: 187068416 16:52:32 INFO - PID 10468 | 16:55:37 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49583/tests/dromaeo/cssquery-ext.html) 16:55:39 INFO - PID 10468 | RSS: Main: 184016896 16:55:39 INFO - PID 10468 | 16:58:41 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-ext.html (next: http://localhost:49583/tests/dromaeo/cssquery-jquery.html) 16:58:41 INFO - PID 10468 | RSS: Main: 188194816 16:58:41 INFO - PID 10468 | 17:01:43 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49583/tests/dromaeo/cssquery-mootools.html) 17:01:44 INFO - PID 10468 | RSS: Main: 185270272 17:01:44 INFO - PID 10468 | 17:04:46 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49583/tests/dromaeo/cssquery-prototype.html) 17:04:46 INFO - PID 10468 | RSS: Main: 189784064 17:04:46 INFO - PID 10468 | 17:07:49 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49583/tests/dromaeo/cssquery-yui.html) 17:07:50 INFO - PID 10468 | RSS: Main: 188243968 17:07:50 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | Cycle 1(1): loaded http://localhost:49583/tests/dromaeo/cssquery-yui.html (next: http://localhost:49583/tests/dromaeo/cssquery-dojo.html) 17:10:52 INFO - PID 10468 | RSS: Main: 186925056 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | __start_tp_report 17:10:52 INFO - PID 10468 | _x_x_mozilla_page_load 17:10:52 INFO - PID 10468 | _x_x_mozilla_page_load_details 17:10:52 INFO - PID 10468 | |i|pagename|runs| 17:10:52 INFO - PID 10468 | |0;dojo.html;2746.9038583649576;2773.819701719388;2781.3463835998537;2801.95797063044;2814.0150947168495;5214.322138122048;5257.316548848649;5304.310439642841;5321.909008653227;5369.838904832856;5244.606654500918;5252.264682944391;5265.605079619035;5425.159100339453;5447.96488667153;4747.1692453820615;4777.116233496797;4828.251620998751;4829.975850120744;4841.636877234204;4785.282207668843;4790.353302304196;4852.199387101124;4874.098291816008;4917.778699958492;4696.929546056812;4745.905081898342;4825.396825396825;4833.927491087637;4872.001239745844;4771.904561908777;4819.08437396897;4844.806207751721;4848.0788650156355;4866.391701037371;4732.810006512607;4766.332713420124;4770.809167633291;4776.904461910743;4780.020095880336;5335.359756829166;5363.436839131913;5375.3280839895015;5377.596680248997;5385.084535628953;5648.6893220872835;5706.514946229576;5722.771089156428;5727.513161381287;5807.970960145214;5847.356790753014;5863.032599621058;5867.3839246879315;5910.290765108171;5914.37899020601;5412.4858138477175;5420.864478388072;5426.077566813651;5426.511613954763;5430.83707488776;5786.652800831964;5894.941050589439;5982.820515384546;6002.519798416203;6020.729067191987;5628.380878103405;5696.3449203341315;5705.343885453226;5721.713914304268;5724.685142317213;5708.54331653475;5819.709014549256;5837.562182836305;5852.473277405054;5869.882602348014;5769.740361683735;5795.7971470999155;5797.420257974169;5798.507126894261;5813.941860581424;5665.915011274834;5744.109663002241;5759.568032397587;5763.884722305615;5813.215215945793;4857.489963553847;4868.440129385166;4873.244647079709;4893.314935908976;4915.361003069578;4170.249355116048;4171.10321280926;4171.833126674899;4204.26425375558;4214.873553793391;4761.071591039714;4835.371401717754;4851.878703032382;4883.780229889663;4901.852944411673;5799.739011744482;5853.5317174625925;5863.648181109147;5906.704664766745;5916.792912248051;4894.902101957941;4910.288008238786;4914.631402644816;4914.975425122851;4952.554270115635;5032.572231360376;5113.335266415343;5132.46109158533;5160.40655324635;5164.431912489623;5424.593155513431;5509.669419834822;5510.504054635102;5518.475744804397;5530.6128570999645;5684.9431505684415;5826.796062137805;5858.150568167677;5860.355360910382;5860.589758716849;5357.571394288526;5384;5434.266374039454;5448;5448.101063324666;5546.861328466821;5664.178694089416;5689.402612725769;5693.829185124453;5712.285964254468;5714.79998200061;5775.104858746901;5788.8552786179;5846.181534585076;5863.912041319299;5619.550435965195;5627.831165065055;5630.60585758993;5632.211490391266;5660.46225608583;5539.362973257966;5591.27313449249;5604.523615492729;5613.550915926634;5622.044252477171;5378.650387724785;5458.235846981505;5497.615166938436;5522.2544956430365;5605.271314729059;5733.483986441241;5748.913766293593;5754.309482862083;5787.247657804627;5792.82621521355;5526.530244929226;5537.086380747131;5579.916301255404;5579.967705974408;5597.496225339576 17:10:52 INFO - PID 10468 | |1;ext.html;699.8985147153661;722.9313215244551;942.6041062753643;960.3901522533189;991.4546999150465;32004.199895002606;32920.34159316812;32961.67038329616;32974.67025329746;32990.835045824795;31213.219669508275;31398;31457.370852582935;31517.212069698213;31531;6471.449926756231;6593.208814942213;6608.306127856578;6758.932410675904;6769.390754832064;6697.933020669804;6765.526413151057;6783.321667833202;6790.49071319653;6799.558028728142;6744.527883048188;6779.15260592426;6783.966080169617;6795.626240556768;6814.659267036654;6735.158105236846;6791.728330866759;6794.592324460499;6797.898031529556;6801.829954251134;6612.206535215805;6654.633995130266;6667.633280169589;6670.6331151786635;6670.866582668368;31156.688433115607;31340.373192536248;31448;31469.8426507866;31580.684193158006;2817.1548535439492;2849.031329348011;2853.7003614620376;2874.942501149986;2878.8992385266624;23910.521789564285;23925.282241532783;24051;24071.518569628686;24161;3035.48396772547;3077.9076627701206;3086.768492363082;3091.1190310761326;3128.7340576051065;148394.25802871023;148997;149382.99999999892;149770.25114874466;149774.25112874366;31749;32097;36947.261054778755;37694.62305376911;39048.80475597604;39212.2157556853;39242.80378598089;39249.41125883114;39251;39329.60670393317;11055.336679799238;11187.720306992227;11192.496337664825;11197.104231661448;11242.831357529643;8798.34012449056;8863.556822158866;8894.066123057115;8911.73264802057;9008;11876.10929180315;11888.167828251939;11899.34553599543;11962.461689224006;12119.757604847853;5043.621728370387;5078.289039534468;5082.669626474341;5100.48995100487;5133.819221578983;836.786619412046;853.4111463090571;878.1832895407205;901.1349104859278;904.4980036080038;18515.981621010975;18619;19108.808911910983;19593.216271349273;19821.900890495453;946.3848498476045;952.6713283917038;969.2294625772528;973.1825266775801;973.6446197137993;10058.663969016661;10295.485225738683;10385.948070259601;10504.527296271686;10534.683959481228;172710;173438;173680;174155;174238;38785.80607097003;38828;38876.80561597174;38995.61004389977;39040.2191956165;1114.3982249585133;1159.211736019498;1163.2264544078262;1166.5567084508002;1167.7197472606513;17876.91061544736;18004.90997545004;18180.636387272443;18548;19007.809921900604;28253.43493130167;28478.288042799097;28496;28541.714582853907;28681.569776453787;150781;151833.44499665027;152114.23942880216;152263;153027.23486382497;27684;27867;27896.721032789414;29228.853855730584;29600;35369;35496.29007419785;35619.46570801388;35681.1079723009;35807.46288805722;25410.491790163724;26367.60448593311;26644.467110658064;27505.587416189173;27775;26573.706174875213;26757.598636020084;27284.31789205286;28470.288242794097;28559.571606426336;29200.41599168047;29646.40707185801;29912.10263692093;30145;30183.245418864703;26032.609510857732;26551.468970620866;26660.200193994213;26953.865230674506;27706.874228267836;20246;22147.667784982918;22220;22263.66604500966;22268.220612278492 17:10:52 INFO - PID 10468 | |2;jquery.html;386.3817891373802;386.66167103784187;407.3035109961965;411.9423280740697;427.81390095308535;12865.292408917507;14960.40158393663;16762.413315533944;17520.123993800324;17539.73690394645;16806.495805125865;17071.231794569245;17202.741958870625;17715.73426398605;17841.286348546077;4941.925871111936;5147.433782283946;5161.7161056141895;5162.845114646548;5169.379674439054;4875.609951203913;5024.371953505812;5031.3207716958295;5038.672486288379;5048.570871475929;5005.724685142316;5030.949690503103;5031.723255220962;5034.169362055257;5047.31861198739;4863.343448634424;4963.7021778693215;5022.070916880352;5022.17134172861;5028.673136246132;4570.474395444533;4574.1080489304595;4576.427946506687;4595.747233902134;4602.447706275235;20995.265165719127;21097.180710069242;21433.46416339604;21607.1357145714;21767.129314827387;1611.4359974009121;1629.331973890711;1629.3401172525146;1629.983700163007;1631.4453085950834;14340.139591624431;14474.131552106803;14651.120932743963;14700.55898323052;14877.256137193097;2053.5071582820165;2087.1338394566237;2124.298981336171;2138.604358193724;2152.860064095829;78678;79559;79704.60147699225;79796.60101699512;80261.59869200675;10763.515641796137;10988.120950323955;11035.83446248307;11126.38804865724;11168.553257869757;14992.47526336573;15042;15149.257835348855;15170.848291516944;15173.924130379499;6329.240491141092;6633.336666333328;7076.540024898468;7395.260473952561;7406;6508.5769424988175;6598.076269322299;6745.730170793114;6751.358620931003;6772.830679233059;6674;6767.695453704595;6809.795706128824;6853.246142924274;6882.83190794898;2039.258723467943;2042.3464491362622;2057.506198512346;2059.155746144074;2067.7208576841936;819.5697258939105;857.4598003257908;857.9871301930476;884.6240347852137;891.7114769158633;16629;16699.6660066798;16904.323827047025;17038.31846726117;17491.91254043747;860.7202659135806;867.9739607811775;869.556526171657;874.3180319350917;886.1847100667402;8782.560871956504;8931.553422328858;9128.543572821332;9208.848893888264;9335;335816;336787;340621;342280;343001;79028.60485697535;79946;79949.60025199837;80499.59750201211;82497.17502824895;1036.7511797168625;1078.4769386847372;1083.6478144603036;1083.756154865149;1085.3216739537788;17213.397531086353;17340.306387744855;17965.10174491244;18035.278588856298;18243.817561824213;39465.21069578535;40914;41806.79096604497;43184;43256.35115473333;47679.76160119177;48389.27416088832;48828;49700;50008.49991500184;8229;8292.87560686578;8399.370047246359;8452.408331416987;8735.082816304452;12963.287019214034;13168.934155329162;13299;13413.86586134126;13516.5269215577;11330.093592512743;11395.772084558428;11576.073914086684;11645.41772911368;11735.530578776754;10493.370397776158;10614.416207108374;10650.360978341325;10924.617638382619;10952.616658416917;11483.885161148615;11493.367864767184;11532.59635912739;11718.589849355232;11956.222845515014;8074.071481779671;8074.555899425353;8279.793005174919;8279.917200828155;8313.376496762647;11144.387058711849;11171.329720216812;11222.887771122185;11237.269577477438;11347.659570212907 17:10:52 INFO - PID 10468 | |3;mootools.html;1178.2989121472722;1227.8342423772795;1241.627511746477;1252.6492582077017;1257.6667183196455;10328.122109620683;10412.375257484557;10644.62743803967;10889.618863339785;10895;10364.481775911212;10520.263581549294;10540.209484288689;10557.049865512103;10584.841227381576;2131.3925531223604;2131.73353330834;2148.581026699794;2166.978330216701;2172.4568857785553;1990.7312512810802;2015.1737787507125;2022.1102714805438;2029.4317591074448;2031.055559164988;2051.54865929496;2052.6818343156833;2066.1322244657204;2066.442060643625;2081.5316553775356;2033.5322875738516;2037.6943458481198;2039.46973786815;2043.6525790615556;2043.6525790615556;1838.4117082533594;1903.5241189702574;1997.2111016148685;2018.9697154542694;2096.612126756555;10199.592016319339;10249.743756406075;10253.897461025368;10254.179665626732;10257.33327333721;5412.648177868426;5634.211210430543;5636.971815140939;5645.15322701594;5648;3227.3061872845064;3392.7794693344854;3427.6229614742606;3437.570303712036;3438.1920248741776;1049.2393015064094;1074.8925107489267;1076.381080878498;1093.2347356850157;1115.9609413670564;14903.254837258202;14975.625609359744;15012;15092.924535377362;15109.5467135985;4537.75042372666;4658.161530924398;4691.9530804692195;4720.834770783074;4740.786664600101;10537.051665350155;10537.998890105428;10538.841917371246;10550.841737373945;10558.472076396149;5163.870903227449;5390.137577987582;5399.325084364455;5403.243545903577;5413.296271484682;4925.852224433273;4971.925421118686;4972.8756781080765;5026.421961474404;5038.445770965191;3756.3614185588517;3798.563165235978;3850.537935447764;3879.127196380848;3953.802309884552;1121.0975164992096;1123.393367581513;1134.3137401871913;1154.5958914380067;1155.1163360029584;599.4724642314823;618.4001518527022;623.6632218601995;624.3974564545235;625.671522450717;4801.639877009238;4867.659263851568;4906.1414252505665;4981.2030075187795;5032.496750324938;510.88760472695947;532.5287120897956;533.7891532844504;535.4672101259272;535.8740695936452;2969.1092672198256;2999.6850330715397;3015.0954713586275;3034.631022110306;3047.83236921967;13077.673058173621;13234.735305294033;13329.266890321125;13578.253196074113;13715.519956801463;12875.484980600671;13021;13253.204807711569;13305.534306299427;13348.132371395828;7232.927670723226;7379.040724705861;7386.852262954711;7392.926070739331;7406.259374062551;5339.119045357473;5401.729913504388;5469.781208751605;5611.9772803339965;5838.2702162229725;12028.879711203126;12068.094892882893;12100.455479503267;12166.939165304117;12229.205101668364;12414.937925310316;12576.622701318975;12794.040446966701;12808.807867882175;12937.288449135387;9662.227021838096;9916.305858590118;9978.650747223812;9989.850152247576;10014.098731113943;9166.129217724305;9623.326367154232;9722.854157187507;9730.95134524323;9745.902540974499;8205.917940820515;8240.423170378015;8261.339092872677;8271;8328.708495202638;7989;8051.114377418362;8113.0669972953865;8209.507429554245;8375.916240837514;7048.682809273492;7052.188998265266;7064.752733654297;7115.75094871677;7119.964400177966;4854.19905715553;4854.732989685601;4910.656254062182;4919.655624106278;4928.753562321798;4712.787924543472;4738.8341408050555;4774.140654682191;4887.291342755351;4930.383702037246 17:10:52 INFO - PID 10468 | |4;prototype.html;375.06608544723645;376.533098957293;376.89823747588133;381.6202878136254;384.235371610495;5425;5470.097433923403;5510.1734739789;5527.613067085305;5528.004959107359;5333.679979201251;5427.887283106964;5437.918431223535;5440.183972404131;5448.42791506891;3992.7205095643317;4124.443200167969;4145.129522800215;4146.813393397297;4160.83356665733;4138.985948442636;4143.606357396057;4150;4157.937630935523;4167.583241675823;4103.322951712964;4111.609397107285;4115.8765237042935;4133.8966525836795;4139.254934111874;4057.89855253621;4088.8773336799945;4103.563752686566;4117.835286588533;4122.711410201302;3591.8742844000335;3603.72972027099;3606.296772129436;3608;3614.6987084649504;5324.946750532484;5342.759575819097;5344.545713614348;5351.598630102719;5361;4718.386609740746;4803.9039219215765;4851.320815085891;4857.684250523705;4872.951270487285;5752.424757524256;5758.42415758425;5773.913391299134;5784.971075144639;5797.507211886995;4023.537293211289;4035.6973227007798;4039.7576145431367;4051.4125451809323;4051.817668204938;6000.21997140369;6130.1724267224245;6142.385761423822;6171.84570385744;6201.930044627893;4129.545749967501;4151.377293406013;4152.190322887069;4157.750534967911;4169.791510424467;4131.690123240769;4136.875893723193;4159.854405095807;4179.310413781753;4183.226103170923;4647.767611619405;4767.547083027107;4774.212254977959;4793.472718001017;4805.9759701201965;5779.508741756914;5782.624129431573;5805.94194058054;5808.041673123887;5821.88356232873;1401.7524403281088;1422.1467119728288;1426.1158081989233;1427.7287315410247;1439.2587817274111;901.3825529512173;953.0993211415146;962.6197651927589;969.069693094623;970.8737864077766;4995.350604421402;4996.100701873697;5007.4491805901325;5007.7245751484015;5014.222795466709;5997.970010150008;6014.428629280212;6018.789342372996;6020.247469066367;6030.9796218267375;4864.489228631013;4978.626603004789;4996;5011.223260394645;5021.799128034911;3143.324185300126;3185.7292130169194;3194.7923384979904;3201.567788348543;3205.1987003249187;5493.697846618475;5577.163425486209;5595.76893083521;5604.607677462538;5634.6337488063145;5854.7072646367515;6117.449429551361;6144;6163.445289923929;6164.855923479058;5411.323584551931;5489.698066606375;5543.61194716366;5550.47270509301;5580.86047848807;5935.970320148372;5938.138969849261;5972.044472884318;5981.641101533748;6011.609245399035;5651.180578816131;5888.823335299948;5893.499052580579;5931.970340148444;5936.436038576328;5595.748191331481;5616.21373007771;5623.662580245198;5627.268455100974;5644.895307580732;4399.230134726474;4476.060027394284;4507.75207363585;4528.43394575678;4551.772411379484;5990.371011043778;6023.789167379121;6030.547708921936;6035.879282414239;6038.184845045863;5728.713564321684;5730.283714535683;5734.971325143348;5740.282464691913;5802.361740208658;5635.351934527582;5777.595568310346;5784.50831679312;5789;5809.215755872903;5715.142728590745;5724.79963201286;5727.914081288867;5729.598928074995;5766.365699773106;5774.884502310014;5782.681952492653;5820.883582328414;5857.8535536610225;5873.3832947539895;5574.86062848432;5610.270664813548;5612.85967850807;5669.971650141723;5683.7779877326575 17:10:52 INFO - PID 10468 | |5;yui.html;684.8835697931352;696.6760456387779;708.0547469128713;717.2648035763342;724.6630316902641;12297.877021229786;13012.089153759218;13165.934170329147;14140.92929535351;14145.29273536323;12758.234505929651;13169;13254.138480998728;13275.933620331909;13276.93361533191;775.6121939030485;795.8448102619991;802.5265093594778;802.638812534359;802.9197080291982;790.1624278265058;793.9761807145795;794.6860989908982;795.0697683710044;796.0884786918974;830.6635812495949;833.1293797981124;835.5571547080058;837.1168417319725;840.1262686805715;820.7332616899472;824.5712229640583;826.9545175015372;830.7590798668379;831.2850948184556;579.597179959928;591.9788365070219;593.9368530330703;596.7911231069135;603.1766638538408;13901.79147312791;14164.645883852883;14166.645833854132;14172.220527870963;14201.502947396895;13988.650283742885;14062.367193476319;14607.415703371853;14754.557363279118;14759.409623615042;12805.807912881315;12976.805347919695;13048.608541743668;13158.802617960739;13206.33968301581;2943.7792165587666;2961.096865456035;2969.376430949503;2970.5098658721286;2972.7473164781018;77981.69265456534;79014.604926975;79146;79465.60267198627;79630;10694.73263168427;12351.876481235073;12787.936060319826;12812.871871281355;12833.679158020937;21640.24259150922;21937.122515099538;21974.89012554927;22222.66666000011;22930;6489.675516224264;6612.603243805387;6621.238557565942;6623.801285961429;6625.3374662534325;3062.3262882165886;3111.8132912025353;3114.5795317632283;3126.140311414379;3130.060981705479;3725.2549490102087;3746.269477451925;3794.506714127201;3826.712996525216;3838.500994870649;683.5147045597582;733.7651951375509;739.2976672161468;742.1613576658342;742.8180095876437;581.447624756483;586.3813676571173;605.833395816154;622.7602373086395;623.1431781300712;9056.320775941831;9659.517024148765;9808.705738827846;10002.34984726005;10211.897881021243;553.3442870198827;563.1074746526801;564.6527385657873;566.6798258983661;581.5667327840786;4306.849260275875;4431.423914891044;4479.61923236522;4490.57339552742;4595.540445955377;84649;86323;86393;87463.56268218618;88191.55904220438;76758;77656.61171694218;77722.61138694384;78062.6096869512;79366.6031669838;60942;61417.692911534265;65568.85329493998;66354.66822665856;67283.66358168276;9458.668946586837;10080.69757907264;10281.537330819981;10317.329373590692;10354.637587684394;26301.473970520867;26517.867410663595;27199.72800271972;30848.84575577108;31326.373472529966;61751;65306.346936530026;66209.01372958819;67368;67587.66206168938;13564.118332308368;14774.778378324549;15088.54734357971;15339.693206136038;15444.92277538605;15942;16048.759268611213;16062.67874642524;16193.514194574182;16424.67150657004;11496.195266331277;11522.711932201762;11646.534138634359;11761.059115270587;15163.696726065638;14573.708525829636;14695.41218351254;15013.474528391454;15277.465288714842;15359;13542.119762215425;13565.457381705017;14044.368003439666;14152.646183845487;14152.858471415155;9835.950820246138;10017.849732254168;10163.644272450429;10210.591576336863;10673.146148307962;11393.316401015965;12343.19769214998;12367.567135150226;12441.315727635067;12616.243025418504 17:10:52 INFO - PID 10468 | __end_tp_report 17:10:52 INFO - PID 10468 | __start_cc_report 17:10:52 INFO - PID 10468 | _x_x_mozilla_cycle_collect,384 17:10:52 INFO - PID 10468 | __end_cc_report 17:10:52 INFO - PID 10468 | __startTimestamp1496016652346__endTimestamp 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | ------- Summary: start ------- 17:10:52 INFO - PID 10468 | Number of tests: 6 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#0] dojo.html Cycles:165 Average:5299.75 Median:5458.24 stddev:623.96 (11.4%) stddev-sans-first:592.87 17:10:52 INFO - PID 10468 | Values: 2746.9 2773.8 2781.3 2802.0 2814.0 5214.3 5257.3 5304.3 5321.9 5369.8 5244.6 5252.3 5265.6 5425.2 5448.0 4747.2 4777.1 4828.3 4830.0 4841.6 4785.3 4790.4 4852.2 4874.1 4917.8 4696.9 4745.9 4825.4 4833.9 4872.0 4771.9 4819.1 4844.8 4848.1 4866.4 4732.8 4766.3 4770.8 4776.9 4780.0 5335.4 5363.4 5375.3 5377.6 5385.1 5648.7 5706.5 5722.8 5727.5 5808.0 5847.4 5863.0 5867.4 5910.3 5914.4 5412.5 5420.9 5426.1 5426.5 5430.8 5786.7 5894.9 5982.8 6002.5 6020.7 5628.4 5696.3 5705.3 5721.7 5724.7 5708.5 5819.7 5837.6 5852.5 5869.9 5769.7 5795.8 5797.4 5798.5 5813.9 5665.9 5744.1 5759.6 5763.9 5813.2 4857.5 4868.4 4873.2 4893.3 4915.4 4170.2 4171.1 4171.8 4204.3 4214.9 4761.1 4835.4 4851.9 4883.8 4901.9 5799.7 5853.5 5863.6 5906.7 5916.8 4894.9 4910.3 4914.6 4915.0 4952.6 5032.6 5113.3 5132.5 5160.4 5164.4 5424.6 5509.7 5510.5 5518.5 5530.6 5684.9 5826.8 5858.2 5860.4 5860.6 5357.6 5384.0 5434.3 5448.0 5448.1 5546.9 5664.2 5689.4 5693.8 5712.3 5714.8 5775.1 5788.9 5846.2 5863.9 5619.6 5627.8 5630.6 5632.2 5660.5 5539.4 5591.3 5604.5 5613.6 5622.0 5378.7 5458.2 5497.6 5522.3 5605.3 5733.5 5748.9 5754.3 5787.2 5792.8 5526.5 5537.1 5579.9 5580.0 5597.5 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#1] ext.html Cycles:180 Average:29493.86 Median:3056.70 stddev:40955.25 (1339.9%) stddev-sans-first:41013.07 17:10:52 INFO - PID 10468 | Values: 699.9 722.9 942.6 960.4 991.5 32004.2 32920.3 32961.7 32974.7 32990.8 31213.2 31398.0 31457.4 31517.2 31531.0 6471.4 6593.2 6608.3 6758.9 6769.4 6697.9 6765.5 6783.3 6790.5 6799.6 6744.5 6779.2 6784.0 6795.6 6814.7 6735.2 6791.7 6794.6 6797.9 6801.8 6612.2 6654.6 6667.6 6670.6 6670.9 31156.7 31340.4 31448.0 31469.8 31580.7 2817.2 2849.0 2853.7 2874.9 2878.9 23910.5 23925.3 24051.0 24071.5 24161.0 3035.5 3077.9 3086.8 3091.1 3128.7 148394.3 148997.0 149383.0 149770.3 149774.3 31749.0 32097.0 36947.3 37694.6 39048.8 39212.2 39242.8 39249.4 39251.0 39329.6 11055.3 11187.7 11192.5 11197.1 11242.8 8798.3 8863.6 8894.1 8911.7 9008.0 11876.1 11888.2 11899.3 11962.5 12119.8 5043.6 5078.3 5082.7 5100.5 5133.8 836.8 853.4 878.2 901.1 904.5 18516.0 18619.0 19108.8 19593.2 19821.9 946.4 952.7 969.2 973.2 973.6 10058.7 10295.5 10385.9 10504.5 10534.7 172710.0 173438.0 173680.0 174155.0 174238.0 38785.8 38828.0 38876.8 38995.6 39040.2 1114.4 1159.2 1163.2 1166.6 1167.7 17876.9 18004.9 18180.6 18548.0 19007.8 28253.4 28478.3 28496.0 28541.7 28681.6 150781.0 151833.4 152114.2 152263.0 153027.2 27684.0 27867.0 27896.7 29228.9 29600.0 35369.0 35496.3 35619.5 35681.1 35807.5 25410.5 26367.6 26644.5 27505.6 27775.0 26573.7 26757.6 27284.3 28470.3 28559.6 29200.4 29646.4 29912.1 30145.0 30183.2 26032.6 26551.5 26660.2 26953.9 27706.9 20246.0 22147.7 22220.0 22263.7 22268.2 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#2] jquery.html Cycles:180 Average:23851.95 Median:386.52 stddev:56732.21 (14677.6%) stddev-sans-first:56864.00 17:10:52 INFO - PID 10468 | Values: 386.4 386.7 407.3 411.9 427.8 12865.3 14960.4 16762.4 17520.1 17539.7 16806.5 17071.2 17202.7 17715.7 17841.3 4941.9 5147.4 5161.7 5162.8 5169.4 4875.6 5024.4 5031.3 5038.7 5048.6 5005.7 5030.9 5031.7 5034.2 5047.3 4863.3 4963.7 5022.1 5022.2 5028.7 4570.5 4574.1 4576.4 4595.7 4602.4 20995.3 21097.2 21433.5 21607.1 21767.1 1611.4 1629.3 1629.3 1630.0 1631.4 14340.1 14474.1 14651.1 14700.6 14877.3 2053.5 2087.1 2124.3 2138.6 2152.9 78678.0 79559.0 79704.6 79796.6 80261.6 10763.5 10988.1 11035.8 11126.4 11168.6 14992.5 15042.0 15149.3 15170.8 15173.9 6329.2 6633.3 7076.5 7395.3 7406.0 6508.6 6598.1 6745.7 6751.4 6772.8 6674.0 6767.7 6809.8 6853.2 6882.8 2039.3 2042.3 2057.5 2059.2 2067.7 819.6 857.5 858.0 884.6 891.7 16629.0 16699.7 16904.3 17038.3 17491.9 860.7 868.0 869.6 874.3 886.2 8782.6 8931.6 9128.5 9208.8 9335.0 335816.0 336787.0 340621.0 342280.0 343001.0 79028.6 79946.0 79949.6 80499.6 82497.2 1036.8 1078.5 1083.6 1083.8 1085.3 17213.4 17340.3 17965.1 18035.3 18243.8 39465.2 40914.0 41806.8 43184.0 43256.4 47679.8 48389.3 48828.0 49700.0 50008.5 8229.0 8292.9 8399.4 8452.4 8735.1 12963.3 13168.9 13299.0 13413.9 13516.5 11330.1 11395.8 11576.1 11645.4 11735.5 10493.4 10614.4 10650.4 10924.6 10952.6 11483.9 11493.4 11532.6 11718.6 11956.2 8074.1 8074.6 8279.8 8279.9 8313.4 11144.4 11171.3 11222.9 11237.3 11347.7 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#3] mootools.html Cycles:180 Average:6236.98 Median:3137.57 stddev:4177.59 (133.1%) stddev-sans-first:4172.02 17:10:52 INFO - PID 10468 | Values: 1178.3 1227.8 1241.6 1252.6 1257.7 10328.1 10412.4 10644.6 10889.6 10895.0 10364.5 10520.3 10540.2 10557.0 10584.8 2131.4 2131.7 2148.6 2167.0 2172.5 1990.7 2015.2 2022.1 2029.4 2031.1 2051.5 2052.7 2066.1 2066.4 2081.5 2033.5 2037.7 2039.5 2043.7 2043.7 1838.4 1903.5 1997.2 2019.0 2096.6 10199.6 10249.7 10253.9 10254.2 10257.3 5412.6 5634.2 5637.0 5645.2 5648.0 3227.3 3392.8 3427.6 3437.6 3438.2 1049.2 1074.9 1076.4 1093.2 1116.0 14903.3 14975.6 15012.0 15092.9 15109.5 4537.8 4658.2 4692.0 4720.8 4740.8 10537.1 10538.0 10538.8 10550.8 10558.5 5163.9 5390.1 5399.3 5403.2 5413.3 4925.9 4971.9 4972.9 5026.4 5038.4 3756.4 3798.6 3850.5 3879.1 3953.8 1121.1 1123.4 1134.3 1154.6 1155.1 599.5 618.4 623.7 624.4 625.7 4801.6 4867.7 4906.1 4981.2 5032.5 510.9 532.5 533.8 535.5 535.9 2969.1 2999.7 3015.1 3034.6 3047.8 13077.7 13234.7 13329.3 13578.3 13715.5 12875.5 13021.0 13253.2 13305.5 13348.1 7232.9 7379.0 7386.9 7392.9 7406.3 5339.1 5401.7 5469.8 5612.0 5838.3 12028.9 12068.1 12100.5 12166.9 12229.2 12414.9 12576.6 12794.0 12808.8 12937.3 9662.2 9916.3 9978.7 9989.9 10014.1 9166.1 9623.3 9722.9 9731.0 9745.9 8205.9 8240.4 8261.3 8271.0 8328.7 7989.0 8051.1 8113.1 8209.5 8375.9 7048.7 7052.2 7064.8 7115.8 7120.0 4854.2 4854.7 4910.7 4919.7 4928.8 4712.8 4738.8 4774.1 4887.3 4930.4 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#4] prototype.html Cycles:180 Average:4770.94 Median:5444.31 stddev:1412.92 (26.0%) stddev-sans-first:1377.82 17:10:52 INFO - PID 10468 | Values: 375.1 376.5 376.9 381.6 384.2 5425.0 5470.1 5510.2 5527.6 5528.0 5333.7 5427.9 5437.9 5440.2 5448.4 3992.7 4124.4 4145.1 4146.8 4160.8 4139.0 4143.6 4150.0 4157.9 4167.6 4103.3 4111.6 4115.9 4133.9 4139.3 4057.9 4088.9 4103.6 4117.8 4122.7 3591.9 3603.7 3606.3 3608.0 3614.7 5324.9 5342.8 5344.5 5351.6 5361.0 4718.4 4803.9 4851.3 4857.7 4873.0 5752.4 5758.4 5773.9 5785.0 5797.5 4023.5 4035.7 4039.8 4051.4 4051.8 6000.2 6130.2 6142.4 6171.8 6201.9 4129.5 4151.4 4152.2 4157.8 4169.8 4131.7 4136.9 4159.9 4179.3 4183.2 4647.8 4767.5 4774.2 4793.5 4806.0 5779.5 5782.6 5805.9 5808.0 5821.9 1401.8 1422.1 1426.1 1427.7 1439.3 901.4 953.1 962.6 969.1 970.9 4995.4 4996.1 5007.4 5007.7 5014.2 5998.0 6014.4 6018.8 6020.2 6031.0 4864.5 4978.6 4996.0 5011.2 5021.8 3143.3 3185.7 3194.8 3201.6 3205.2 5493.7 5577.2 5595.8 5604.6 5634.6 5854.7 6117.4 6144.0 6163.4 6164.9 5411.3 5489.7 5543.6 5550.5 5580.9 5936.0 5938.1 5972.0 5981.6 6011.6 5651.2 5888.8 5893.5 5932.0 5936.4 5595.7 5616.2 5623.7 5627.3 5644.9 4399.2 4476.1 4507.8 4528.4 4551.8 5990.4 6023.8 6030.5 6035.9 6038.2 5728.7 5730.3 5735.0 5740.3 5802.4 5635.4 5777.6 5784.5 5789.0 5809.2 5715.1 5724.8 5727.9 5729.6 5766.4 5774.9 5782.7 5820.9 5857.9 5873.4 5574.9 5610.3 5612.9 5670.0 5683.8 17:10:52 INFO - PID 10468 | 17:10:52 INFO - PID 10468 | [#5] yui.html Cycles:180 Average:17952.38 Median:3735.76 stddev:24026.16 (643.1%) stddev-sans-first:24058.57 17:10:52 INFO - PID 10468 | Values: 684.9 696.7 708.1 717.3 724.7 12297.9 13012.1 13165.9 14140.9 14145.3 12758.2 13169.0 13254.1 13275.9 13276.9 775.6 795.8 802.5 802.6 802.9 790.2 794.0 794.7 795.1 796.1 830.7 833.1 835.6 837.1 840.1 820.7 824.6 827.0 830.8 831.3 579.6 592.0 593.9 596.8 603.2 13901.8 14164.6 14166.6 14172.2 14201.5 13988.7 14062.4 14607.4 14754.6 14759.4 12805.8 12976.8 13048.6 13158.8 13206.3 2943.8 2961.1 2969.4 2970.5 2972.7 77981.7 79014.6 79146.0 79465.6 79630.0 10694.7 12351.9 12787.9 12812.9 12833.7 21640.2 21937.1 21974.9 22222.7 22930.0 6489.7 6612.6 6621.2 6623.8 6625.3 3062.3 3111.8 3114.6 3126.1 3130.1 3725.3 3746.3 3794.5 3826.7 3838.5 683.5 733.8 739.3 742.2 742.8 581.4 586.4 605.8 622.8 623.1 9056.3 9659.5 9808.7 10002.3 10211.9 553.3 563.1 564.7 566.7 581.6 4306.8 4431.4 4479.6 4490.6 4595.5 84649.0 86323.0 86393.0 87463.6 88191.6 76758.0 77656.6 77722.6 78062.6 79366.6 60942.0 61417.7 65568.9 66354.7 67283.7 9458.7 10080.7 10281.5 10317.3 10354.6 26301.5 26517.9 27199.7 30848.8 31326.4 61751.0 65306.3 66209.0 67368.0 67587.7 13564.1 14774.8 15088.5 15339.7 15444.9 15942.0 16048.8 16062.7 16193.5 16424.7 11496.2 11522.7 11646.5 11761.1 15163.7 14573.7 14695.4 15013.5 15277.5 15359.0 13542.1 13565.5 14044.4 14152.6 14152.9 9836.0 10017.8 10163.6 10210.6 10673.1 11393.3 12343.2 12367.6 12441.3 12616.2 17:10:52 INFO - PID 10468 | -------- Summary: end -------- 17:10:52 INFO - PID 10468 | 17:10:53 INFO - TEST-INFO | 10468: exit 0 17:10:53 INFO - TEST-OK | dromaeo_css | took 1147975ms 17:10:53 INFO - TEST-START | kraken 17:10:53 INFO - operating with platform_type : linux_ 17:10:53 INFO - Initialising browser for kraken test... 17:10:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49583/getInfo.html -profile /tmp/tmpSMd6vY/profile 17:10:53 INFO - TEST-INFO | started process 10883 (/builds/slave/test/build/application/firefox/firefox http://localhost:49583/getInfo.html) 17:11:28 INFO - TEST-INFO | 10883: killed by SIGTERM 17:11:28 INFO - Browser initialized. 17:11:28 INFO - Running cycle 1/1 for kraken test... 17:11:28 INFO - TEST-INFO | started process 11108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSMd6vY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:40 INFO - PID 11108 | RSS: Main: 187330560 17:11:40 INFO - PID 11108 | 17:11:43 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-beat-detection) 17:11:44 INFO - PID 11108 | RSS: Main: 190074880 17:11:44 INFO - PID 11108 | 17:11:47 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-dft) 17:11:47 INFO - PID 11108 | RSS: Main: 189566976 17:11:47 INFO - PID 11108 | 17:11:50 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-fft) 17:11:51 INFO - PID 11108 | RSS: Main: 186175488 17:11:51 INFO - PID 11108 | 17:11:53 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49583/tests/kraken/driver.html?testName=audio-oscillator) 17:11:54 INFO - PID 11108 | RSS: Main: 186343424 17:11:54 INFO - PID 11108 | 17:11:56 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:57 INFO - PID 11108 | RSS: Main: 186347520 17:11:57 INFO - PID 11108 | 17:12:00 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-darkroom) 17:12:00 INFO - PID 11108 | RSS: Main: 190283776 17:12:00 INFO - PID 11108 | 17:12:04 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49583/tests/kraken/driver.html?testName=imaging-desaturate) 17:12:05 INFO - PID 11108 | RSS: Main: 186273792 17:12:05 INFO - PID 11108 | 17:12:07 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49583/tests/kraken/driver.html?testName=json-parse-financial) 17:12:08 INFO - PID 11108 | RSS: Main: 187092992 17:12:08 INFO - PID 11108 | 17:12:10 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:12:10 INFO - PID 11108 | RSS: Main: 187637760 17:12:10 INFO - PID 11108 | 17:12:12 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:12:13 INFO - PID 11108 | RSS: Main: 187351040 17:12:13 INFO - PID 11108 | 17:12:15 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:12:16 INFO - PID 11108 | RSS: Main: 187166720 17:12:16 INFO - PID 11108 | 17:12:19 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:12:19 INFO - PID 11108 | RSS: Main: 187576320 17:12:19 INFO - PID 11108 | 17:12:22 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:12:23 INFO - PID 11108 | RSS: Main: 187232256 17:12:23 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | Cycle 1(1): loaded http://localhost:49583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49583/tests/kraken/driver.html?testName=ai-astar) 17:12:25 INFO - PID 11108 | RSS: Main: 188964864 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | __start_tp_report 17:12:25 INFO - PID 11108 | _x_x_mozilla_page_load 17:12:25 INFO - PID 11108 | _x_x_mozilla_page_load_details 17:12:25 INFO - PID 11108 | |i|pagename|runs| 17:12:25 INFO - PID 11108 | |0;ai-astar;103;111;111;109;111;110;111;110;111;111 17:12:25 INFO - PID 11108 | |1;audio-beat-detection;149;126;123;167;123;124;128;128;147;125 17:12:25 INFO - PID 11108 | |2;audio-dft;165;163;165;172;169;169;162;163;162;165 17:12:25 INFO - PID 11108 | |3;audio-fft;74;76;74;107;74;75;78;75;91;74 17:12:25 INFO - PID 11108 | |4;audio-oscillator;85;84;106;85;84;83;99;83;89;112 17:12:25 INFO - PID 11108 | |5;imaging-gaussian-blur;113;115;114;115;118;116;116;114;120;114 17:12:25 INFO - PID 11108 | |6;imaging-darkroom;150;153;152;151;150;151;150;152;152;150 17:12:25 INFO - PID 11108 | |7;imaging-desaturate;94;96;95;94;95;95;94;94;96;94 17:12:25 INFO - PID 11108 | |8;json-parse-financial;56;55;54;56;57;57;55;59;57;61 17:12:25 INFO - PID 11108 | |9;json-stringify-tinderbox;56;58;56;57;56;56;57;56;61;57 17:12:25 INFO - PID 11108 | |10;stanford-crypto-aes;87;106;88;89;97;96;87;89;129;86 17:12:25 INFO - PID 11108 | |11;stanford-crypto-ccm;134;133;131;146;132;132;132;132;150;145 17:12:25 INFO - PID 11108 | |12;stanford-crypto-pbkdf2;188;187;193;189;191;194;197;198;194;182 17:12:25 INFO - PID 11108 | |13;stanford-crypto-sha256-iterative;78;71;74;77;73;74;72;71;72;71 17:12:25 INFO - PID 11108 | __end_tp_report 17:12:25 INFO - PID 11108 | __start_cc_report 17:12:25 INFO - PID 11108 | _x_x_mozilla_cycle_collect,1021 17:12:25 INFO - PID 11108 | __end_cc_report 17:12:25 INFO - PID 11108 | __startTimestamp1496016745637__endTimestamp 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | ------- Summary: start ------- 17:12:25 INFO - PID 11108 | Number of tests: 14 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.49 (2.2%) stddev-sans-first:0.73 17:12:25 INFO - PID 11108 | Values: 103.0 111.0 111.0 109.0 111.0 110.0 111.0 110.0 111.0 111.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:128.00 stddev:15.06 (11.8%) stddev-sans-first:14.97 17:12:25 INFO - PID 11108 | Values: 149.0 126.0 123.0 167.0 123.0 124.0 128.0 128.0 147.0 125.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.41 (2.1%) stddev-sans-first:3.61 17:12:25 INFO - PID 11108 | Values: 165.0 163.0 165.0 172.0 169.0 169.0 162.0 163.0 162.0 165.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#3] audio-fft Cycles:10 Average:79.80 Median:75.00 stddev:10.87 (14.5%) stddev-sans-first:11.33 17:12:25 INFO - PID 11108 | Values: 74.0 76.0 74.0 107.0 74.0 75.0 78.0 75.0 91.0 74.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:84.50 stddev:10.71 (12.7%) stddev-sans-first:11.14 17:12:25 INFO - PID 11108 | Values: 85.0 84.0 106.0 85.0 84.0 83.0 99.0 83.0 89.0 112.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:115.50 stddev:2.12 (1.8%) stddev-sans-first:2.05 17:12:25 INFO - PID 11108 | Values: 113.0 115.0 114.0 115.0 118.0 116.0 116.0 114.0 120.0 114.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 17:12:25 INFO - PID 11108 | Values: 150.0 153.0 152.0 151.0 150.0 151.0 150.0 152.0 152.0 150.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 17:12:25 INFO - PID 11108 | Values: 94.0 96.0 95.0 94.0 95.0 95.0 94.0 94.0 96.0 94.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:2.06 (3.6%) stddev-sans-first:2.17 17:12:25 INFO - PID 11108 | Values: 56.0 55.0 54.0 56.0 57.0 57.0 55.0 59.0 57.0 61.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:1.56 (2.7%) stddev-sans-first:1.62 17:12:25 INFO - PID 11108 | Values: 56.0 58.0 56.0 57.0 56.0 56.0 57.0 56.0 61.0 57.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:88.50 stddev:13.38 (15.1%) stddev-sans-first:13.84 17:12:25 INFO - PID 11108 | Values: 87.0 106.0 88.0 89.0 97.0 96.0 87.0 89.0 129.0 86.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:133.50 stddev:7.26 (5.4%) stddev-sans-first:7.63 17:12:25 INFO - PID 11108 | Values: 134.0 133.0 131.0 146.0 132.0 132.0 132.0 132.0 150.0 145.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.30 Median:193.50 stddev:4.90 (2.5%) stddev-sans-first:5.05 17:12:25 INFO - PID 11108 | Values: 188.0 187.0 193.0 189.0 191.0 194.0 197.0 198.0 194.0 182.0 17:12:25 INFO - PID 11108 | 17:12:25 INFO - PID 11108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.50 stddev:2.50 (3.4%) stddev-sans-first:1.99 17:12:25 INFO - PID 11108 | Values: 78.0 71.0 74.0 77.0 73.0 74.0 72.0 71.0 72.0 71.0 17:12:25 INFO - PID 11108 | -------- Summary: end -------- 17:12:25 INFO - PID 11108 | 17:12:26 INFO - TEST-INFO | 11108: exit 0 17:12:26 INFO - TEST-OK | kraken | took 93617ms 17:12:26 INFO - SUITE-END | took 1241s 17:12:27 INFO - Completed test suite (00:20:42) 17:12:27 INFO - javascript benchmark 17:12:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6663.063622648932, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2746.9038583649576, 2773.819701719388, 2781.3463835998537, 2801.95797063044, 2814.0150947168495, 5214.322138122048, 5257.316548848649, 5304.310439642841, 5321.909008653227, 5369.838904832856, 5244.606654500918, 5252.264682944391, 5265.605079619035, 5425.159100339453, 5447.96488667153, 4747.1692453820615, 4777.116233496797, 4828.251620998751, 4829.975850120744, 4841.636877234204, 4785.282207668843, 4790.353302304196, 4852.199387101124, 4874.098291816008, 4917.778699958492, 4696.929546056812, 4745.905081898342, 4825.396825396825, 4833.927491087637, 4872.001239745844, 4771.904561908777, 4819.08437396897, 4844.806207751721, 4848.0788650156355, 4866.391701037371, 4732.810006512607, 4766.332713420124, 4770.809167633291, 4776.904461910743, 4780.020095880336, 5335.359756829166, 5363.436839131913, 5375.3280839895015, 5377.596680248997, 5385.084535628953, 5648.6893220872835, 5706.514946229576, 5722.771089156428, 5727.513161381287, 5807.970960145214, 5847.356790753014, 5863.032599621058, 5867.3839246879315, 5910.290765108171, 5914.37899020601, 5412.4858138477175, 5420.864478388072, 5426.077566813651, 5426.511613954763, 5430.83707488776, 5786.652800831964, 5894.941050589439, 5982.820515384546, 6002.519798416203, 6020.729067191987, 5628.380878103405, 5696.3449203341315, 5705.343885453226, 5721.713914304268, 5724.685142317213, 5708.54331653475, 5819.709014549256, 5837.562182836305, 5852.473277405054, 5869.882602348014, 5769.740361683735, 5795.7971470999155, 5797.420257974169, 5798.507126894261, 5813.941860581424, 5665.915011274834, 5744.109663002241, 5759.568032397587, 5763.884722305615, 5813.215215945793, 4857.489963553847, 4868.440129385166, 4873.244647079709, 4893.314935908976, 4915.361003069578, 4170.249355116048, 4171.10321280926, 4171.833126674899, 4204.26425375558, 4214.873553793391, 4761.071591039714, 4835.371401717754, 4851.878703032382, 4883.780229889663, 4901.852944411673, 5799.739011744482, 5853.5317174625925, 5863.648181109147, 5906.704664766745, 5916.792912248051, 4894.902101957941, 4910.288008238786, 4914.631402644816, 4914.975425122851, 4952.554270115635, 5032.572231360376, 5113.335266415343, 5132.46109158533, 5160.40655324635, 5164.431912489623, 5424.593155513431, 5509.669419834822, 5510.504054635102, 5518.475744804397, 5530.6128570999645, 5684.9431505684415, 5826.796062137805, 5858.150568167677, 5860.355360910382, 5860.589758716849, 5357.571394288526, 5384.0, 5434.266374039454, 5448.0, 5448.101063324666, 5546.861328466821, 5664.178694089416, 5689.402612725769, 5693.829185124453, 5712.285964254468, 5714.79998200061, 5775.104858746901, 5788.8552786179, 5846.181534585076, 5863.912041319299, 5619.550435965195, 5627.831165065055, 5630.60585758993, 5632.211490391266, 5660.46225608583, 5539.362973257966, 5591.27313449249, 5604.523615492729, 5613.550915926634, 5622.044252477171, 5378.650387724785, 5458.235846981505, 5497.615166938436, 5522.2544956430365, 5605.271314729059, 5733.483986441241, 5748.913766293593, 5754.309482862083, 5787.247657804627, 5792.82621521355, 5526.530244929226, 5537.086380747131, 5579.916301255404, 5579.967705974408, 5597.496225339576], "value": 5254.219367733444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.8985147153661, 722.9313215244551, 942.6041062753643, 960.3901522533189, 991.4546999150465, 32004.199895002606, 32920.34159316812, 32961.67038329616, 32974.67025329746, 32990.835045824795, 31213.219669508275, 31398.0, 31457.370852582935, 31517.212069698213, 31531.0, 6471.449926756231, 6593.208814942213, 6608.306127856578, 6758.932410675904, 6769.390754832064, 6697.933020669804, 6765.526413151057, 6783.321667833202, 6790.49071319653, 6799.558028728142, 6744.527883048188, 6779.15260592426, 6783.966080169617, 6795.626240556768, 6814.659267036654, 6735.158105236846, 6791.728330866759, 6794.592324460499, 6797.898031529556, 6801.829954251134, 6612.206535215805, 6654.633995130266, 6667.633280169589, 6670.6331151786635, 6670.866582668368, 31156.688433115607, 31340.373192536248, 31448.0, 31469.8426507866, 31580.684193158006, 2817.1548535439492, 2849.031329348011, 2853.7003614620376, 2874.942501149986, 2878.8992385266624, 23910.521789564285, 23925.282241532783, 24051.0, 24071.518569628686, 24161.0, 3035.48396772547, 3077.9076627701206, 3086.768492363082, 3091.1190310761326, 3128.7340576051065, 148394.25802871023, 148997.0, 149382.99999999892, 149770.25114874466, 149774.25112874366, 31749.0, 32097.0, 36947.261054778755, 37694.62305376911, 39048.80475597604, 39212.2157556853, 39242.80378598089, 39249.41125883114, 39251.0, 39329.60670393317, 11055.336679799238, 11187.720306992227, 11192.496337664825, 11197.104231661448, 11242.831357529643, 8798.34012449056, 8863.556822158866, 8894.066123057115, 8911.73264802057, 9008.0, 11876.10929180315, 11888.167828251939, 11899.34553599543, 11962.461689224006, 12119.757604847853, 5043.621728370387, 5078.289039534468, 5082.669626474341, 5100.48995100487, 5133.819221578983, 836.786619412046, 853.4111463090571, 878.1832895407205, 901.1349104859278, 904.4980036080038, 18515.981621010975, 18619.0, 19108.808911910983, 19593.216271349273, 19821.900890495453, 946.3848498476045, 952.6713283917038, 969.2294625772528, 973.1825266775801, 973.6446197137993, 10058.663969016661, 10295.485225738683, 10385.948070259601, 10504.527296271686, 10534.683959481228, 172710.0, 173438.0, 173680.0, 174155.0, 174238.0, 38785.80607097003, 38828.0, 38876.80561597174, 38995.61004389977, 39040.2191956165, 1114.3982249585133, 1159.211736019498, 1163.2264544078262, 1166.5567084508002, 1167.7197472606513, 17876.91061544736, 18004.90997545004, 18180.636387272443, 18548.0, 19007.809921900604, 28253.43493130167, 28478.288042799097, 28496.0, 28541.714582853907, 28681.569776453787, 150781.0, 151833.44499665027, 152114.23942880216, 152263.0, 153027.23486382497, 27684.0, 27867.0, 27896.721032789414, 29228.853855730584, 29600.0, 35369.0, 35496.29007419785, 35619.46570801388, 35681.1079723009, 35807.46288805722, 25410.491790163724, 26367.60448593311, 26644.467110658064, 27505.587416189173, 27775.0, 26573.706174875213, 26757.598636020084, 27284.31789205286, 28470.288242794097, 28559.571606426336, 29200.41599168047, 29646.40707185801, 29912.10263692093, 30145.0, 30183.245418864703, 26032.609510857732, 26551.468970620866, 26660.200193994213, 26953.865230674506, 27706.874228267836, 20246.0, 22147.667784982918, 22220.0, 22263.66604500966, 22268.220612278492], "value": 13891.613055915215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3817891373802, 386.66167103784187, 407.3035109961965, 411.9423280740697, 427.81390095308535, 12865.292408917507, 14960.40158393663, 16762.413315533944, 17520.123993800324, 17539.73690394645, 16806.495805125865, 17071.231794569245, 17202.741958870625, 17715.73426398605, 17841.286348546077, 4941.925871111936, 5147.433782283946, 5161.7161056141895, 5162.845114646548, 5169.379674439054, 4875.609951203913, 5024.371953505812, 5031.3207716958295, 5038.672486288379, 5048.570871475929, 5005.724685142316, 5030.949690503103, 5031.723255220962, 5034.169362055257, 5047.31861198739, 4863.343448634424, 4963.7021778693215, 5022.070916880352, 5022.17134172861, 5028.673136246132, 4570.474395444533, 4574.1080489304595, 4576.427946506687, 4595.747233902134, 4602.447706275235, 20995.265165719127, 21097.180710069242, 21433.46416339604, 21607.1357145714, 21767.129314827387, 1611.4359974009121, 1629.331973890711, 1629.3401172525146, 1629.983700163007, 1631.4453085950834, 14340.139591624431, 14474.131552106803, 14651.120932743963, 14700.55898323052, 14877.256137193097, 2053.5071582820165, 2087.1338394566237, 2124.298981336171, 2138.604358193724, 2152.860064095829, 78678.0, 79559.0, 79704.60147699225, 79796.60101699512, 80261.59869200675, 10763.515641796137, 10988.120950323955, 11035.83446248307, 11126.38804865724, 11168.553257869757, 14992.47526336573, 15042.0, 15149.257835348855, 15170.848291516944, 15173.924130379499, 6329.240491141092, 6633.336666333328, 7076.540024898468, 7395.260473952561, 7406.0, 6508.5769424988175, 6598.076269322299, 6745.730170793114, 6751.358620931003, 6772.830679233059, 6674.0, 6767.695453704595, 6809.795706128824, 6853.246142924274, 6882.83190794898, 2039.258723467943, 2042.3464491362622, 2057.506198512346, 2059.155746144074, 2067.7208576841936, 819.5697258939105, 857.4598003257908, 857.9871301930476, 884.6240347852137, 891.7114769158633, 16629.0, 16699.6660066798, 16904.323827047025, 17038.31846726117, 17491.91254043747, 860.7202659135806, 867.9739607811775, 869.556526171657, 874.3180319350917, 886.1847100667402, 8782.560871956504, 8931.553422328858, 9128.543572821332, 9208.848893888264, 9335.0, 335816.0, 336787.0, 340621.0, 342280.0, 343001.0, 79028.60485697535, 79946.0, 79949.60025199837, 80499.59750201211, 82497.17502824895, 1036.7511797168625, 1078.4769386847372, 1083.6478144603036, 1083.756154865149, 1085.3216739537788, 17213.397531086353, 17340.306387744855, 17965.10174491244, 18035.278588856298, 18243.817561824213, 39465.21069578535, 40914.0, 41806.79096604497, 43184.0, 43256.35115473333, 47679.76160119177, 48389.27416088832, 48828.0, 49700.0, 50008.49991500184, 8229.0, 8292.87560686578, 8399.370047246359, 8452.408331416987, 8735.082816304452, 12963.287019214034, 13168.934155329162, 13299.0, 13413.86586134126, 13516.5269215577, 11330.093592512743, 11395.772084558428, 11576.073914086684, 11645.41772911368, 11735.530578776754, 10493.370397776158, 10614.416207108374, 10650.360978341325, 10924.617638382619, 10952.616658416917, 11483.885161148615, 11493.367864767184, 11532.59635912739, 11718.589849355232, 11956.222845515014, 8074.071481779671, 8074.555899425353, 8279.793005174919, 8279.917200828155, 8313.376496762647, 11144.387058711849, 11171.329720216812, 11222.887771122185, 11237.269577477438, 11347.659570212907], "value": 8656.146108372614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1178.2989121472722, 1227.8342423772795, 1241.627511746477, 1252.6492582077017, 1257.6667183196455, 10328.122109620683, 10412.375257484557, 10644.62743803967, 10889.618863339785, 10895.0, 10364.481775911212, 10520.263581549294, 10540.209484288689, 10557.049865512103, 10584.841227381576, 2131.3925531223604, 2131.73353330834, 2148.581026699794, 2166.978330216701, 2172.4568857785553, 1990.7312512810802, 2015.1737787507125, 2022.1102714805438, 2029.4317591074448, 2031.055559164988, 2051.54865929496, 2052.6818343156833, 2066.1322244657204, 2066.442060643625, 2081.5316553775356, 2033.5322875738516, 2037.6943458481198, 2039.46973786815, 2043.6525790615556, 2043.6525790615556, 1838.4117082533594, 1903.5241189702574, 1997.2111016148685, 2018.9697154542694, 2096.612126756555, 10199.592016319339, 10249.743756406075, 10253.897461025368, 10254.179665626732, 10257.33327333721, 5412.648177868426, 5634.211210430543, 5636.971815140939, 5645.15322701594, 5648.0, 3227.3061872845064, 3392.7794693344854, 3427.6229614742606, 3437.570303712036, 3438.1920248741776, 1049.2393015064094, 1074.8925107489267, 1076.381080878498, 1093.2347356850157, 1115.9609413670564, 14903.254837258202, 14975.625609359744, 15012.0, 15092.924535377362, 15109.5467135985, 4537.75042372666, 4658.161530924398, 4691.9530804692195, 4720.834770783074, 4740.786664600101, 10537.051665350155, 10537.998890105428, 10538.841917371246, 10550.841737373945, 10558.472076396149, 5163.870903227449, 5390.137577987582, 5399.325084364455, 5403.243545903577, 5413.296271484682, 4925.852224433273, 4971.925421118686, 4972.8756781080765, 5026.421961474404, 5038.445770965191, 3756.3614185588517, 3798.563165235978, 3850.537935447764, 3879.127196380848, 3953.802309884552, 1121.0975164992096, 1123.393367581513, 1134.3137401871913, 1154.5958914380067, 1155.1163360029584, 599.4724642314823, 618.4001518527022, 623.6632218601995, 624.3974564545235, 625.671522450717, 4801.639877009238, 4867.659263851568, 4906.1414252505665, 4981.2030075187795, 5032.496750324938, 510.88760472695947, 532.5287120897956, 533.7891532844504, 535.4672101259272, 535.8740695936452, 2969.1092672198256, 2999.6850330715397, 3015.0954713586275, 3034.631022110306, 3047.83236921967, 13077.673058173621, 13234.735305294033, 13329.266890321125, 13578.253196074113, 13715.519956801463, 12875.484980600671, 13021.0, 13253.204807711569, 13305.534306299427, 13348.132371395828, 7232.927670723226, 7379.040724705861, 7386.852262954711, 7392.926070739331, 7406.259374062551, 5339.119045357473, 5401.729913504388, 5469.781208751605, 5611.9772803339965, 5838.2702162229725, 12028.879711203126, 12068.094892882893, 12100.455479503267, 12166.939165304117, 12229.205101668364, 12414.937925310316, 12576.622701318975, 12794.040446966701, 12808.807867882175, 12937.288449135387, 9662.227021838096, 9916.305858590118, 9978.650747223812, 9989.850152247576, 10014.098731113943, 9166.129217724305, 9623.326367154232, 9722.854157187507, 9730.95134524323, 9745.902540974499, 8205.917940820515, 8240.423170378015, 8261.339092872677, 8271.0, 8328.708495202638, 7989.0, 8051.114377418362, 8113.0669972953865, 8209.507429554245, 8375.916240837514, 7048.682809273492, 7052.188998265266, 7064.752733654297, 7115.75094871677, 7119.964400177966, 4854.19905715553, 4854.732989685601, 4910.656254062182, 4919.655624106278, 4928.753562321798, 4712.787924543472, 4738.8341408050555, 4774.140654682191, 4887.291342755351, 4930.383702037246], "value": 4557.224124704664, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.06608544723645, 376.533098957293, 376.89823747588133, 381.6202878136254, 384.235371610495, 5425.0, 5470.097433923403, 5510.1734739789, 5527.613067085305, 5528.004959107359, 5333.679979201251, 5427.887283106964, 5437.918431223535, 5440.183972404131, 5448.42791506891, 3992.7205095643317, 4124.443200167969, 4145.129522800215, 4146.813393397297, 4160.83356665733, 4138.985948442636, 4143.606357396057, 4150.0, 4157.937630935523, 4167.583241675823, 4103.322951712964, 4111.609397107285, 4115.8765237042935, 4133.8966525836795, 4139.254934111874, 4057.89855253621, 4088.8773336799945, 4103.563752686566, 4117.835286588533, 4122.711410201302, 3591.8742844000335, 3603.72972027099, 3606.296772129436, 3608.0, 3614.6987084649504, 5324.946750532484, 5342.759575819097, 5344.545713614348, 5351.598630102719, 5361.0, 4718.386609740746, 4803.9039219215765, 4851.320815085891, 4857.684250523705, 4872.951270487285, 5752.424757524256, 5758.42415758425, 5773.913391299134, 5784.971075144639, 5797.507211886995, 4023.537293211289, 4035.6973227007798, 4039.7576145431367, 4051.4125451809323, 4051.817668204938, 6000.21997140369, 6130.1724267224245, 6142.385761423822, 6171.84570385744, 6201.930044627893, 4129.545749967501, 4151.377293406013, 4152.190322887069, 4157.750534967911, 4169.791510424467, 4131.690123240769, 4136.875893723193, 4159.854405095807, 4179.310413781753, 4183.226103170923, 4647.767611619405, 4767.547083027107, 4774.212254977959, 4793.472718001017, 4805.9759701201965, 5779.508741756914, 5782.624129431573, 5805.94194058054, 5808.041673123887, 5821.88356232873, 1401.7524403281088, 1422.1467119728288, 1426.1158081989233, 1427.7287315410247, 1439.2587817274111, 901.3825529512173, 953.0993211415146, 962.6197651927589, 969.069693094623, 970.8737864077766, 4995.350604421402, 4996.100701873697, 5007.4491805901325, 5007.7245751484015, 5014.222795466709, 5997.970010150008, 6014.428629280212, 6018.789342372996, 6020.247469066367, 6030.9796218267375, 4864.489228631013, 4978.626603004789, 4996.0, 5011.223260394645, 5021.799128034911, 3143.324185300126, 3185.7292130169194, 3194.7923384979904, 3201.567788348543, 3205.1987003249187, 5493.697846618475, 5577.163425486209, 5595.76893083521, 5604.607677462538, 5634.6337488063145, 5854.7072646367515, 6117.449429551361, 6144.0, 6163.445289923929, 6164.855923479058, 5411.323584551931, 5489.698066606375, 5543.61194716366, 5550.47270509301, 5580.86047848807, 5935.970320148372, 5938.138969849261, 5972.044472884318, 5981.641101533748, 6011.609245399035, 5651.180578816131, 5888.823335299948, 5893.499052580579, 5931.970340148444, 5936.436038576328, 5595.748191331481, 5616.21373007771, 5623.662580245198, 5627.268455100974, 5644.895307580732, 4399.230134726474, 4476.060027394284, 4507.75207363585, 4528.43394575678, 4551.772411379484, 5990.371011043778, 6023.789167379121, 6030.547708921936, 6035.879282414239, 6038.184845045863, 5728.713564321684, 5730.283714535683, 5734.971325143348, 5740.282464691913, 5802.361740208658, 5635.351934527582, 5777.595568310346, 5784.50831679312, 5789.0, 5809.215755872903, 5715.142728590745, 5724.79963201286, 5727.914081288867, 5729.598928074995, 5766.365699773106, 5774.884502310014, 5782.681952492653, 5820.883582328414, 5857.8535536610225, 5873.3832947539895, 5574.86062848432, 5610.270664813548, 5612.85967850807, 5669.971650141723, 5683.7779877326575], "value": 4331.078241140361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.8835697931352, 696.6760456387779, 708.0547469128713, 717.2648035763342, 724.6630316902641, 12297.877021229786, 13012.089153759218, 13165.934170329147, 14140.92929535351, 14145.29273536323, 12758.234505929651, 13169.0, 13254.138480998728, 13275.933620331909, 13276.93361533191, 775.6121939030485, 795.8448102619991, 802.5265093594778, 802.638812534359, 802.9197080291982, 790.1624278265058, 793.9761807145795, 794.6860989908982, 795.0697683710044, 796.0884786918974, 830.6635812495949, 833.1293797981124, 835.5571547080058, 837.1168417319725, 840.1262686805715, 820.7332616899472, 824.5712229640583, 826.9545175015372, 830.7590798668379, 831.2850948184556, 579.597179959928, 591.9788365070219, 593.9368530330703, 596.7911231069135, 603.1766638538408, 13901.79147312791, 14164.645883852883, 14166.645833854132, 14172.220527870963, 14201.502947396895, 13988.650283742885, 14062.367193476319, 14607.415703371853, 14754.557363279118, 14759.409623615042, 12805.807912881315, 12976.805347919695, 13048.608541743668, 13158.802617960739, 13206.33968301581, 2943.7792165587666, 2961.096865456035, 2969.376430949503, 2970.5098658721286, 2972.7473164781018, 77981.69265456534, 79014.604926975, 79146.0, 79465.60267198627, 79630.0, 10694.73263168427, 12351.876481235073, 12787.936060319826, 12812.871871281355, 12833.679158020937, 21640.24259150922, 21937.122515099538, 21974.89012554927, 22222.66666000011, 22930.0, 6489.675516224264, 6612.603243805387, 6621.238557565942, 6623.801285961429, 6625.3374662534325, 3062.3262882165886, 3111.8132912025353, 3114.5795317632283, 3126.140311414379, 3130.060981705479, 3725.2549490102087, 3746.269477451925, 3794.506714127201, 3826.712996525216, 3838.500994870649, 683.5147045597582, 733.7651951375509, 739.2976672161468, 742.1613576658342, 742.8180095876437, 581.447624756483, 586.3813676571173, 605.833395816154, 622.7602373086395, 623.1431781300712, 9056.320775941831, 9659.517024148765, 9808.705738827846, 10002.34984726005, 10211.897881021243, 553.3442870198827, 563.1074746526801, 564.6527385657873, 566.6798258983661, 581.5667327840786, 4306.849260275875, 4431.423914891044, 4479.61923236522, 4490.57339552742, 4595.540445955377, 84649.0, 86323.0, 86393.0, 87463.56268218618, 88191.55904220438, 76758.0, 77656.61171694218, 77722.61138694384, 78062.6096869512, 79366.6031669838, 60942.0, 61417.692911534265, 65568.85329493998, 66354.66822665856, 67283.66358168276, 9458.668946586837, 10080.69757907264, 10281.537330819981, 10317.329373590692, 10354.637587684394, 26301.473970520867, 26517.867410663595, 27199.72800271972, 30848.84575577108, 31326.373472529966, 61751.0, 65306.346936530026, 66209.01372958819, 67368.0, 67587.66206168938, 13564.118332308368, 14774.778378324549, 15088.54734357971, 15339.693206136038, 15444.92277538605, 15942.0, 16048.759268611213, 16062.67874642524, 16193.514194574182, 16424.67150657004, 11496.195266331277, 11522.711932201762, 11646.534138634359, 11761.059115270587, 15163.696726065638, 14573.708525829636, 14695.41218351254, 15013.474528391454, 15277.465288714842, 15359.0, 13542.119762215425, 13565.457381705017, 14044.368003439666, 14152.646183845487, 14152.858471415155, 9835.950820246138, 10017.849732254168, 10163.644272450429, 10210.591576336863, 10673.146148307962, 11393.316401015965, 12343.19769214998, 12367.567135150226, 12441.315727635067, 12616.243025418504], "value": 7016.675859254925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 109.0, 111.0, 110.0, 111.0, 110.0, 111.0, 111.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 123.0, 167.0, 123.0, 124.0, 128.0, 128.0, 147.0, 125.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 172.0, 169.0, 169.0, 162.0, 163.0, 162.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 107.0, 74.0, 75.0, 78.0, 75.0, 91.0, 74.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 85.0, 84.0, 83.0, 99.0, 83.0, 89.0, 112.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 115.0, 118.0, 116.0, 116.0, 114.0, 120.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 153.0, 152.0, 151.0, 150.0, 151.0, 150.0, 152.0, 152.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 96.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 56.0, 57.0, 57.0, 55.0, 59.0, 57.0, 61.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 61.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 88.0, 89.0, 97.0, 96.0, 87.0, 89.0, 129.0, 86.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 131.0, 146.0, 132.0, 132.0, 132.0, 132.0, 150.0, 145.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 187.0, 193.0, 189.0, 191.0, 194.0, 197.0, 198.0, 194.0, 182.0], "value": 191.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 74.0, 77.0, 73.0, 74.0, 72.0, 71.0, 72.0, 71.0], "value": 73.3, "unit": "score"}]}]} 17:12:27 INFO - Return code: 0 17:12:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:12:27 INFO - # TBPL SUCCESS # 17:12:27 INFO - Running post-action listener: _resource_record_post_action 17:12:27 INFO - [mozharness: 2017-05-29 00:12:27.456681Z] Finished run-tests step (success) 17:12:27 INFO - Running post-run listener: _resource_record_post_run 17:12:27 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 339968; Write bytes: 416653312; Read time: 224; Write time: 229608 17:12:27 INFO - TinderboxPrint: CPU usage
12.7% 17:12:27 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 224 17:12:27 INFO - TinderboxPrint: I/O write bytes / time
416,653,312 / 229,608 17:12:27 INFO - TinderboxPrint: CPU idle
8,763.9 (87.3%) 17:12:27 INFO - TinderboxPrint: CPU user
1,224.3 (12.2%) 17:12:27 INFO - TinderboxPrint: Swap in / out
0 / 0 17:12:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107958272; Read time: 0; Write time: 79752 17:12:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:12:27 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 339968; Write bytes: 308695040; Read time: 224; Write time: 149856 17:12:28 INFO - Running post-run listener: _upload_blobber_files 17:12:28 INFO - Blob upload gear active. 17:12:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:12:28 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 17:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:12:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:12:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:12:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:35 INFO - (blobuploader) - INFO - Done attempting. 17:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:35 INFO - (blobuploader) - INFO - Done attempting. 17:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:12:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:36 INFO - (blobuploader) - INFO - Done attempting. 17:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:12:37 INFO - (blobuploader) - INFO - Done attempting. 17:12:37 INFO - (blobuploader) - INFO - Iteration through files over. 17:12:37 INFO - Return code: 0 17:12:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:12:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:12:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a130dbac66540b564a29111a973e1236144d2d1e63b9e6fdeb743fed4ec23847fbc3faf885e88f8be3ab84cc598639f1abdcc08c959e19dcd682ade4fee6f610", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eae1ea4ac25a48b94cb4e3a9fb4354e8783ec8ef0f06a08200a883450c685a396418faf22325ace535bf7d41162a1c01afc7c53f1e70113dcb2dc45768230fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3f5b4b51630d6e85b0ea5629b865fe672db57087f92fb376beac4f7167034ee4b4e5ad90a48e7ba9a8b1f03cc40fa58308a8b1c888f8259904bd48e339139e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455b9b9a1a6c38fdcef18b5ebc01165765963a2479240f7b1cdf1e896d2be7a3e8b8da1e90987fe7ecd3bb77b1b66f84c44b8b1aa20523e8925c0ef03f708497"} 17:12:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:12:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:12:37 INFO - Contents: 17:12:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a130dbac66540b564a29111a973e1236144d2d1e63b9e6fdeb743fed4ec23847fbc3faf885e88f8be3ab84cc598639f1abdcc08c959e19dcd682ade4fee6f610", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eae1ea4ac25a48b94cb4e3a9fb4354e8783ec8ef0f06a08200a883450c685a396418faf22325ace535bf7d41162a1c01afc7c53f1e70113dcb2dc45768230fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3f5b4b51630d6e85b0ea5629b865fe672db57087f92fb376beac4f7167034ee4b4e5ad90a48e7ba9a8b1f03cc40fa58308a8b1c888f8259904bd48e339139e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455b9b9a1a6c38fdcef18b5ebc01165765963a2479240f7b1cdf1e896d2be7a3e8b8da1e90987fe7ecd3bb77b1b66f84c44b8b1aa20523e8925c0ef03f708497"} 17:12:37 INFO - Running post-run listener: copy_logs_to_upload_dir 17:12:37 INFO - Copying logs to upload dir... 17:12:37 INFO - mkdir: /builds/slave/test/build/upload/logs 17:12:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.268816 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-05-28 17:12:38.112157) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:12:38.119499) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a130dbac66540b564a29111a973e1236144d2d1e63b9e6fdeb743fed4ec23847fbc3faf885e88f8be3ab84cc598639f1abdcc08c959e19dcd682ade4fee6f610", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eae1ea4ac25a48b94cb4e3a9fb4354e8783ec8ef0f06a08200a883450c685a396418faf22325ace535bf7d41162a1c01afc7c53f1e70113dcb2dc45768230fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3f5b4b51630d6e85b0ea5629b865fe672db57087f92fb376beac4f7167034ee4b4e5ad90a48e7ba9a8b1f03cc40fa58308a8b1c888f8259904bd48e339139e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455b9b9a1a6c38fdcef18b5ebc01165765963a2479240f7b1cdf1e896d2be7a3e8b8da1e90987fe7ecd3bb77b1b66f84c44b8b1aa20523e8925c0ef03f708497"} build_url:https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011304 build_url: 'https://queue.taskcluster.net/v1/task/JaiVcFo4T_mKzUx68iYZ1Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a130dbac66540b564a29111a973e1236144d2d1e63b9e6fdeb743fed4ec23847fbc3faf885e88f8be3ab84cc598639f1abdcc08c959e19dcd682ade4fee6f610", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eae1ea4ac25a48b94cb4e3a9fb4354e8783ec8ef0f06a08200a883450c685a396418faf22325ace535bf7d41162a1c01afc7c53f1e70113dcb2dc45768230fb2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ed3f5b4b51630d6e85b0ea5629b865fe672db57087f92fb376beac4f7167034ee4b4e5ad90a48e7ba9a8b1f03cc40fa58308a8b1c888f8259904bd48e339139e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455b9b9a1a6c38fdcef18b5ebc01165765963a2479240f7b1cdf1e896d2be7a3e8b8da1e90987fe7ecd3bb77b1b66f84c44b8b1aa20523e8925c0ef03f708497"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:12:38.149360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:12:38.149776) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1496015436.398225-1541406678 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:12:38.231799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:12:38.235357) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:12:38.235776) ========= ========= Total master_lag: 0.12 =========