builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1496224735.61 results: success (0) revision: 06d83f260f410f125847e95618b6f8b9e83e9a2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.609264) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.609766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.610046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.705081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.705337) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 02:58:56-- 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% 86.8M=0s 2017-05-31 02:58:56 (86.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.856027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.856303) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021115 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.915813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:55.916114) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 06d83f260f410f125847e95618b6f8b9e83e9a2f --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 06d83f260f410f125847e95618b6f8b9e83e9a2f --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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 02:58:56,763 truncating revision to first 12 chars 2017-05-31 02:58:56,763 Setting DEBUG logging. 2017-05-31 02:58:56,763 attempt 1/10 2017-05-31 02:58:56,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/06d83f260f41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 02:58:57,066 unpacking tar archive at: mozilla-central-06d83f260f41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686464 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:56.627164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:56.627429) ========= script_repo_revision: 06d83f260f410f125847e95618b6f8b9e83e9a2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:56.627790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:56.628063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 02:58:56.645793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-31 02:58:56.646061) ========= /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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:57 INFO - MultiFileLogger online at 20170531 02:58:57 in /builds/slave/test 02:58:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:58:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:57 INFO - {'append_to_log': False, 02:58:57 INFO - 'base_work_dir': '/builds/slave/test', 02:58:57 INFO - 'blob_upload_branch': 'Firefox', 02:58:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:57 INFO - 'branch': 'Firefox', 02:58:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:57 INFO - 'config_files': ('talos/linux_config.py',), 02:58:57 INFO - 'default_actions': ('clobber', 02:58:57 INFO - 'read-buildbot-config', 02:58:57 INFO - 'download-and-extract', 02:58:57 INFO - 'populate-webroot', 02:58:57 INFO - 'create-virtualenv', 02:58:57 INFO - 'install', 02:58:57 INFO - 'setup-mitmproxy', 02:58:57 INFO - 'run-tests'), 02:58:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:57 INFO - 'download_minidump_stackwalk': True, 02:58:57 INFO - 'download_symbols': 'ondemand', 02:58:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:57 INFO - 'gecko_profile': False, 02:58:57 INFO - 'gecko_profile_interval': 0, 02:58:57 INFO - 'installer_path': 'installer.exe', 02:58:57 INFO - 'log_level': 'info', 02:58:57 INFO - 'log_name': 'talos', 02:58:57 INFO - 'log_to_console': True, 02:58:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:57 INFO - 'opt_config_files': (), 02:58:57 INFO - 'pip_index': False, 02:58:57 INFO - 'suite': 'dromaeojs-e10s', 02:58:57 INFO - 'system_bits': '32', 02:58:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:57 INFO - 'title': 'talos-linux64-ix-039', 02:58:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:57 INFO - 'use_talos_json': True, 02:58:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:57 INFO - 'work_dir': 'build'} 02:58:57 INFO - [mozharness: 2017-05-31 09:58:57.599735Z] Running clobber step. 02:58:57 INFO - Running pre-action listener: _resource_record_pre_action 02:58:57 INFO - Running main action method: clobber 02:58:57 INFO - rmtree: /builds/slave/test/build 02:58:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:58 INFO - Running post-action listener: _resource_record_post_action 02:58:58 INFO - [mozharness: 2017-05-31 09:58:58.649862Z] Finished clobber step (success) 02:58:58 INFO - [mozharness: 2017-05-31 09:58:58.649963Z] Running read-buildbot-config step. 02:58:58 INFO - Running pre-action listener: _resource_record_pre_action 02:58:58 INFO - Running main action method: read_buildbot_config 02:58:58 INFO - Using buildbot properties: 02:58:58 INFO - { 02:58:58 INFO - "project": "", 02:58:58 INFO - "product": "firefox", 02:58:58 INFO - "who": "cbook@mozilla.com", 02:58:58 INFO - "installer_path": "public/build/target.tar.bz2", 02:58:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 02:58:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:58:58 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 02:58:58 INFO - "stage_platform": "linux64-stylosequential", 02:58:58 INFO - "basedir": "/builds/slave/test", 02:58:58 INFO - "buildnumber": 36, 02:58:58 INFO - "platform": "ubuntu64_hw_styloseq", 02:58:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:58:58 INFO - "slavebuilddir": "test", 02:58:58 INFO - "taskId": "AlPwnN2cSkKJ4CjxSXy8iQ", 02:58:58 INFO - "branch": "mozilla-central", 02:58:58 INFO - "script_repo_revision": "production", 02:58:58 INFO - "revision": "06d83f260f410f125847e95618b6f8b9e83e9a2f", 02:58:58 INFO - "slavename": "talos-linux64-ix-039", 02:58:58 INFO - "repo_path": "mozilla-central" 02:58:58 INFO - } 02:58:58 INFO - Finding installer, test and symbols from parent task. 02:58:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AlPwnN2cSkKJ4CjxSXy8iQ'}, attempt #1 02:58:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AlPwnN2cSkKJ4CjxSXy8iQ'}, attempt #1 02:58:59 INFO - Task dependencies: ZPsXcz3ZRXiFbi_tli0rPA 02:58:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA'}, attempt #1 02:58:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:58:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/test_packages.json 02:58:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip 02:58:59 INFO - Running post-action listener: _resource_record_post_action 02:58:59 INFO - [mozharness: 2017-05-31 09:58:59.995499Z] Finished read-buildbot-config step (success) 02:58:59 INFO - [mozharness: 2017-05-31 09:58:59.995721Z] Running download-and-extract step. 02:58:59 INFO - Running pre-action listener: _resource_record_pre_action 02:58:59 INFO - Running main action method: download_and_extract 02:58:59 INFO - mkdir: /builds/slave/test/build/tests 02:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:59 INFO - trying https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json 02:58:59 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:00 INFO - Downloaded 986 bytes. 02:59:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:00 INFO - Using the following test package requirements: 02:59:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:00 INFO - u'common': [u'target.common.tests.zip'], 02:59:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:00 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:00 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:00 INFO - u'target.web-platform.tests.zip'], 02:59:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip 02:59:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip into memory 02:59:02 INFO - Content-Length response header: 63526654 02:59:02 INFO - Bytes received: 63526654 02:59:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip 02:59:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.common.tests.zip into memory 02:59:15 INFO - Content-Length response header: 63526654 02:59:15 INFO - Bytes received: 63526654 02:59:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip 02:59:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:59:27 INFO - Fetch https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.talos.tests.zip into memory 02:59:28 INFO - Content-Length response header: 14447425 02:59:28 INFO - Bytes received: 14447425 02:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:28 INFO - trying https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:59:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:59:29 INFO - Downloaded 55912076 bytes. 02:59:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:59:29 INFO - mkdir: /builds/slave/test/properties 02:59:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:29 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:29 INFO - Contents: 02:59:29 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 02:59:29 INFO - Running post-action listener: _resource_record_post_action 02:59:29 INFO - Running post-action listener: set_extra_try_arguments 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.884731Z] Finished download-and-extract step (success) 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.884906Z] Running populate-webroot step. 02:59:29 INFO - Running pre-action listener: _resource_record_pre_action 02:59:29 INFO - Running main action method: populate_webroot 02:59:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:29 INFO - '--tppagecycles', 02:59:29 INFO - '7'], 02:59:29 INFO - 'tests': ['tsvgm']}}, 02:59:29 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['damp', 'tps']}, 02:59:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'tests': ['damp', 'tps']}, 02:59:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['dromaeo_dom']}, 02:59:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:59:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['a11yr', 02:59:29 INFO - 'ts_paint', 02:59:29 INFO - 'tpaint', 02:59:29 INFO - 'sessionrestore', 02:59:29 INFO - 'sessionrestore_no_auto_restore', 02:59:29 INFO - 'tabpaint']}, 02:59:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:59:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:59:29 INFO - 'bloom_basic_ref']}, 02:59:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 02:59:29 INFO - 'talos_options': ['--mitmproxy', 02:59:29 INFO - 'mitmproxy-recording-1.mp', 02:59:29 INFO - '--firstNonBlankPaint'], 02:59:29 INFO - 'tests': ['Quantum_1']}, 02:59:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['tsvgx', 02:59:29 INFO - 'tsvgr_opacity', 02:59:29 INFO - 'tart', 02:59:29 INFO - 'tscrollx', 02:59:29 INFO - 'cart', 02:59:29 INFO - 'tsvg_static']}, 02:59:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:29 INFO - 'tsvgr_opacity', 02:59:29 INFO - 'tart', 02:59:29 INFO - 'tscrollx', 02:59:29 INFO - 'cart', 02:59:29 INFO - 'tsvg_static']}, 02:59:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'talos_options': ['--disable-e10s'], 02:59:29 INFO - 'tests': ['tp5o']}, 02:59:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'talos_options': ['--disable-e10s', 02:59:29 INFO - '--xperf_path', 02:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:29 INFO - 'tests': ['tp5n']}, 02:59:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:29 INFO - 'talos_options': ['--xperf_path', 02:59:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:29 INFO - 'tests': ['tp5n']}}, 02:59:29 INFO - 'talos.zip': {'path': '', 02:59:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:29 INFO - Running post-action listener: _resource_record_post_action 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.906518Z] Finished populate-webroot step (success) 02:59:29 INFO - [mozharness: 2017-05-31 09:59:29.906608Z] Running create-virtualenv step. 02:59:29 INFO - Running pre-action listener: _resource_record_pre_action 02:59:29 INFO - Running main action method: create_virtualenv 02:59:29 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:30 INFO - Using real prefix '/usr' 02:59:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:30 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:32 INFO - Installing pip.................done. 02:59:32 INFO - Return code: 0 02:59:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:32 INFO - Reading from file tmpfile_stdout 02:59:32 INFO - Output received: 02:59:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:32 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:32 INFO - Using env: {'DISPLAY': ':0', 02:59:32 INFO - 'HOME': '/home/cltbld', 02:59:32 INFO - 'LANG': 'en_US.UTF-8', 02:59:32 INFO - 'LANGUAGE': 'en_US:en', 02:59:32 INFO - 'LOGNAME': 'cltbld', 02:59:32 INFO - 'MAIL': '/var/mail/cltbld', 02:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:32 INFO - 'MOZ_NO_REMOTE': '1', 02:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:32 INFO - 'NO_EM_RESTART': '1', 02:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:32 INFO - 'PWD': '/builds/slave/test', 02:59:32 INFO - 'SHELL': '/bin/bash', 02:59:32 INFO - 'SHLVL': '1', 02:59:32 INFO - 'TERM': 'linux', 02:59:32 INFO - 'TMOUT': '86400', 02:59:32 INFO - 'USER': 'cltbld', 02:59:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:32 INFO - '_': '/tools/buildbot/bin/python'} 02:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:59:32 INFO - Cleaning up... 02:59:32 INFO - Return code: 0 02:59:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:32 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:59:32 INFO - Using env: {'DISPLAY': ':0', 02:59:32 INFO - 'HOME': '/home/cltbld', 02:59:32 INFO - 'LANG': 'en_US.UTF-8', 02:59:32 INFO - 'LANGUAGE': 'en_US:en', 02:59:32 INFO - 'LOGNAME': 'cltbld', 02:59:32 INFO - 'MAIL': '/var/mail/cltbld', 02:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:32 INFO - 'MOZ_NO_REMOTE': '1', 02:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:32 INFO - 'NO_EM_RESTART': '1', 02:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:32 INFO - 'PWD': '/builds/slave/test', 02:59:32 INFO - 'SHELL': '/bin/bash', 02:59:32 INFO - 'SHLVL': '1', 02:59:32 INFO - 'TERM': 'linux', 02:59:32 INFO - 'TMOUT': '86400', 02:59:32 INFO - 'USER': 'cltbld', 02:59:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:32 INFO - '_': '/tools/buildbot/bin/python'} 02:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:33 INFO - Downloading/unpacking psutil>=3.1.1 02:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:34 INFO - Installing collected packages: psutil 02:59:34 INFO - Running setup.py install for psutil 02:59:34 INFO - building 'psutil._psutil_linux' extension 02:59:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:59:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:59:34 INFO - building 'psutil._psutil_posix' extension 02:59:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:59:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:59:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:34 INFO - Successfully installed psutil 02:59:34 INFO - Cleaning up... 02:59:34 INFO - Return code: 0 02:59:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:34 INFO - Using env: {'DISPLAY': ':0', 02:59:34 INFO - 'HOME': '/home/cltbld', 02:59:34 INFO - 'LANG': 'en_US.UTF-8', 02:59:34 INFO - 'LANGUAGE': 'en_US:en', 02:59:34 INFO - 'LOGNAME': 'cltbld', 02:59:34 INFO - 'MAIL': '/var/mail/cltbld', 02:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:34 INFO - 'MOZ_NO_REMOTE': '1', 02:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:34 INFO - 'NO_EM_RESTART': '1', 02:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:34 INFO - 'PWD': '/builds/slave/test', 02:59:34 INFO - 'SHELL': '/bin/bash', 02:59:34 INFO - 'SHLVL': '1', 02:59:34 INFO - 'TERM': 'linux', 02:59:34 INFO - 'TMOUT': '86400', 02:59:34 INFO - 'USER': 'cltbld', 02:59:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:34 INFO - '_': '/tools/buildbot/bin/python'} 02:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:36 INFO - Installing collected packages: mozsystemmonitor 02:59:36 INFO - Running setup.py install for mozsystemmonitor 02:59:36 INFO - Successfully installed mozsystemmonitor 02:59:36 INFO - Cleaning up... 02:59:36 INFO - Return code: 0 02:59:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:59:36 INFO - Using env: {'DISPLAY': ':0', 02:59:36 INFO - 'HOME': '/home/cltbld', 02:59:36 INFO - 'LANG': 'en_US.UTF-8', 02:59:36 INFO - 'LANGUAGE': 'en_US:en', 02:59:36 INFO - 'LOGNAME': 'cltbld', 02:59:36 INFO - 'MAIL': '/var/mail/cltbld', 02:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:36 INFO - 'MOZ_NO_REMOTE': '1', 02:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:36 INFO - 'NO_EM_RESTART': '1', 02:59:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:36 INFO - 'PWD': '/builds/slave/test', 02:59:36 INFO - 'SHELL': '/bin/bash', 02:59:36 INFO - 'SHLVL': '1', 02:59:36 INFO - 'TERM': 'linux', 02:59:36 INFO - 'TMOUT': '86400', 02:59:36 INFO - 'USER': 'cltbld', 02:59:36 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:36 INFO - '_': '/tools/buildbot/bin/python'} 02:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:36 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:37 INFO - warning: no files found matching '*.txt' 02:59:37 INFO - no previously-included directories found matching 'build' 02:59:37 INFO - no previously-included directories found matching 'dist' 02:59:37 INFO - no previously-included directories found matching '.git*' 02:59:37 INFO - Installing collected packages: jsonschema, functools32 02:59:37 INFO - Running setup.py install for functools32 02:59:37 INFO - warning: no files found matching '*.txt' 02:59:37 INFO - no previously-included directories found matching 'build' 02:59:37 INFO - no previously-included directories found matching 'dist' 02:59:37 INFO - no previously-included directories found matching '.git*' 02:59:37 INFO - Successfully installed jsonschema functools32 02:59:37 INFO - Cleaning up... 02:59:37 INFO - Return code: 0 02:59:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:59:38 INFO - Using env: {'DISPLAY': ':0', 02:59:38 INFO - 'HOME': '/home/cltbld', 02:59:38 INFO - 'LANG': 'en_US.UTF-8', 02:59:38 INFO - 'LANGUAGE': 'en_US:en', 02:59:38 INFO - 'LOGNAME': 'cltbld', 02:59:38 INFO - 'MAIL': '/var/mail/cltbld', 02:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:38 INFO - 'MOZ_NO_REMOTE': '1', 02:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:38 INFO - 'NO_EM_RESTART': '1', 02:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:38 INFO - 'PWD': '/builds/slave/test', 02:59:38 INFO - 'SHELL': '/bin/bash', 02:59:38 INFO - 'SHLVL': '1', 02:59:38 INFO - 'TERM': 'linux', 02:59:38 INFO - 'TMOUT': '86400', 02:59:38 INFO - 'USER': 'cltbld', 02:59:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:38 INFO - '_': '/tools/buildbot/bin/python'} 02:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:38 INFO - Cleaning up... 02:59:38 INFO - Return code: 0 02:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:59:38 INFO - Using env: {'DISPLAY': ':0', 02:59:38 INFO - 'HOME': '/home/cltbld', 02:59:38 INFO - 'LANG': 'en_US.UTF-8', 02:59:38 INFO - 'LANGUAGE': 'en_US:en', 02:59:38 INFO - 'LOGNAME': 'cltbld', 02:59:38 INFO - 'MAIL': '/var/mail/cltbld', 02:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:38 INFO - 'MOZ_NO_REMOTE': '1', 02:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:38 INFO - 'NO_EM_RESTART': '1', 02:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:38 INFO - 'PWD': '/builds/slave/test', 02:59:38 INFO - 'SHELL': '/bin/bash', 02:59:38 INFO - 'SHLVL': '1', 02:59:38 INFO - 'TERM': 'linux', 02:59:38 INFO - 'TMOUT': '86400', 02:59:38 INFO - 'USER': 'cltbld', 02:59:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:38 INFO - '_': '/tools/buildbot/bin/python'} 02:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:40 INFO - Downloading docopt-0.6.1.tar.gz 02:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:40 INFO - Running setup.py install for blobuploader 02:59:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:40 INFO - Running setup.py install for requests 02:59:40 INFO - Running setup.py install for docopt 02:59:40 INFO - Successfully installed blobuploader requests docopt 02:59:40 INFO - Cleaning up... 02:59:40 INFO - Return code: 0 02:59:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:40 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:40 INFO - Using env: {'DISPLAY': ':0', 02:59:40 INFO - 'HOME': '/home/cltbld', 02:59:40 INFO - 'LANG': 'en_US.UTF-8', 02:59:40 INFO - 'LANGUAGE': 'en_US:en', 02:59:40 INFO - 'LOGNAME': 'cltbld', 02:59:40 INFO - 'MAIL': '/var/mail/cltbld', 02:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:40 INFO - 'MOZ_NO_REMOTE': '1', 02:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:40 INFO - 'NO_EM_RESTART': '1', 02:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:40 INFO - 'PWD': '/builds/slave/test', 02:59:40 INFO - 'SHELL': '/bin/bash', 02:59:40 INFO - 'SHLVL': '1', 02:59:40 INFO - 'TERM': 'linux', 02:59:40 INFO - 'TMOUT': '86400', 02:59:40 INFO - 'USER': 'cltbld', 02:59:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:40 INFO - '_': '/tools/buildbot/bin/python'} 02:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:40 INFO - Running setup.py (path:/tmp/pip-QaWNSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:40 INFO - Running setup.py (path:/tmp/pip-KtZbkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:41 INFO - Running setup.py (path:/tmp/pip-iT1ej0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:41 INFO - Running setup.py (path:/tmp/pip-pUuK9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:41 INFO - Running setup.py (path:/tmp/pip-o3xlqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:41 INFO - Running setup.py (path:/tmp/pip-utzK_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:41 INFO - Running setup.py (path:/tmp/pip-3nlGVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:41 INFO - Running setup.py (path:/tmp/pip-YcdwWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:41 INFO - Running setup.py (path:/tmp/pip-L1m8ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:41 INFO - Running setup.py (path:/tmp/pip-cfYEn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:41 INFO - Running setup.py (path:/tmp/pip-Eh_Bfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:41 INFO - Running setup.py (path:/tmp/pip-g9OT_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:41 INFO - Running setup.py (path:/tmp/pip-CJQrAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:41 INFO - Running setup.py (path:/tmp/pip-HeNocU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:41 INFO - Running setup.py (path:/tmp/pip-zpiEN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:41 INFO - Running setup.py (path:/tmp/pip-73M5VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:42 INFO - Running setup.py (path:/tmp/pip-eG6HkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:42 INFO - Running setup.py install for manifestparser 02:59:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Running setup.py install for mozcrash 02:59:42 INFO - Running setup.py install for mozdebug 02:59:42 INFO - Running setup.py install for mozdevice 02:59:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Running setup.py install for mozfile 02:59:42 INFO - Running setup.py install for mozhttpd 02:59:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Running setup.py install for mozinfo 02:59:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Running setup.py install for mozInstall 02:59:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:42 INFO - Running setup.py install for mozleak 02:59:43 INFO - Running setup.py install for mozlog 02:59:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Running setup.py install for moznetwork 02:59:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Running setup.py install for mozprocess 02:59:43 INFO - Running setup.py install for mozprofile 02:59:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Running setup.py install for mozrunner 02:59:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Running setup.py install for mozscreenshot 02:59:43 INFO - Running setup.py install for moztest 02:59:43 INFO - Running setup.py install for mozversion 02:59:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:43 INFO - Cleaning up... 02:59:43 INFO - Return code: 0 02:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:43 INFO - Using env: {'DISPLAY': ':0', 02:59:43 INFO - 'HOME': '/home/cltbld', 02:59:43 INFO - 'LANG': 'en_US.UTF-8', 02:59:43 INFO - 'LANGUAGE': 'en_US:en', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MAIL': '/var/mail/cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SHLVL': '1', 02:59:43 INFO - 'TERM': 'linux', 02:59:43 INFO - 'TMOUT': '86400', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - '_': '/tools/buildbot/bin/python'} 02:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:44 INFO - Running setup.py (path:/tmp/pip-4b7kMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:44 INFO - Running setup.py (path:/tmp/pip-k4FsYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:44 INFO - Running setup.py (path:/tmp/pip-HJ8v6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:44 INFO - Running setup.py (path:/tmp/pip-qKUvU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:44 INFO - Running setup.py (path:/tmp/pip-j55YPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:44 INFO - Running setup.py (path:/tmp/pip-ndbGEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:44 INFO - Running setup.py (path:/tmp/pip-3tdXZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:44 INFO - Running setup.py (path:/tmp/pip-Sr0eUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:44 INFO - Running setup.py (path:/tmp/pip-M8YL0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:44 INFO - Running setup.py (path:/tmp/pip-YpnMT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:44 INFO - Running setup.py (path:/tmp/pip-drIVu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:44 INFO - Running setup.py (path:/tmp/pip-5zyUv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:45 INFO - Running setup.py (path:/tmp/pip-lGaAtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:45 INFO - Running setup.py (path:/tmp/pip-jRQNVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:45 INFO - Running setup.py (path:/tmp/pip-fSGcoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:45 INFO - Running setup.py (path:/tmp/pip-V07itV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:45 INFO - Running setup.py (path:/tmp/pip-NOLTz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:59:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:46 INFO - Downloading blessings-1.6.tar.gz 02:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:46 INFO - Installing collected packages: blessings 02:59:46 INFO - Running setup.py install for blessings 02:59:46 INFO - Successfully installed blessings 02:59:46 INFO - Cleaning up... 02:59:46 INFO - Return code: 0 02:59:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:46 INFO - Reading from file tmpfile_stdout 02:59:46 INFO - Current package versions: 02:59:46 INFO - argparse == 1.2.1 02:59:46 INFO - blessings == 1.6 02:59:46 INFO - blobuploader == 1.2.4 02:59:46 INFO - docopt == 0.6.1 02:59:46 INFO - functools32 == 3.2.3-2 02:59:46 INFO - jsonschema == 2.5.1 02:59:46 INFO - manifestparser == 1.1 02:59:46 INFO - mozInstall == 1.12 02:59:46 INFO - mozcrash == 1.0 02:59:46 INFO - mozdebug == 0.1 02:59:46 INFO - mozdevice == 0.51 02:59:46 INFO - mozfile == 1.2 02:59:46 INFO - mozhttpd == 0.7 02:59:46 INFO - mozinfo == 0.9 02:59:46 INFO - mozleak == 0.1 02:59:46 INFO - mozlog == 3.4 02:59:46 INFO - moznetwork == 0.27 02:59:46 INFO - mozprocess == 0.25 02:59:46 INFO - mozprofile == 0.28 02:59:46 INFO - mozrunner == 6.13 02:59:46 INFO - mozscreenshot == 0.1 02:59:46 INFO - mozsystemmonitor == 0.3 02:59:46 INFO - moztest == 0.8 02:59:46 INFO - mozversion == 1.4 02:59:46 INFO - psutil == 3.1.1 02:59:46 INFO - requests == 1.2.3 02:59:46 INFO - wsgiref == 0.1.2 02:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:46 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:59:46 INFO - Using env: {'DISPLAY': ':0', 02:59:46 INFO - 'HOME': '/home/cltbld', 02:59:46 INFO - 'LANG': 'en_US.UTF-8', 02:59:46 INFO - 'LANGUAGE': 'en_US:en', 02:59:46 INFO - 'LOGNAME': 'cltbld', 02:59:46 INFO - 'MAIL': '/var/mail/cltbld', 02:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:46 INFO - 'MOZ_NO_REMOTE': '1', 02:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:46 INFO - 'NO_EM_RESTART': '1', 02:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:46 INFO - 'PWD': '/builds/slave/test', 02:59:46 INFO - 'SHELL': '/bin/bash', 02:59:46 INFO - 'SHLVL': '1', 02:59:46 INFO - 'TERM': 'linux', 02:59:46 INFO - 'TMOUT': '86400', 02:59:46 INFO - 'USER': 'cltbld', 02:59:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:46 INFO - '_': '/tools/buildbot/bin/python'} 02:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:59:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:48 INFO - Installing collected packages: marionette-driver 02:59:48 INFO - Running setup.py install for marionette-driver 02:59:48 INFO - Successfully installed marionette-driver 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 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 0x15ca3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1948dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:59:48 INFO - Using env: {'DISPLAY': ':0', 02:59:48 INFO - 'HOME': '/home/cltbld', 02:59:48 INFO - 'LANG': 'en_US.UTF-8', 02:59:48 INFO - 'LANGUAGE': 'en_US:en', 02:59:48 INFO - 'LOGNAME': 'cltbld', 02:59:48 INFO - 'MAIL': '/var/mail/cltbld', 02:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:48 INFO - 'MOZ_NO_REMOTE': '1', 02:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:48 INFO - 'NO_EM_RESTART': '1', 02:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:48 INFO - 'PWD': '/builds/slave/test', 02:59:48 INFO - 'SHELL': '/bin/bash', 02:59:48 INFO - 'SHLVL': '1', 02:59:48 INFO - 'TERM': 'linux', 02:59:48 INFO - 'TMOUT': '86400', 02:59:48 INFO - 'USER': 'cltbld', 02:59:48 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 02:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:48 INFO - '_': '/tools/buildbot/bin/python'} 02:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Running post-action listener: _resource_record_post_action 02:59:48 INFO - Running post-action listener: _start_resource_monitoring 02:59:48 INFO - Starting resource monitoring. 02:59:48 INFO - [mozharness: 2017-05-31 09:59:48.717327Z] Finished create-virtualenv step (success) 02:59:48 INFO - [mozharness: 2017-05-31 09:59:48.717903Z] Running install step. 02:59:48 INFO - Running pre-action listener: _resource_record_pre_action 02:59:48 INFO - Running main action method: install 02:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:48 INFO - Reading from file tmpfile_stdout 02:59:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:49 INFO - Reading from file tmpfile_stdout 02:59:49 INFO - Output received: 02:59:49 INFO - Usage: mozinstall [options] installer 02:59:49 INFO - Options: 02:59:49 INFO - -h, --help show this help message and exit 02:59:49 INFO - -d DEST, --destination=DEST 02:59:49 INFO - Directory to install application into. [default: 02:59:49 INFO - "/builds/slave/test"] 02:59:49 INFO - --app=APP Application being installed. [default: firefox] 02:59:49 INFO - mkdir: /builds/slave/test/build/application 02:59:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:00:05 INFO - Reading from file tmpfile_stdout 03:00:05 INFO - Output received: 03:00:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:05 INFO - Running post-action listener: _resource_record_post_action 03:00:05 INFO - [mozharness: 2017-05-31 10:00:05.570393Z] Finished install step (success) 03:00:05 INFO - [mozharness: 2017-05-31 10:00:05.570670Z] Running setup-mitmproxy step. 03:00:05 INFO - Running pre-action listener: _resource_record_pre_action 03:00:05 INFO - Running main action method: setup_mitmproxy 03:00:05 INFO - Skipping: mitmproxy is not required 03:00:05 INFO - Running post-action listener: _resource_record_post_action 03:00:05 INFO - [mozharness: 2017-05-31 10:00:05.571790Z] Finished setup-mitmproxy step (success) 03:00:05 INFO - [mozharness: 2017-05-31 10:00:05.572008Z] Running run-tests step. 03:00:05 INFO - Running pre-action listener: _resource_record_pre_action 03:00:05 INFO - Running main action method: run_tests 03:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:05 INFO - Python 2.7.3 03:00:05 INFO - Return code: 0 03:00:05 INFO - grabbing minidump binary from tooltool 03:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:05 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 0x1945840>, '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 0x1946740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1946bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:05 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 03:00:05 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 03:00:05 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 03:00:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:05 INFO - Return code: 0 03:00:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:05 INFO - ENV: RUST_BACKTRACE is now 1 03:00:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:05 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/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 03:00:05 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/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 03:00:05 INFO - Using env: {'DISPLAY': ':0', 03:00:05 INFO - 'HOME': '/home/cltbld', 03:00:05 INFO - 'LANG': 'en_US.UTF-8', 03:00:05 INFO - 'LANGUAGE': 'en_US:en', 03:00:05 INFO - 'LOGNAME': 'cltbld', 03:00:05 INFO - 'MAIL': '/var/mail/cltbld', 03:00:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:05 INFO - 'MOZ_NO_REMOTE': '1', 03:00:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:05 INFO - 'NO_EM_RESTART': '1', 03:00:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:05 INFO - 'PWD': '/builds/slave/test', 03:00:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:05 INFO - 'RUST_BACKTRACE': '1', 03:00:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:05 INFO - 'SHELL': '/bin/bash', 03:00:05 INFO - 'SHLVL': '1', 03:00:05 INFO - 'TERM': 'linux', 03:00:05 INFO - 'TMOUT': '86400', 03:00:05 INFO - 'USER': 'cltbld', 03:00:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489', 03:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:05 INFO - '_': '/tools/buildbot/bin/python'} 03:00:05 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/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 03:00:05 INFO - mozversion application_buildid: 20170531092130 03:00:05 INFO - mozversion application_changeset: 06d83f260f410f125847e95618b6f8b9e83e9a2f 03:00:05 INFO - mozversion application_display_name: Nightly 03:00:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:05 INFO - mozversion application_name: Firefox 03:00:05 INFO - mozversion application_remotingname: firefox 03:00:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:05 INFO - mozversion application_vendor: Mozilla 03:00:05 INFO - mozversion application_version: 55.0a1 03:00:05 INFO - mozversion platform_buildid: 20170531092130 03:00:05 INFO - mozversion platform_changeset: 06d83f260f410f125847e95618b6f8b9e83e9a2f 03:00:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:05 INFO - mozversion platform_version: 55.0a1 03:00:05 INFO - using testdate: 1496224805 03:00:05 INFO - actual date: 1496224805 03:00:05 INFO - starting webserver on 'localhost:41341' 03:00:05 INFO - SUITE-START | Running 2 tests 03:00:05 INFO - TEST-START | dromaeo_css 03:00:05 INFO - operating with platform_type : linux_ 03:00:05 INFO - Initialising browser for dromaeo_css test... 03:00:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41341/getInfo.html -profile /tmp/tmpoFpyJH/profile 03:00:05 INFO - TEST-INFO | started process 915 (/builds/slave/test/build/application/firefox/firefox http://localhost:41341/getInfo.html) 03:00:41 INFO - TEST-INFO | 915: killed by SIGTERM 03:00:41 INFO - Browser initialized. 03:00:41 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:41 INFO - TEST-INFO | started process 1205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoFpyJH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:53 INFO - PID 1205 | RSS: Main: 187645952 03:00:53 INFO - PID 1205 | 03:03:57 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41341/tests/dromaeo/cssquery-ext.html) 03:03:59 INFO - PID 1205 | RSS: Main: 183939072 03:03:59 INFO - PID 1205 | 03:07:01 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-ext.html (next: http://localhost:41341/tests/dromaeo/cssquery-jquery.html) 03:07:02 INFO - PID 1205 | RSS: Main: 187183104 03:07:02 INFO - PID 1205 | 03:10:04 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41341/tests/dromaeo/cssquery-mootools.html) 03:10:04 INFO - PID 1205 | RSS: Main: 186146816 03:10:04 INFO - PID 1205 | 03:13:06 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41341/tests/dromaeo/cssquery-prototype.html) 03:13:07 INFO - PID 1205 | RSS: Main: 189063168 03:13:07 INFO - PID 1205 | 03:16:10 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41341/tests/dromaeo/cssquery-yui.html) 03:16:11 INFO - PID 1205 | RSS: Main: 189194240 03:16:11 INFO - PID 1205 | 03:19:12 INFO - PID 1205 | Cycle 1(1): loaded http://localhost:41341/tests/dromaeo/cssquery-yui.html (next: http://localhost:41341/tests/dromaeo/cssquery-dojo.html) 03:19:13 INFO - PID 1205 | RSS: Main: 185561088 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | __start_tp_report 03:19:13 INFO - PID 1205 | _x_x_mozilla_page_load 03:19:13 INFO - PID 1205 | _x_x_mozilla_page_load_details 03:19:13 INFO - PID 1205 | |i|pagename|runs| 03:19:13 INFO - PID 1205 | |0;dojo.html;2732.6447561816967;2743.602177684236;2748.1618106477517;2786.1780774671483;2786.6934637189906;5219.00838840621;5313.3092697949305;5319.494648008443;5320.707361095138;5357.7589008494615;5221.190715439113;5264.973675131619;5286.286351342567;5304.655197412166;5343.946560534394;4734.076855013256;4763.452202996665;4790.305405716169;4792.233242681172;4817.012512434942;4725.976370118145;4790.137775200463;4835.709857408549;4844.878878028042;4875.585575226092;4639.257718764981;4676.50896655853;4742.193827049376;4769.689970151963;4806.87982800431;4727;4765.166095933232;4768.2847572864;4801.039792041571;4801.7118972861745;4723.858284251443;4737.123632128068;4738.64460165489;4741.834035808764;4786.473487916326;5157.742112894341;5253.579713622939;5262.342207224097;5297.788088476456;5305.734713264322;5710.400407957146;5712.771489140429;5757.568182386296;5775.826725198251;5788.913166302509;5794.043982742843;5798.188253644493;5799.449052340021;5817.854553636151;5858.882822343572;5345.919811202835;5355.866103347447;5366.570674346043;5367.704776237344;5368.785248590091;5812.215350927655;5881.647101173943;5906.852328691817;5917.46742793142;5941.702914854326;5708.457696518824;5723.8569035774435;5739.971300143556;5740.196372507852;5756.136579513023;5694.772209111589;5756.366799652035;5779.219805326311;5789.421057894261;5806.44838740319;5529.3364796223905;5724.4561766632105;5756.5682573807135;5756.65460072397;5759.798407055733;5650.7174641267775;5687.886242275132;5694.402087780806;5734.111212762028;5778.248827652463;4798.664093513421;4822.252550854623;4840.273958906122;4842.6368022398465;4875.341828853059;4118.382242663624;4125.608067233608;4128.4632997710105;4131.752094874257;4174.08170202555;4767.404074490689;4831.227003679394;4848.0788650156355;4862;4906.215005599087;5814.854628634233;5815.9709201453725;5819.301683797971;5823.56323275756;5824.126381042793;4899.118158731462;4906.509349065065;4916.139675556835;4917.065757506062;4958.528939750718;4965.577925876341;5048.444671086178;5052.7726252318;5087.109755792721;5157.535821776059;5375.623706340519;5376.623636345575;5402.135658294654;5421.2139239810795;5442.809501667422;5543.085390910454;5678.290213723285;5723.8855222896145;5785.595008349375;5791.9131213031;5355.3305836770405;5371.973140134274;5378.489043540857;5384.946150538444;5407.648502847303;5554.333479982428;5608.7195640217005;5648;5734.397888221677;5735.225744524436;5757.309122905278;5765.192872997867;5773.336066352424;5775.075987841925;5788.218590490398;5642.943570564406;5646.85882852932;5666.546676265806;5674.858128546819;5719.914201286901;5623.100303951512;5631.211630371669;5633.971830140823;5640.548756099584;5664.688442135722;5434.456554344534;5496.697681627549;5524.86187845291;5525;5579.944200557942;5627.831165065055;5632.070708333079;5641.37944826077;5646.520045795989;5651.971740141437;5446.482584154499;5448.645838020516;5451;5472.972635136799;5490.615656903979 03:19:13 INFO - PID 1205 | |1;ext.html;610.7801191571034;679.9966000169999;686.1971493352777;955.2501286490107;1148.8161894096945;30403.391932161372;31365.68634313656;31373.21566960827;31398.843005784995;31545.52681709776;29834;29989;29998.700012999863;30224.546631800487;30391.69608303916;6138.478229350521;6508.349165083501;6670.3329667033395;6682.964140558197;6687.531872768908;6565.803025909207;6656.667166641672;6662.100616416795;6662.566933149354;6663.30035346289;6618.635975021371;6646.6676666166495;6652.53432259742;6665.800025999228;6672.332766723337;6632.369924857131;6638.970959501261;6642.070110184578;6669.833254168636;6688.431483323923;6587.505937054692;6603.70283337251;6625.635590042546;6626.834329141761;6643.933560664428;29567.704322956924;29668.8516557418;29772;29845.25386865324;29895.665128556455;2724.972750272492;2756.8621568921476;2758.8344699318104;2762.903298384567;2763.6407267055156;22402.215922442636;22572.322830315115;22641.77358226413;22662.886685566467;22713.88643056774;2874.2814296425895;2886.682464928856;2887.3070463088707;2903.7096290371005;2924.736773690378;149199.25400373037;149294;149320;154345;164629;34781;35117;35158.472622910165;35214.11964700852;35245.47131793025;36462.27075458529;36623;36664.63335366666;36667.26665466676;39099;10547.736306592244;10570.471476426148;10652.62715804943;10684.57261709523;10701.946490267655;8399.454035487674;8407.747767566983;8420.368472364597;8432.409731318872;8443.83112337762;11242.775144497064;11362.715932101764;11393.259438136494;11469.369184694922;11499.252548584314;4506.639468842484;4593.379893714373;4603.309503574424;4610.170169369479;4725.881852953635;835.5404527509845;872.3326655108847;891.5631340643038;893.4907102951255;911.4166933162782;18817.623647526972;19831.801681982997;19928;24674.748743092572;24952.625710614357;872.075599864146;873.4235404632911;877.022120335821;881.6561540999015;891.8127193289482;11192.44037798107;11208;11321.377324247245;11674.766504669858;11917.16579839403;185929;186733;187346;187684;188133;36629.26741465156;36829;36980.81509592489;37032.62967370346;37214.62785372166;1028.8148133335922;1075.1667457720173;1077.9137668986461;1083.951222195003;1092.3664274720643;18957.14692838798;20382.796172038685;20429.387118386472;20635.4841128973;21339.14643414308;28031.859840701483;32614.347713045132;33129;33270.83927026929;33561;162390;162705;163613;163914;164524.17737911234;27082.187534374;27128;27302.771375288557;27530.311742206606;27574.862125690044;31094.844525777225;31932.201694957814;32358.83820580882;32364.35271294608;32387.67612323941;23397;25099.87450062738;25438.872805635852;25835.612465812654;25987.740122599287;25063.74936250614;25509.3622659435;25561.616575751752;26250.86874565615;26383;28504.42991140124;28610.85694571514;28642.427151457272;28744;28841.56737648895;23285.41786455352;24823.13119040825;25540.361490962874;25785.556849475994;26415.075472358374;18647.067646617885;21282.36152915415;21620;21646;21929.342119736433 03:19:13 INFO - PID 1205 | |2;jquery.html;365.08728179551116;365.7199800697559;370.78679759138504;377.67897287305794;386.70610336144523;16612;16646;17369.044702541356;17397;19351.709724354147;17422;17969.550761230978;17970.730439043393;17975.280988760467;18010.09949502526;5566.55467562594;5702.030654788696;5704.8859022819515;5709.8572535686735;5710.5717071219615;5620.241267428906;5668.461496157879;5672.943270567303;5686.0333743263745;5687.459691329338;5590.105583106703;5616.466435688603;5625.1843482694985;5635.774569017255;5645.576581756364;5046.97476512617;5284.497972692588;5308.177232528964;5308.362996440414;5317.229001794737;4717.834875779331;4722.031983443386;4727.503612120747;4729.290606409032;4735.857924262277;21765.673514897288;22076.22733204346;22077.227297044687;22123;22130.22544210961;1635.7219272723546;1656.6935117003393;1658.1046235033068;1659.751037344408;1659.9087050212233;14259.714805703932;14542.927285363505;14599.635009124751;14745.189014604193;14801.70396592073;2046.0997161249002;2081.40679906226;2100.233414803601;2106.7787882272446;2111.1766411099684;104387.47806260997;106740;108725.45637271841;116269;118014;9898.851517227247;10236.33463824864;10265.384076955406;10431.68704938853;10445.216608754374;13589.048766586244;13619.18284902909;13628;13633.863661363457;13662.316884155753;6417.711202995876;6451.548391612542;6654.6672666366485;6668.966655166693;6686.431653309523;6021.909671354933;6067.302260240041;6135.202423684892;6135.32511423743;6145.047517634774;6418.6469744164515;6466.321036291121;6476.708548115346;6581.572197807127;6621.602703837785;1812.5378028602622;1832.688442964699;1848.260695721722;1855.3228071753713;2024;770.4029377232578;841.6591280531395;868.7914900423852;876.9956150219208;898.0525545549377;17208;18017.369392071214;18047.172254427453;18314.63370732578;18317.7252341215;802.502448481945;804.2962407893093;805.9879101813477;821.4701517521165;822.1696086952102;9246.815063698688;9272;9467.715968520955;9690.224782017422;9958.751031224278;347521;350747;376007;381655;387390;87474.56262718646;90857;91262;91972.08027919635;92015;843.9451435656663;880.9603567839463;956.7703751099685;967.2793768642406;984.6553706202772;17905.19426625831;18368.90815545967;18784.6243075135;18967.71548426747;19097.41359192458;47427;48311.75844120757;48379.75810120927;48569.75715121402;48888.2666760006;58298;58367;58832;59153.704231478565;59445;8870.556472176495;8921.687740929035;8945.865812012955;8973.416727912665;9021.774455638662;13854.445822167001;14338.49815256461;14392.20842853653;14442.638934026734;14490.492832750802;12550;12564.434600443185;12763.80854287205;12774.48902043945;12782.872171278168;11650.533978641099;11704.414779261173;11742.941285293518;11955.907716149813;11985.400729963292;13353.465861365437;13524;13648.727025459237;13672.589822305346;13680.589582312547;8232.753017409488;8763.649454021768;8839.46963182211;8892.466452012899;8892.77768055778;13096.869031309947;13233.735325293634;13466.057375983588;13527.458901644217;13592.79610805819 03:19:13 INFO - PID 1205 | |3;mootools.html;1099.983500247496;1122.7040701764886;1127.8421021057059;1144.479261935819;1157.3576664950954;9610.279229057815;10086.747831304221;10117.949410252957;10137.797244055124;10405.635802746905;10103.54534045968;10214.591416343355;10277.537510812013;10347.275690701654;10379.065884070433;2171.478845077178;2209.569134018867;2217.1131547381096;2217.323716266538;2224.043661225672;2141.0793358855685;2144.067330711138;2146.549224662823;2160.6975023496725;2162.740471143465;1987.5031242189452;2028.9695654565194;2033.6339458897392;2041.224334752792;2042.9284975025878;2076.0346438905904;2078.7609424916027;2087.092114930003;2091.362134548962;2106.220698341616;2001.119507416732;2022.9595408091902;2063.535704466498;2067.5348046689373;2189.2009416563;9778.511074446249;9796.412215267106;9869.161121304698;9882.604695812159;9910.9504452478;5100.311457953166;5291.656042357273;5305.602079844027;5334.093204155264;5337.839864804062;3168.6989735975276;3222.887198948049;3223.935521289561;3276.9016929491913;3281.950770738441;1080.9243352965295;1094.3707368263201;1114.2144787924494;1117.8490903727975;1118.5917140243835;15240.923795381063;15463.768043479356;15656.138912359816;15701.371945122295;15720.764188537181;4419.712718673276;4628.490866004737;4680.742559159211;4729.834455794031;4739.360186374795;12268.754624907631;12282.692932676577;12302.692432689075;12305.200161989442;12310.446029928675;5171.870703232449;5198.2722418861385;5246.63273570854;5254.92117618236;5261.0793111205385;4609.423822022247;4696.741679207608;4697.154512187839;4708.599769019672;4764;3833.789141597239;3894.3963685628773;3911.8044097794996;3933.1150491139265;3945.8421663133154;1244.6079484962208;1270.834791477102;1291.5802364231663;1292.6186774901428;1295.2875918244927;618.9381061893864;621.6518749500204;634.429013887505;636.5130675033603;636.9967301500155;5741.569382296261;5844.620099693507;5859.296884373903;5915.822525324247;6080.908786368208;786.0488808541614;790.4664351562787;799.0748599137447;809.5183365897282;815.2784785464906;3525.2773181497732;3553.875614353485;3648.3068217038676;3652.7077833773233;3666;13144.34278286101;13450.26023568713;13658.453661853613;13685.521006764915;13773.586792396243;12278;12804.93597532025;13046.934765326303;13522.391492382867;13710.108842925178;6876.724931002804;7104.396126329217;7113.288671132846;7144.499885008104;7174.892376614355;5454.100073487989;5874.441928016831;5933.940660593339;5963.314218864886;6199.132121502903;12328.876711233132;12391.62825115248;12502.562410315595;12655.87344126547;12658.810117848056;12535.874641253835;12664.113512054068;12768.170068945488;12866.806997895226;12902.225866448043;7579.658915348712;7980.600969951595;8061.113277539584;8159.592020399075;8175.877361839458;9514.85727714071;9600.183984361129;9603.231741460526;9627.181689556186;9639.084286992724;7660.3488703460835;7888.921110788819;7935.801604959922;7989.920100798918;8043.436959413019;7976;7991.081025681889;8056.959715201387;8163.673453062049;8170.468919520212;7193.784186474414;7208.531445456028;7225.855482890418;7249.492535522674;7281.672324745293;5098.9490105098475;5187.4553171916405;5200.817971370984;5235.136202526541;5278.392984806643;4817.638677099161;4828.324034635084;4935.950640493693;4987.251912213197;5105.846824595268 03:19:13 INFO - PID 1205 | |4;prototype.html;335.1196752805905;335.4682827718067;336.9208236064526;338.5193025903216;338.8631142516856;5498.3127109111365;5640.802571909984;5652.745626446809;5655.208270842086;5683.119116536938;5391.757370918308;5457.308234447324;5467.507924286813;5472.2338872557875;5474.616776825624;4072.5927407259187;4078.3474644056955;4083.367078102884;4088.202800453898;4092.7339722918064;3986.880393588197;4096.119334343116;4110.157417729373;4110.5613035437655;4111.075008123164;4061.7969101544954;4067.7966101694947;4071.124708187739;4083.4283200351974;4083.530394004698;4030.617091376344;4040.8787736367663;4042.7978601069976;4044.777537235451;4050.6151915567975;3508.3684936711384;3510.824458777051;3513.420285652864;3516.595591506984;3519.8416071276597;5426.104692725696;5430.51125398716;5441.945580544183;5452.591055670801;5464.9180262296095;4781.187198176319;4781.474037855833;4807.351007613962;4809.927851082237;4823.710577365369;5821.79623713168;5835.912461313083;5850.502707269887;5857.238558987305;5875.6474611523445;3863.1501069764886;3875.8643447479485;3907;3923.7449565778134;3934.8426062957733;5852.414758524156;6064.514838812928;6081.483073938676;6163.938360616381;6185.165002724664;3845.307844588001;3977.3636218204947;3985.960140398617;3987.1626958338493;4000.2799496090984;4052.2098190852503;4059.7564146150735;4062.207869465426;4073.205724883619;4082.81627326771;4723.149833030019;4737.194676904935;4749.311349854252;4761.4524329701835;4769.260764581495;5827.24245848037;5832.358440571534;5845;5849.473547380671;5856.063029915278;1410.4640236709984;1417.4542801021475;1421.9004669673232;1425.8075159853288;1426.3510102903153;889.2041622747734;942.9952850235842;945.550863339908;948.9098535639104;951.2057432044182;5027.145385284511;5046.1926091825135;5046.914913293659;5059.56993655536;5104.668196567211;6028.668423236676;6037.9396206038255;6053.576249662569;6055.333913269536;6056.3338032816355;4986.975065124724;4998.975005124951;5014.272930425141;5040.49595040493;5044.167712327425;3156.2740569668645;3206.9198270043435;3216.453202955503;3226.757993150476;3228.80627162371;5605.786618444886;5628;5633.352164501135;5638.182463542763;5653.530082178581;6112.969435152796;6236.970899801482;6264.686765661699;6268.874622507525;6285.151504546919;5602.859928501739;5605.943940560624;5615.971920140373;5619.690916999522;5620.297462817148;6068.484178844671;6076.939230607814;6089.421504957022;6096.116063170904;6104.664243466652;5870.589058765845;5911.793087241926;5928.407159284037;5946.375630558729;6009.338972713085;5584.274044374205;5593.608447408805;5600.467955544217;5616.578756593353;5621.550275977994;3743.8315275813197;3999.1002024544246;3999.840006399828;4008.599140085968;4025.5169379673457;5925.733341999534;5956.344802071855;6063.151158837854;6077.6353418795015;6128.233970753656;5875;5896.55775816824;5909.379515151019;5921.526277897844;5933.643981361132;5883.881542782332;5886.38192989747;5908.911366329423;5912.142739302863;5936.821895343147;5602.915956260741;5772;5801.622894511843;5817.854553636193;5823.621464604787;5934.465898069195;5934.554908381975;5941.821745347646;5945.762169513171;5960.254968128984;5715.399883012224;5735.426457354231;5738.885222295614;5776.884462310646;5786.508146807569 03:19:13 INFO - PID 1205 | |5;yui.html;629.8866204083263;632.373949789708;635.1679300116846;648.5719425179383;667.1926968368274;13402.329883505823;13670.179789212629;13779.966502512301;13837.3773180207;16616.086115263657;14735.48425805097;14929.029613075143;14982.101073935544;15003.1748253846;15016.699666006672;621.0311913415076;635.6154526511464;638.157631925858;640.7020735358058;640.7180840430219;640.4364159539622;661.2659947458318;665.1419668627465;665.8801415745164;675.2707076357547;689.7930620813761;690.8549204667027;691.205114118765;692.560224257595;692.9376356127948;689.4208864553799;692.0864458914235;693.0020770091078;693.7918624412681;694.7776711452337;501.73909567025305;502.8089326056112;505.1412598582388;505.4642079395852;507.99492005079844;13231.86768132316;13252.46990120394;13422;13448.394822233024;13455.259960702157;14311.427542898271;15174.468893588783;15372;15393.769093463607;15437.382504699799;12045.939770301093;12167.878321216764;12207.084468664796;12311.384430778515;12404.689882752913;2934.4424559333656;2960.230340111565;2961.3781105967773;2971.0195635440255;2971.539411391238;84336.57831710864;84786.57606711927;85327.5733621328;85818.5709071457;87108.56445717794;11699.122565807598;11801.055915526736;11945.343006134746;11955;11976.101792365433;16101.27544260511;16634.58413539671;16693.582660433345;20093.296734614218;20711.792882070986;6087.878242435127;6302.243730752339;6307.96846015767;6311.368863113744;6313.179286692701;2711.6881558620616;2970.12381347503;2984.820910745362;2988.491956367423;3013.9849300753795;3430.2110514581786;3473.4442489201606;3497.982510087433;3504.9824750876082;3526.4886591444097;696.9198542167716;702.9261927497539;704.8378872859271;704.9647517624201;705.858828234345;532.3664838841765;539.8947205295009;540.6674894939583;543.7063985447893;544.213611331622;9366.90633093674;10156.441395723159;10203.591856325664;10308.175345972304;10425.436184572374;535.5956253028938;536.2706718862344;543.9881819815141;544.0343390481926;545.1060261171682;4340.76125813077;4591.79336929839;4635.745034023161;4667.206574882278;4760.857174284777;84327.57836210902;85632.57183714042;86075.13924860797;86210;88282;76108.61945690236;76142.61928690432;77037;77414.2258577407;80372;62938.68530657409;64398.35601644017;65579.34420655732;65703.67148164229;67276.6636166816;8811.118888111137;8837.64649414042;8913.777155571162;8959.462432254086;10608.681739547827;30098.849505752332;31195.37609247757;31684;33060.504092438154;33164.668353316156;56122.15816762834;56164.43835561592;56490.435095648514;57118.143227852444;59322.40677593169;12652.873471265537;13763.38064787107;13797.51708690191;13888.930555347159;13947.790783138058;16120.435784747477;16334.591635209215;16338.428155014994;16387.508374748777;16507.752383714014;12886.226826390446;14299.428022878968;14329;14557.344919478437;15249.313780879666;13522.323883805968;14129.788053179416;14316.498922538078;14478;14496.275186240435;13985.720285594434;14579.781303280248;14694.11835289886;14869.553913382615;14966.925165374103;9764.170045546209;10178.389296642225;10216.642417515352;10269.281150319406;10314;10756.569737210424;10756.731081722706;10906.563737450413;10922.235443518877;11089.168312376443 03:19:13 INFO - PID 1205 | __end_tp_report 03:19:13 INFO - PID 1205 | __start_cc_report 03:19:13 INFO - PID 1205 | _x_x_mozilla_cycle_collect,381 03:19:13 INFO - PID 1205 | __end_cc_report 03:19:13 INFO - PID 1205 | __startTimestamp1496225953238__endTimestamp 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | ------- Summary: start ------- 03:19:13 INFO - PID 1205 | Number of tests: 6 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#0] dojo.html Cycles:165 Average:5261.45 Median:5407.65 stddev:621.28 (11.5%) stddev-sans-first:590.66 03:19:13 INFO - PID 1205 | Values: 2732.6 2743.6 2748.2 2786.2 2786.7 5219.0 5313.3 5319.5 5320.7 5357.8 5221.2 5265.0 5286.3 5304.7 5343.9 4734.1 4763.5 4790.3 4792.2 4817.0 4726.0 4790.1 4835.7 4844.9 4875.6 4639.3 4676.5 4742.2 4769.7 4806.9 4727.0 4765.2 4768.3 4801.0 4801.7 4723.9 4737.1 4738.6 4741.8 4786.5 5157.7 5253.6 5262.3 5297.8 5305.7 5710.4 5712.8 5757.6 5775.8 5788.9 5794.0 5798.2 5799.4 5817.9 5858.9 5345.9 5355.9 5366.6 5367.7 5368.8 5812.2 5881.6 5906.9 5917.5 5941.7 5708.5 5723.9 5740.0 5740.2 5756.1 5694.8 5756.4 5779.2 5789.4 5806.4 5529.3 5724.5 5756.6 5756.7 5759.8 5650.7 5687.9 5694.4 5734.1 5778.2 4798.7 4822.3 4840.3 4842.6 4875.3 4118.4 4125.6 4128.5 4131.8 4174.1 4767.4 4831.2 4848.1 4862.0 4906.2 5814.9 5816.0 5819.3 5823.6 5824.1 4899.1 4906.5 4916.1 4917.1 4958.5 4965.6 5048.4 5052.8 5087.1 5157.5 5375.6 5376.6 5402.1 5421.2 5442.8 5543.1 5678.3 5723.9 5785.6 5791.9 5355.3 5372.0 5378.5 5384.9 5407.6 5554.3 5608.7 5648.0 5734.4 5735.2 5757.3 5765.2 5773.3 5775.1 5788.2 5642.9 5646.9 5666.5 5674.9 5719.9 5623.1 5631.2 5634.0 5640.5 5664.7 5434.5 5496.7 5524.9 5525.0 5579.9 5627.8 5632.1 5641.4 5646.5 5652.0 5446.5 5448.6 5451.0 5473.0 5490.6 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#1] ext.html Cycles:180 Average:29858.22 Median:2914.22 stddev:43599.08 (1496.1%) stddev-sans-first:43666.07 03:19:13 INFO - PID 1205 | Values: 610.8 680.0 686.2 955.3 1148.8 30403.4 31365.7 31373.2 31398.8 31545.5 29834.0 29989.0 29998.7 30224.5 30391.7 6138.5 6508.3 6670.3 6683.0 6687.5 6565.8 6656.7 6662.1 6662.6 6663.3 6618.6 6646.7 6652.5 6665.8 6672.3 6632.4 6639.0 6642.1 6669.8 6688.4 6587.5 6603.7 6625.6 6626.8 6643.9 29567.7 29668.9 29772.0 29845.3 29895.7 2725.0 2756.9 2758.8 2762.9 2763.6 22402.2 22572.3 22641.8 22662.9 22713.9 2874.3 2886.7 2887.3 2903.7 2924.7 149199.3 149294.0 149320.0 154345.0 164629.0 34781.0 35117.0 35158.5 35214.1 35245.5 36462.3 36623.0 36664.6 36667.3 39099.0 10547.7 10570.5 10652.6 10684.6 10701.9 8399.5 8407.7 8420.4 8432.4 8443.8 11242.8 11362.7 11393.3 11469.4 11499.3 4506.6 4593.4 4603.3 4610.2 4725.9 835.5 872.3 891.6 893.5 911.4 18817.6 19831.8 19928.0 24674.7 24952.6 872.1 873.4 877.0 881.7 891.8 11192.4 11208.0 11321.4 11674.8 11917.2 185929.0 186733.0 187346.0 187684.0 188133.0 36629.3 36829.0 36980.8 37032.6 37214.6 1028.8 1075.2 1077.9 1084.0 1092.4 18957.1 20382.8 20429.4 20635.5 21339.1 28031.9 32614.3 33129.0 33270.8 33561.0 162390.0 162705.0 163613.0 163914.0 164524.2 27082.2 27128.0 27302.8 27530.3 27574.9 31094.8 31932.2 32358.8 32364.4 32387.7 23397.0 25099.9 25438.9 25835.6 25987.7 25063.7 25509.4 25561.6 26250.9 26383.0 28504.4 28610.9 28642.4 28744.0 28841.6 23285.4 24823.1 25540.4 25785.6 26415.1 18647.1 21282.4 21620.0 21646.0 21929.3 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#2] jquery.html Cycles:180 Average:26596.45 Median:191016.34 stddev:62699.35 (32.8%) stddev-sans-first:62844.31 03:19:13 INFO - PID 1205 | Values: 365.1 365.7 370.8 377.7 386.7 16612.0 16646.0 17369.0 17397.0 19351.7 17422.0 17969.6 17970.7 17975.3 18010.1 5566.6 5702.0 5704.9 5709.9 5710.6 5620.2 5668.5 5672.9 5686.0 5687.5 5590.1 5616.5 5625.2 5635.8 5645.6 5047.0 5284.5 5308.2 5308.4 5317.2 4717.8 4722.0 4727.5 4729.3 4735.9 21765.7 22076.2 22077.2 22123.0 22130.2 1635.7 1656.7 1658.1 1659.8 1659.9 14259.7 14542.9 14599.6 14745.2 14801.7 2046.1 2081.4 2100.2 2106.8 2111.2 104387.5 106740.0 108725.5 116269.0 118014.0 9898.9 10236.3 10265.4 10431.7 10445.2 13589.0 13619.2 13628.0 13633.9 13662.3 6417.7 6451.5 6654.7 6669.0 6686.4 6021.9 6067.3 6135.2 6135.3 6145.0 6418.6 6466.3 6476.7 6581.6 6621.6 1812.5 1832.7 1848.3 1855.3 2024.0 770.4 841.7 868.8 877.0 898.1 17208.0 18017.4 18047.2 18314.6 18317.7 802.5 804.3 806.0 821.5 822.2 9246.8 9272.0 9467.7 9690.2 9958.8 347521.0 350747.0 376007.0 381655.0 387390.0 87474.6 90857.0 91262.0 91972.1 92015.0 843.9 881.0 956.8 967.3 984.7 17905.2 18368.9 18784.6 18967.7 19097.4 47427.0 48311.8 48379.8 48569.8 48888.3 58298.0 58367.0 58832.0 59153.7 59445.0 8870.6 8921.7 8945.9 8973.4 9021.8 13854.4 14338.5 14392.2 14442.6 14490.5 12550.0 12564.4 12763.8 12774.5 12782.9 11650.5 11704.4 11742.9 11955.9 11985.4 13353.5 13524.0 13648.7 13672.6 13680.6 8232.8 8763.6 8839.5 8892.5 8892.8 13096.9 13233.7 13466.1 13527.5 13592.8 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#3] mootools.html Cycles:180 Average:6271.14 Median:3903.10 stddev:4183.76 (107.2%) stddev-sans-first:4177.46 03:19:13 INFO - PID 1205 | Values: 1100.0 1122.7 1127.8 1144.5 1157.4 9610.3 10086.7 10117.9 10137.8 10405.6 10103.5 10214.6 10277.5 10347.3 10379.1 2171.5 2209.6 2217.1 2217.3 2224.0 2141.1 2144.1 2146.5 2160.7 2162.7 1987.5 2029.0 2033.6 2041.2 2042.9 2076.0 2078.8 2087.1 2091.4 2106.2 2001.1 2023.0 2063.5 2067.5 2189.2 9778.5 9796.4 9869.2 9882.6 9911.0 5100.3 5291.7 5305.6 5334.1 5337.8 3168.7 3222.9 3223.9 3276.9 3282.0 1080.9 1094.4 1114.2 1117.8 1118.6 15240.9 15463.8 15656.1 15701.4 15720.8 4419.7 4628.5 4680.7 4729.8 4739.4 12268.8 12282.7 12302.7 12305.2 12310.4 5171.9 5198.3 5246.6 5254.9 5261.1 4609.4 4696.7 4697.2 4708.6 4764.0 3833.8 3894.4 3911.8 3933.1 3945.8 1244.6 1270.8 1291.6 1292.6 1295.3 618.9 621.7 634.4 636.5 637.0 5741.6 5844.6 5859.3 5915.8 6080.9 786.0 790.5 799.1 809.5 815.3 3525.3 3553.9 3648.3 3652.7 3666.0 13144.3 13450.3 13658.5 13685.5 13773.6 12278.0 12804.9 13046.9 13522.4 13710.1 6876.7 7104.4 7113.3 7144.5 7174.9 5454.1 5874.4 5933.9 5963.3 6199.1 12328.9 12391.6 12502.6 12655.9 12658.8 12535.9 12664.1 12768.2 12866.8 12902.2 7579.7 7980.6 8061.1 8159.6 8175.9 9514.9 9600.2 9603.2 9627.2 9639.1 7660.3 7888.9 7935.8 7989.9 8043.4 7976.0 7991.1 8057.0 8163.7 8170.5 7193.8 7208.5 7225.9 7249.5 7281.7 5098.9 5187.5 5200.8 5235.1 5278.4 4817.6 4828.3 4936.0 4987.3 5105.8 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#4] prototype.html Cycles:180 Average:4775.84 Median:5541.29 stddev:1461.69 (26.4%) stddev-sans-first:1427.28 03:19:13 INFO - PID 1205 | Values: 335.1 335.5 336.9 338.5 338.9 5498.3 5640.8 5652.7 5655.2 5683.1 5391.8 5457.3 5467.5 5472.2 5474.6 4072.6 4078.3 4083.4 4088.2 4092.7 3986.9 4096.1 4110.2 4110.6 4111.1 4061.8 4067.8 4071.1 4083.4 4083.5 4030.6 4040.9 4042.8 4044.8 4050.6 3508.4 3510.8 3513.4 3516.6 3519.8 5426.1 5430.5 5441.9 5452.6 5464.9 4781.2 4781.5 4807.4 4809.9 4823.7 5821.8 5835.9 5850.5 5857.2 5875.6 3863.2 3875.9 3907.0 3923.7 3934.8 5852.4 6064.5 6081.5 6163.9 6185.2 3845.3 3977.4 3986.0 3987.2 4000.3 4052.2 4059.8 4062.2 4073.2 4082.8 4723.1 4737.2 4749.3 4761.5 4769.3 5827.2 5832.4 5845.0 5849.5 5856.1 1410.5 1417.5 1421.9 1425.8 1426.4 889.2 943.0 945.6 948.9 951.2 5027.1 5046.2 5046.9 5059.6 5104.7 6028.7 6037.9 6053.6 6055.3 6056.3 4987.0 4999.0 5014.3 5040.5 5044.2 3156.3 3206.9 3216.5 3226.8 3228.8 5605.8 5628.0 5633.4 5638.2 5653.5 6113.0 6237.0 6264.7 6268.9 6285.2 5602.9 5605.9 5616.0 5619.7 5620.3 6068.5 6076.9 6089.4 6096.1 6104.7 5870.6 5911.8 5928.4 5946.4 6009.3 5584.3 5593.6 5600.5 5616.6 5621.6 3743.8 3999.1 3999.8 4008.6 4025.5 5925.7 5956.3 6063.2 6077.6 6128.2 5875.0 5896.6 5909.4 5921.5 5933.6 5883.9 5886.4 5908.9 5912.1 5936.8 5602.9 5772.0 5801.6 5817.9 5823.6 5934.5 5934.6 5941.8 5945.8 5960.3 5715.4 5735.4 5738.9 5776.9 5786.5 03:19:13 INFO - PID 1205 | 03:19:13 INFO - PID 1205 | [#5] yui.html Cycles:180 Average:17837.02 Median:3485.71 stddev:24113.13 (691.8%) stddev-sans-first:24146.16 03:19:13 INFO - PID 1205 | Values: 629.9 632.4 635.2 648.6 667.2 13402.3 13670.2 13780.0 13837.4 16616.1 14735.5 14929.0 14982.1 15003.2 15016.7 621.0 635.6 638.2 640.7 640.7 640.4 661.3 665.1 665.9 675.3 689.8 690.9 691.2 692.6 692.9 689.4 692.1 693.0 693.8 694.8 501.7 502.8 505.1 505.5 508.0 13231.9 13252.5 13422.0 13448.4 13455.3 14311.4 15174.5 15372.0 15393.8 15437.4 12045.9 12167.9 12207.1 12311.4 12404.7 2934.4 2960.2 2961.4 2971.0 2971.5 84336.6 84786.6 85327.6 85818.6 87108.6 11699.1 11801.1 11945.3 11955.0 11976.1 16101.3 16634.6 16693.6 20093.3 20711.8 6087.9 6302.2 6308.0 6311.4 6313.2 2711.7 2970.1 2984.8 2988.5 3014.0 3430.2 3473.4 3498.0 3505.0 3526.5 696.9 702.9 704.8 705.0 705.9 532.4 539.9 540.7 543.7 544.2 9366.9 10156.4 10203.6 10308.2 10425.4 535.6 536.3 544.0 544.0 545.1 4340.8 4591.8 4635.7 4667.2 4760.9 84327.6 85632.6 86075.1 86210.0 88282.0 76108.6 76142.6 77037.0 77414.2 80372.0 62938.7 64398.4 65579.3 65703.7 67276.7 8811.1 8837.6 8913.8 8959.5 10608.7 30098.8 31195.4 31684.0 33060.5 33164.7 56122.2 56164.4 56490.4 57118.1 59322.4 12652.9 13763.4 13797.5 13888.9 13947.8 16120.4 16334.6 16338.4 16387.5 16507.8 12886.2 14299.4 14329.0 14557.3 15249.3 13522.3 14129.8 14316.5 14478.0 14496.3 13985.7 14579.8 14694.1 14869.6 14966.9 9764.2 10178.4 10216.6 10269.3 10314.0 10756.6 10756.7 10906.6 10922.2 11089.2 03:19:13 INFO - PID 1205 | -------- Summary: end -------- 03:19:13 INFO - PID 1205 | 03:19:14 INFO - TEST-INFO | 1205: exit 0 03:19:14 INFO - TEST-OK | dromaeo_css | took 1148347ms 03:19:14 INFO - TEST-START | kraken 03:19:14 INFO - operating with platform_type : linux_ 03:19:14 INFO - Initialising browser for kraken test... 03:19:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41341/getInfo.html -profile /tmp/tmpJ9zTXJ/profile 03:19:14 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/firefox/firefox http://localhost:41341/getInfo.html) 03:19:49 INFO - TEST-INFO | 1640: killed by SIGTERM 03:19:49 INFO - Browser initialized. 03:19:49 INFO - Running cycle 1/1 for kraken test... 03:19:49 INFO - TEST-INFO | started process 1861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ9zTXJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:01 INFO - PID 1861 | RSS: Main: 188342272 03:20:01 INFO - PID 1861 | 03:20:03 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41341/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:04 INFO - PID 1861 | RSS: Main: 192065536 03:20:04 INFO - PID 1861 | 03:20:07 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41341/tests/kraken/driver.html?testName=audio-dft) 03:20:08 INFO - PID 1861 | RSS: Main: 190701568 03:20:08 INFO - PID 1861 | 03:20:11 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41341/tests/kraken/driver.html?testName=audio-fft) 03:20:11 INFO - PID 1861 | RSS: Main: 186404864 03:20:11 INFO - PID 1861 | 03:20:14 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41341/tests/kraken/driver.html?testName=audio-oscillator) 03:20:14 INFO - PID 1861 | RSS: Main: 186585088 03:20:14 INFO - PID 1861 | 03:20:16 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41341/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:17 INFO - PID 1861 | RSS: Main: 187523072 03:20:17 INFO - PID 1861 | 03:20:20 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41341/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:21 INFO - PID 1861 | RSS: Main: 188456960 03:20:21 INFO - PID 1861 | 03:20:24 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41341/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:25 INFO - PID 1861 | RSS: Main: 187039744 03:20:25 INFO - PID 1861 | 03:20:28 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41341/tests/kraken/driver.html?testName=json-parse-financial) 03:20:28 INFO - PID 1861 | RSS: Main: 187772928 03:20:28 INFO - PID 1861 | 03:20:30 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41341/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:31 INFO - PID 1861 | RSS: Main: 187932672 03:20:31 INFO - PID 1861 | 03:20:32 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:33 INFO - PID 1861 | RSS: Main: 187318272 03:20:33 INFO - PID 1861 | 03:20:35 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:36 INFO - PID 1861 | RSS: Main: 187441152 03:20:36 INFO - PID 1861 | 03:20:39 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:40 INFO - PID 1861 | RSS: Main: 187842560 03:20:40 INFO - PID 1861 | 03:20:43 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:43 INFO - PID 1861 | RSS: Main: 187469824 03:20:43 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | Cycle 1(1): loaded http://localhost:41341/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41341/tests/kraken/driver.html?testName=ai-astar) 03:20:45 INFO - PID 1861 | RSS: Main: 189026304 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | __start_tp_report 03:20:45 INFO - PID 1861 | _x_x_mozilla_page_load 03:20:45 INFO - PID 1861 | _x_x_mozilla_page_load_details 03:20:45 INFO - PID 1861 | |i|pagename|runs| 03:20:45 INFO - PID 1861 | |0;ai-astar;104;109;110;109;112;112;110;112;111;113 03:20:45 INFO - PID 1861 | |1;audio-beat-detection;153;126;122;185;125;124;134;123;143;123 03:20:45 INFO - PID 1861 | |2;audio-dft;164;167;168;169;169;169;170;166;163;167 03:20:45 INFO - PID 1861 | |3;audio-fft;79;74;74;117;76;74;75;75;97;74 03:20:45 INFO - PID 1861 | |4;audio-oscillator;84;82;108;84;84;83;100;84;83;115 03:20:45 INFO - PID 1861 | |5;imaging-gaussian-blur;113;115;114;114;114;113;113;114;114;114 03:20:45 INFO - PID 1861 | |6;imaging-darkroom;150;154;151;151;150;149;150;150;150;150 03:20:45 INFO - PID 1861 | |7;imaging-desaturate;95;95;94;94;94;94;94;94;94;95 03:20:45 INFO - PID 1861 | |8;json-parse-financial;55;54;54;55;56;57;56;63;55;56 03:20:45 INFO - PID 1861 | |9;json-stringify-tinderbox;58;57;57;57;61;57;56;58;58;57 03:20:45 INFO - PID 1861 | |10;stanford-crypto-aes;86;84;86;86;85;86;85;89;113;86 03:20:45 INFO - PID 1861 | |11;stanford-crypto-ccm;135;131;129;132;130;131;129;146;139;131 03:20:45 INFO - PID 1861 | |12;stanford-crypto-pbkdf2;188;194;196;208;200;198;189;193;194;189 03:20:45 INFO - PID 1861 | |13;stanford-crypto-sha256-iterative;79;73;76;74;76;72;79;72;73;71 03:20:45 INFO - PID 1861 | __end_tp_report 03:20:45 INFO - PID 1861 | __start_cc_report 03:20:45 INFO - PID 1861 | _x_x_mozilla_cycle_collect,1016 03:20:45 INFO - PID 1861 | __end_cc_report 03:20:45 INFO - PID 1861 | __startTimestamp1496226045907__endTimestamp 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | ------- Summary: start ------- 03:20:45 INFO - PID 1861 | Number of tests: 14 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:2.57 (2.3%) stddev-sans-first:1.45 03:20:45 INFO - PID 1861 | Values: 104.0 109.0 110.0 109.0 112.0 112.0 110.0 112.0 111.0 113.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:130.00 stddev:20.12 (15.5%) stddev-sans-first:20.35 03:20:45 INFO - PID 1861 | Values: 153.0 126.0 122.0 185.0 125.0 124.0 134.0 123.0 143.0 123.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#2] audio-dft Cycles:10 Average:167.20 Median:168.50 stddev:2.30 (1.4%) stddev-sans-first:2.13 03:20:45 INFO - PID 1861 | Values: 164.0 167.0 168.0 169.0 169.0 169.0 170.0 166.0 163.0 167.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:14.32 (19.1%) stddev-sans-first:15.16 03:20:45 INFO - PID 1861 | Values: 79.0 74.0 74.0 117.0 76.0 74.0 75.0 75.0 97.0 74.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.50 stddev:12.25 (14.7%) stddev-sans-first:12.75 03:20:45 INFO - PID 1861 | Values: 84.0 82.0 108.0 84.0 84.0 83.0 100.0 84.0 83.0 115.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 03:20:45 INFO - PID 1861 | Values: 113.0 115.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 03:20:45 INFO - PID 1861 | Values: 150.0 154.0 151.0 151.0 150.0 149.0 150.0 150.0 150.0 150.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:20:45 INFO - PID 1861 | Values: 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:2.60 (4.6%) stddev-sans-first:2.73 03:20:45 INFO - PID 1861 | Values: 55.0 54.0 54.0 55.0 56.0 57.0 56.0 63.0 55.0 56.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.50 stddev:1.35 (2.3%) stddev-sans-first:1.42 03:20:45 INFO - PID 1861 | Values: 58.0 57.0 57.0 57.0 61.0 57.0 56.0 58.0 58.0 57.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:86.00 stddev:8.67 (10.1%) stddev-sans-first:9.14 03:20:45 INFO - PID 1861 | Values: 86.0 84.0 86.0 86.0 85.0 86.0 85.0 89.0 113.0 86.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:131.50 stddev:5.40 (4.1%) stddev-sans-first:5.69 03:20:45 INFO - PID 1861 | Values: 135.0 131.0 129.0 132.0 130.0 131.0 129.0 146.0 139.0 131.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.90 Median:195.00 stddev:6.06 (3.1%) stddev-sans-first:5.89 03:20:45 INFO - PID 1861 | Values: 188.0 194.0 196.0 208.0 200.0 198.0 189.0 193.0 194.0 189.0 03:20:45 INFO - PID 1861 | 03:20:45 INFO - PID 1861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:75.00 stddev:2.88 (3.8%) stddev-sans-first:2.55 03:20:45 INFO - PID 1861 | Values: 79.0 73.0 76.0 74.0 76.0 72.0 79.0 72.0 73.0 71.0 03:20:45 INFO - PID 1861 | -------- Summary: end -------- 03:20:45 INFO - PID 1861 | 03:20:47 INFO - TEST-INFO | 1861: exit 0 03:20:47 INFO - TEST-OK | kraken | took 92936ms 03:20:47 INFO - SUITE-END | took 1241s 03:20:47 INFO - Completed test suite (00:20:41) 03:20:47 INFO - javascript benchmark 03:20:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6649.934778814036, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2732.6447561816967, 2743.602177684236, 2748.1618106477517, 2786.1780774671483, 2786.6934637189906, 5219.00838840621, 5313.3092697949305, 5319.494648008443, 5320.707361095138, 5357.7589008494615, 5221.190715439113, 5264.973675131619, 5286.286351342567, 5304.655197412166, 5343.946560534394, 4734.076855013256, 4763.452202996665, 4790.305405716169, 4792.233242681172, 4817.012512434942, 4725.976370118145, 4790.137775200463, 4835.709857408549, 4844.878878028042, 4875.585575226092, 4639.257718764981, 4676.50896655853, 4742.193827049376, 4769.689970151963, 4806.87982800431, 4727.0, 4765.166095933232, 4768.2847572864, 4801.039792041571, 4801.7118972861745, 4723.858284251443, 4737.123632128068, 4738.64460165489, 4741.834035808764, 4786.473487916326, 5157.742112894341, 5253.579713622939, 5262.342207224097, 5297.788088476456, 5305.734713264322, 5710.400407957146, 5712.771489140429, 5757.568182386296, 5775.826725198251, 5788.913166302509, 5794.043982742843, 5798.188253644493, 5799.449052340021, 5817.854553636151, 5858.882822343572, 5345.919811202835, 5355.866103347447, 5366.570674346043, 5367.704776237344, 5368.785248590091, 5812.215350927655, 5881.647101173943, 5906.852328691817, 5917.46742793142, 5941.702914854326, 5708.457696518824, 5723.8569035774435, 5739.971300143556, 5740.196372507852, 5756.136579513023, 5694.772209111589, 5756.366799652035, 5779.219805326311, 5789.421057894261, 5806.44838740319, 5529.3364796223905, 5724.4561766632105, 5756.5682573807135, 5756.65460072397, 5759.798407055733, 5650.7174641267775, 5687.886242275132, 5694.402087780806, 5734.111212762028, 5778.248827652463, 4798.664093513421, 4822.252550854623, 4840.273958906122, 4842.6368022398465, 4875.341828853059, 4118.382242663624, 4125.608067233608, 4128.4632997710105, 4131.752094874257, 4174.08170202555, 4767.404074490689, 4831.227003679394, 4848.0788650156355, 4862.0, 4906.215005599087, 5814.854628634233, 5815.9709201453725, 5819.301683797971, 5823.56323275756, 5824.126381042793, 4899.118158731462, 4906.509349065065, 4916.139675556835, 4917.065757506062, 4958.528939750718, 4965.577925876341, 5048.444671086178, 5052.7726252318, 5087.109755792721, 5157.535821776059, 5375.623706340519, 5376.623636345575, 5402.135658294654, 5421.2139239810795, 5442.809501667422, 5543.085390910454, 5678.290213723285, 5723.8855222896145, 5785.595008349375, 5791.9131213031, 5355.3305836770405, 5371.973140134274, 5378.489043540857, 5384.946150538444, 5407.648502847303, 5554.333479982428, 5608.7195640217005, 5648.0, 5734.397888221677, 5735.225744524436, 5757.309122905278, 5765.192872997867, 5773.336066352424, 5775.075987841925, 5788.218590490398, 5642.943570564406, 5646.85882852932, 5666.546676265806, 5674.858128546819, 5719.914201286901, 5623.100303951512, 5631.211630371669, 5633.971830140823, 5640.548756099584, 5664.688442135722, 5434.456554344534, 5496.697681627549, 5524.86187845291, 5525.0, 5579.944200557942, 5627.831165065055, 5632.070708333079, 5641.37944826077, 5646.520045795989, 5651.971740141437, 5446.482584154499, 5448.645838020516, 5451.0, 5472.972635136799, 5490.615656903979], "value": 5215.925141546857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.7801191571034, 679.9966000169999, 686.1971493352777, 955.2501286490107, 1148.8161894096945, 30403.391932161372, 31365.68634313656, 31373.21566960827, 31398.843005784995, 31545.52681709776, 29834.0, 29989.0, 29998.700012999863, 30224.546631800487, 30391.69608303916, 6138.478229350521, 6508.349165083501, 6670.3329667033395, 6682.964140558197, 6687.531872768908, 6565.803025909207, 6656.667166641672, 6662.100616416795, 6662.566933149354, 6663.30035346289, 6618.635975021371, 6646.6676666166495, 6652.53432259742, 6665.800025999228, 6672.332766723337, 6632.369924857131, 6638.970959501261, 6642.070110184578, 6669.833254168636, 6688.431483323923, 6587.505937054692, 6603.70283337251, 6625.635590042546, 6626.834329141761, 6643.933560664428, 29567.704322956924, 29668.8516557418, 29772.0, 29845.25386865324, 29895.665128556455, 2724.972750272492, 2756.8621568921476, 2758.8344699318104, 2762.903298384567, 2763.6407267055156, 22402.215922442636, 22572.322830315115, 22641.77358226413, 22662.886685566467, 22713.88643056774, 2874.2814296425895, 2886.682464928856, 2887.3070463088707, 2903.7096290371005, 2924.736773690378, 149199.25400373037, 149294.0, 149320.0, 154345.0, 164629.0, 34781.0, 35117.0, 35158.472622910165, 35214.11964700852, 35245.47131793025, 36462.27075458529, 36623.0, 36664.63335366666, 36667.26665466676, 39099.0, 10547.736306592244, 10570.471476426148, 10652.62715804943, 10684.57261709523, 10701.946490267655, 8399.454035487674, 8407.747767566983, 8420.368472364597, 8432.409731318872, 8443.83112337762, 11242.775144497064, 11362.715932101764, 11393.259438136494, 11469.369184694922, 11499.252548584314, 4506.639468842484, 4593.379893714373, 4603.309503574424, 4610.170169369479, 4725.881852953635, 835.5404527509845, 872.3326655108847, 891.5631340643038, 893.4907102951255, 911.4166933162782, 18817.623647526972, 19831.801681982997, 19928.0, 24674.748743092572, 24952.625710614357, 872.075599864146, 873.4235404632911, 877.022120335821, 881.6561540999015, 891.8127193289482, 11192.44037798107, 11208.0, 11321.377324247245, 11674.766504669858, 11917.16579839403, 185929.0, 186733.0, 187346.0, 187684.0, 188133.0, 36629.26741465156, 36829.0, 36980.81509592489, 37032.62967370346, 37214.62785372166, 1028.8148133335922, 1075.1667457720173, 1077.9137668986461, 1083.951222195003, 1092.3664274720643, 18957.14692838798, 20382.796172038685, 20429.387118386472, 20635.4841128973, 21339.14643414308, 28031.859840701483, 32614.347713045132, 33129.0, 33270.83927026929, 33561.0, 162390.0, 162705.0, 163613.0, 163914.0, 164524.17737911234, 27082.187534374, 27128.0, 27302.771375288557, 27530.311742206606, 27574.862125690044, 31094.844525777225, 31932.201694957814, 32358.83820580882, 32364.35271294608, 32387.67612323941, 23397.0, 25099.87450062738, 25438.872805635852, 25835.612465812654, 25987.740122599287, 25063.74936250614, 25509.3622659435, 25561.616575751752, 26250.86874565615, 26383.0, 28504.42991140124, 28610.85694571514, 28642.427151457272, 28744.0, 28841.56737648895, 23285.41786455352, 24823.13119040825, 25540.361490962874, 25785.556849475994, 26415.075472358374, 18647.067646617885, 21282.36152915415, 21620.0, 21646.0, 21929.342119736433], "value": 13601.497255220178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.08728179551116, 365.7199800697559, 370.78679759138504, 377.67897287305794, 386.70610336144523, 16612.0, 16646.0, 17369.044702541356, 17397.0, 19351.709724354147, 17422.0, 17969.550761230978, 17970.730439043393, 17975.280988760467, 18010.09949502526, 5566.55467562594, 5702.030654788696, 5704.8859022819515, 5709.8572535686735, 5710.5717071219615, 5620.241267428906, 5668.461496157879, 5672.943270567303, 5686.0333743263745, 5687.459691329338, 5590.105583106703, 5616.466435688603, 5625.1843482694985, 5635.774569017255, 5645.576581756364, 5046.97476512617, 5284.497972692588, 5308.177232528964, 5308.362996440414, 5317.229001794737, 4717.834875779331, 4722.031983443386, 4727.503612120747, 4729.290606409032, 4735.857924262277, 21765.673514897288, 22076.22733204346, 22077.227297044687, 22123.0, 22130.22544210961, 1635.7219272723546, 1656.6935117003393, 1658.1046235033068, 1659.751037344408, 1659.9087050212233, 14259.714805703932, 14542.927285363505, 14599.635009124751, 14745.189014604193, 14801.70396592073, 2046.0997161249002, 2081.40679906226, 2100.233414803601, 2106.7787882272446, 2111.1766411099684, 104387.47806260997, 106740.0, 108725.45637271841, 116269.0, 118014.0, 9898.851517227247, 10236.33463824864, 10265.384076955406, 10431.68704938853, 10445.216608754374, 13589.048766586244, 13619.18284902909, 13628.0, 13633.863661363457, 13662.316884155753, 6417.711202995876, 6451.548391612542, 6654.6672666366485, 6668.966655166693, 6686.431653309523, 6021.909671354933, 6067.302260240041, 6135.202423684892, 6135.32511423743, 6145.047517634774, 6418.6469744164515, 6466.321036291121, 6476.708548115346, 6581.572197807127, 6621.602703837785, 1812.5378028602622, 1832.688442964699, 1848.260695721722, 1855.3228071753713, 2024.0, 770.4029377232578, 841.6591280531395, 868.7914900423852, 876.9956150219208, 898.0525545549377, 17208.0, 18017.369392071214, 18047.172254427453, 18314.63370732578, 18317.7252341215, 802.502448481945, 804.2962407893093, 805.9879101813477, 821.4701517521165, 822.1696086952102, 9246.815063698688, 9272.0, 9467.715968520955, 9690.224782017422, 9958.751031224278, 347521.0, 350747.0, 376007.0, 381655.0, 387390.0, 87474.56262718646, 90857.0, 91262.0, 91972.08027919635, 92015.0, 843.9451435656663, 880.9603567839463, 956.7703751099685, 967.2793768642406, 984.6553706202772, 17905.19426625831, 18368.90815545967, 18784.6243075135, 18967.71548426747, 19097.41359192458, 47427.0, 48311.75844120757, 48379.75810120927, 48569.75715121402, 48888.2666760006, 58298.0, 58367.0, 58832.0, 59153.704231478565, 59445.0, 8870.556472176495, 8921.687740929035, 8945.865812012955, 8973.416727912665, 9021.774455638662, 13854.445822167001, 14338.49815256461, 14392.20842853653, 14442.638934026734, 14490.492832750802, 12550.0, 12564.434600443185, 12763.80854287205, 12774.48902043945, 12782.872171278168, 11650.533978641099, 11704.414779261173, 11742.941285293518, 11955.907716149813, 11985.400729963292, 13353.465861365437, 13524.0, 13648.727025459237, 13672.589822305346, 13680.589582312547, 8232.753017409488, 8763.649454021768, 8839.46963182211, 8892.466452012899, 8892.77768055778, 13096.869031309947, 13233.735325293634, 13466.057375983588, 13527.458901644217, 13592.79610805819], "value": 9037.706510763908, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1099.983500247496, 1122.7040701764886, 1127.8421021057059, 1144.479261935819, 1157.3576664950954, 9610.279229057815, 10086.747831304221, 10117.949410252957, 10137.797244055124, 10405.635802746905, 10103.54534045968, 10214.591416343355, 10277.537510812013, 10347.275690701654, 10379.065884070433, 2171.478845077178, 2209.569134018867, 2217.1131547381096, 2217.323716266538, 2224.043661225672, 2141.0793358855685, 2144.067330711138, 2146.549224662823, 2160.6975023496725, 2162.740471143465, 1987.5031242189452, 2028.9695654565194, 2033.6339458897392, 2041.224334752792, 2042.9284975025878, 2076.0346438905904, 2078.7609424916027, 2087.092114930003, 2091.362134548962, 2106.220698341616, 2001.119507416732, 2022.9595408091902, 2063.535704466498, 2067.5348046689373, 2189.2009416563, 9778.511074446249, 9796.412215267106, 9869.161121304698, 9882.604695812159, 9910.9504452478, 5100.311457953166, 5291.656042357273, 5305.602079844027, 5334.093204155264, 5337.839864804062, 3168.6989735975276, 3222.887198948049, 3223.935521289561, 3276.9016929491913, 3281.950770738441, 1080.9243352965295, 1094.3707368263201, 1114.2144787924494, 1117.8490903727975, 1118.5917140243835, 15240.923795381063, 15463.768043479356, 15656.138912359816, 15701.371945122295, 15720.764188537181, 4419.712718673276, 4628.490866004737, 4680.742559159211, 4729.834455794031, 4739.360186374795, 12268.754624907631, 12282.692932676577, 12302.692432689075, 12305.200161989442, 12310.446029928675, 5171.870703232449, 5198.2722418861385, 5246.63273570854, 5254.92117618236, 5261.0793111205385, 4609.423822022247, 4696.741679207608, 4697.154512187839, 4708.599769019672, 4764.0, 3833.789141597239, 3894.3963685628773, 3911.8044097794996, 3933.1150491139265, 3945.8421663133154, 1244.6079484962208, 1270.834791477102, 1291.5802364231663, 1292.6186774901428, 1295.2875918244927, 618.9381061893864, 621.6518749500204, 634.429013887505, 636.5130675033603, 636.9967301500155, 5741.569382296261, 5844.620099693507, 5859.296884373903, 5915.822525324247, 6080.908786368208, 786.0488808541614, 790.4664351562787, 799.0748599137447, 809.5183365897282, 815.2784785464906, 3525.2773181497732, 3553.875614353485, 3648.3068217038676, 3652.7077833773233, 3666.0, 13144.34278286101, 13450.26023568713, 13658.453661853613, 13685.521006764915, 13773.586792396243, 12278.0, 12804.93597532025, 13046.934765326303, 13522.391492382867, 13710.108842925178, 6876.724931002804, 7104.396126329217, 7113.288671132846, 7144.499885008104, 7174.892376614355, 5454.100073487989, 5874.441928016831, 5933.940660593339, 5963.314218864886, 6199.132121502903, 12328.876711233132, 12391.62825115248, 12502.562410315595, 12655.87344126547, 12658.810117848056, 12535.874641253835, 12664.113512054068, 12768.170068945488, 12866.806997895226, 12902.225866448043, 7579.658915348712, 7980.600969951595, 8061.113277539584, 8159.592020399075, 8175.877361839458, 9514.85727714071, 9600.183984361129, 9603.231741460526, 9627.181689556186, 9639.084286992724, 7660.3488703460835, 7888.921110788819, 7935.801604959922, 7989.920100798918, 8043.436959413019, 7976.0, 7991.081025681889, 8056.959715201387, 8163.673453062049, 8170.468919520212, 7193.784186474414, 7208.531445456028, 7225.855482890418, 7249.492535522674, 7281.672324745293, 5098.9490105098475, 5187.4553171916405, 5200.817971370984, 5235.136202526541, 5278.392984806643, 4817.638677099161, 4828.324034635084, 4935.950640493693, 4987.251912213197, 5105.846824595268], "value": 4656.9759822553, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.1196752805905, 335.4682827718067, 336.9208236064526, 338.5193025903216, 338.8631142516856, 5498.3127109111365, 5640.802571909984, 5652.745626446809, 5655.208270842086, 5683.119116536938, 5391.757370918308, 5457.308234447324, 5467.507924286813, 5472.2338872557875, 5474.616776825624, 4072.5927407259187, 4078.3474644056955, 4083.367078102884, 4088.202800453898, 4092.7339722918064, 3986.880393588197, 4096.119334343116, 4110.157417729373, 4110.5613035437655, 4111.075008123164, 4061.7969101544954, 4067.7966101694947, 4071.124708187739, 4083.4283200351974, 4083.530394004698, 4030.617091376344, 4040.8787736367663, 4042.7978601069976, 4044.777537235451, 4050.6151915567975, 3508.3684936711384, 3510.824458777051, 3513.420285652864, 3516.595591506984, 3519.8416071276597, 5426.104692725696, 5430.51125398716, 5441.945580544183, 5452.591055670801, 5464.9180262296095, 4781.187198176319, 4781.474037855833, 4807.351007613962, 4809.927851082237, 4823.710577365369, 5821.79623713168, 5835.912461313083, 5850.502707269887, 5857.238558987305, 5875.6474611523445, 3863.1501069764886, 3875.8643447479485, 3907.0, 3923.7449565778134, 3934.8426062957733, 5852.414758524156, 6064.514838812928, 6081.483073938676, 6163.938360616381, 6185.165002724664, 3845.307844588001, 3977.3636218204947, 3985.960140398617, 3987.1626958338493, 4000.2799496090984, 4052.2098190852503, 4059.7564146150735, 4062.207869465426, 4073.205724883619, 4082.81627326771, 4723.149833030019, 4737.194676904935, 4749.311349854252, 4761.4524329701835, 4769.260764581495, 5827.24245848037, 5832.358440571534, 5845.0, 5849.473547380671, 5856.063029915278, 1410.4640236709984, 1417.4542801021475, 1421.9004669673232, 1425.8075159853288, 1426.3510102903153, 889.2041622747734, 942.9952850235842, 945.550863339908, 948.9098535639104, 951.2057432044182, 5027.145385284511, 5046.1926091825135, 5046.914913293659, 5059.56993655536, 5104.668196567211, 6028.668423236676, 6037.9396206038255, 6053.576249662569, 6055.333913269536, 6056.3338032816355, 4986.975065124724, 4998.975005124951, 5014.272930425141, 5040.49595040493, 5044.167712327425, 3156.2740569668645, 3206.9198270043435, 3216.453202955503, 3226.757993150476, 3228.80627162371, 5605.786618444886, 5628.0, 5633.352164501135, 5638.182463542763, 5653.530082178581, 6112.969435152796, 6236.970899801482, 6264.686765661699, 6268.874622507525, 6285.151504546919, 5602.859928501739, 5605.943940560624, 5615.971920140373, 5619.690916999522, 5620.297462817148, 6068.484178844671, 6076.939230607814, 6089.421504957022, 6096.116063170904, 6104.664243466652, 5870.589058765845, 5911.793087241926, 5928.407159284037, 5946.375630558729, 6009.338972713085, 5584.274044374205, 5593.608447408805, 5600.467955544217, 5616.578756593353, 5621.550275977994, 3743.8315275813197, 3999.1002024544246, 3999.840006399828, 4008.599140085968, 4025.5169379673457, 5925.733341999534, 5956.344802071855, 6063.151158837854, 6077.6353418795015, 6128.233970753656, 5875.0, 5896.55775816824, 5909.379515151019, 5921.526277897844, 5933.643981361132, 5883.881542782332, 5886.38192989747, 5908.911366329423, 5912.142739302863, 5936.821895343147, 5602.915956260741, 5772.0, 5801.622894511843, 5817.854553636193, 5823.621464604787, 5934.465898069195, 5934.554908381975, 5941.821745347646, 5945.762169513171, 5960.254968128984, 5715.399883012224, 5735.426457354231, 5738.885222295614, 5776.884462310646, 5786.508146807569], "value": 4309.444859327413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.8866204083263, 632.373949789708, 635.1679300116846, 648.5719425179383, 667.1926968368274, 13402.329883505823, 13670.179789212629, 13779.966502512301, 13837.3773180207, 16616.086115263657, 14735.48425805097, 14929.029613075143, 14982.101073935544, 15003.1748253846, 15016.699666006672, 621.0311913415076, 635.6154526511464, 638.157631925858, 640.7020735358058, 640.7180840430219, 640.4364159539622, 661.2659947458318, 665.1419668627465, 665.8801415745164, 675.2707076357547, 689.7930620813761, 690.8549204667027, 691.205114118765, 692.560224257595, 692.9376356127948, 689.4208864553799, 692.0864458914235, 693.0020770091078, 693.7918624412681, 694.7776711452337, 501.73909567025305, 502.8089326056112, 505.1412598582388, 505.4642079395852, 507.99492005079844, 13231.86768132316, 13252.46990120394, 13422.0, 13448.394822233024, 13455.259960702157, 14311.427542898271, 15174.468893588783, 15372.0, 15393.769093463607, 15437.382504699799, 12045.939770301093, 12167.878321216764, 12207.084468664796, 12311.384430778515, 12404.689882752913, 2934.4424559333656, 2960.230340111565, 2961.3781105967773, 2971.0195635440255, 2971.539411391238, 84336.57831710864, 84786.57606711927, 85327.5733621328, 85818.5709071457, 87108.56445717794, 11699.122565807598, 11801.055915526736, 11945.343006134746, 11955.0, 11976.101792365433, 16101.27544260511, 16634.58413539671, 16693.582660433345, 20093.296734614218, 20711.792882070986, 6087.878242435127, 6302.243730752339, 6307.96846015767, 6311.368863113744, 6313.179286692701, 2711.6881558620616, 2970.12381347503, 2984.820910745362, 2988.491956367423, 3013.9849300753795, 3430.2110514581786, 3473.4442489201606, 3497.982510087433, 3504.9824750876082, 3526.4886591444097, 696.9198542167716, 702.9261927497539, 704.8378872859271, 704.9647517624201, 705.858828234345, 532.3664838841765, 539.8947205295009, 540.6674894939583, 543.7063985447893, 544.213611331622, 9366.90633093674, 10156.441395723159, 10203.591856325664, 10308.175345972304, 10425.436184572374, 535.5956253028938, 536.2706718862344, 543.9881819815141, 544.0343390481926, 545.1060261171682, 4340.76125813077, 4591.79336929839, 4635.745034023161, 4667.206574882278, 4760.857174284777, 84327.57836210902, 85632.57183714042, 86075.13924860797, 86210.0, 88282.0, 76108.61945690236, 76142.61928690432, 77037.0, 77414.2258577407, 80372.0, 62938.68530657409, 64398.35601644017, 65579.34420655732, 65703.67148164229, 67276.6636166816, 8811.118888111137, 8837.64649414042, 8913.777155571162, 8959.462432254086, 10608.681739547827, 30098.849505752332, 31195.37609247757, 31684.0, 33060.504092438154, 33164.668353316156, 56122.15816762834, 56164.43835561592, 56490.435095648514, 57118.143227852444, 59322.40677593169, 12652.873471265537, 13763.38064787107, 13797.51708690191, 13888.930555347159, 13947.790783138058, 16120.435784747477, 16334.591635209215, 16338.428155014994, 16387.508374748777, 16507.752383714014, 12886.226826390446, 14299.428022878968, 14329.0, 14557.344919478437, 15249.313780879666, 13522.323883805968, 14129.788053179416, 14316.498922538078, 14478.0, 14496.275186240435, 13985.720285594434, 14579.781303280248, 14694.11835289886, 14869.553913382615, 14966.925165374103, 9764.170045546209, 10178.389296642225, 10216.642417515352, 10269.281150319406, 10314.0, 10756.569737210424, 10756.731081722706, 10906.563737450413, 10922.235443518877, 11089.168312376443], "value": 6720.052047091282, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 110.0, 109.0, 112.0, 112.0, 110.0, 112.0, 111.0, 113.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 122.0, 185.0, 125.0, 124.0, 134.0, 123.0, 143.0, 123.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 168.0, 169.0, 169.0, 169.0, 170.0, 166.0, 163.0, 167.0], "value": 167.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 74.0, 117.0, 76.0, 74.0, 75.0, 75.0, 97.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 108.0, 84.0, 84.0, 83.0, 100.0, 84.0, 83.0, 115.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 151.0, 151.0, 150.0, 149.0, 150.0, 150.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 55.0, 56.0, 57.0, 56.0, 63.0, 55.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 57.0, 61.0, 57.0, 56.0, 58.0, 58.0, 57.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 86.0, 85.0, 86.0, 85.0, 89.0, 113.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 129.0, 132.0, 130.0, 131.0, 129.0, 146.0, 139.0, 131.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 194.0, 196.0, 208.0, 200.0, 198.0, 189.0, 193.0, 194.0, 189.0], "value": 194.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 76.0, 74.0, 76.0, 72.0, 79.0, 72.0, 73.0, 71.0], "value": 74.5, "unit": "score"}]}]} 03:20:47 INFO - Return code: 0 03:20:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:47 INFO - # TBPL SUCCESS # 03:20:47 INFO - Running post-action listener: _resource_record_post_action 03:20:47 INFO - [mozharness: 2017-05-31 10:20:47.734803Z] Finished run-tests step (success) 03:20:47 INFO - Running post-run listener: _resource_record_post_run 03:20:47 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8192; Write bytes: 410419200; Read time: 148; Write time: 399064 03:20:47 INFO - TinderboxPrint: CPU usage
12.7% 03:20:47 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 148 03:20:47 INFO - TinderboxPrint: I/O write bytes / time
410,419,200 / 399,064 03:20:47 INFO - TinderboxPrint: CPU idle
8,765.7 (87.3%) 03:20:47 INFO - TinderboxPrint: CPU user
1,221.9 (12.2%) 03:20:47 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 96268288; Read time: 0; Write time: 99324 03:20:47 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:20:47 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 8192; Write bytes: 314150912; Read time: 148; Write time: 299740 03:20:48 INFO - Running post-run listener: _upload_blobber_files 03:20:48 INFO - Blob upload gear active. 03:20:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:49 INFO - (blobuploader) - INFO - Done attempting. 03:20:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:56 INFO - (blobuploader) - INFO - Done attempting. 03:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:58 INFO - (blobuploader) - INFO - Done attempting. 03:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:59 INFO - (blobuploader) - INFO - Done attempting. 03:20:59 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:59 INFO - Return code: 0 03:20:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308e40d99f73640c0941ae3ccc7cdfd4c76151bbeee95079ec27782888353a6ea559e937157b4f048dab0153ed9ec5ade8e8c1e7c189e04a5a49a744adf163f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00d897cdb22298a1f7c545afbf9af1b3b58fa8ed66884fe2ec2f68c619fb0bc441b3ae71d8046eb651cc84660bfb2a748455391ba7a80bc042343c47ce25e5db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5543b450b9f3091e586931a242b0a03f30d01644303b0a65fe023d0f4cec010ad839ddeb39d7c0b906b87e3b561852bcab67aa58de9243fda22d095525f52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a449da0b1d36290b77c4dd5429042ab414c6ef679164be5a427d602f255ed11ac552247590da2e5e442b2cca1a39e7a9aaec8338f542a6d0423af5d530719"} 03:20:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:59 INFO - Contents: 03:20:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308e40d99f73640c0941ae3ccc7cdfd4c76151bbeee95079ec27782888353a6ea559e937157b4f048dab0153ed9ec5ade8e8c1e7c189e04a5a49a744adf163f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00d897cdb22298a1f7c545afbf9af1b3b58fa8ed66884fe2ec2f68c619fb0bc441b3ae71d8046eb651cc84660bfb2a748455391ba7a80bc042343c47ce25e5db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5543b450b9f3091e586931a242b0a03f30d01644303b0a65fe023d0f4cec010ad839ddeb39d7c0b906b87e3b561852bcab67aa58de9243fda22d095525f52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a449da0b1d36290b77c4dd5429042ab414c6ef679164be5a427d602f255ed11ac552247590da2e5e442b2cca1a39e7a9aaec8338f542a6d0423af5d530719"} 03:20:59 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:59 INFO - Copying logs to upload dir... 03:20:59 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.044129 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-31 03:20:58.663405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 03:20:58.668404) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308e40d99f73640c0941ae3ccc7cdfd4c76151bbeee95079ec27782888353a6ea559e937157b4f048dab0153ed9ec5ade8e8c1e7c189e04a5a49a744adf163f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00d897cdb22298a1f7c545afbf9af1b3b58fa8ed66884fe2ec2f68c619fb0bc441b3ae71d8046eb651cc84660bfb2a748455391ba7a80bc042343c47ce25e5db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5543b450b9f3091e586931a242b0a03f30d01644303b0a65fe023d0f4cec010ad839ddeb39d7c0b906b87e3b561852bcab67aa58de9243fda22d095525f52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a449da0b1d36290b77c4dd5429042ab414c6ef679164be5a427d602f255ed11ac552247590da2e5e442b2cca1a39e7a9aaec8338f542a6d0423af5d530719"} build_url:https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/ZPsXcz3ZRXiFbi_tli0rPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/308e40d99f73640c0941ae3ccc7cdfd4c76151bbeee95079ec27782888353a6ea559e937157b4f048dab0153ed9ec5ade8e8c1e7c189e04a5a49a744adf163f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00d897cdb22298a1f7c545afbf9af1b3b58fa8ed66884fe2ec2f68c619fb0bc441b3ae71d8046eb651cc84660bfb2a748455391ba7a80bc042343c47ce25e5db", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/75e5543b450b9f3091e586931a242b0a03f30d01644303b0a65fe023d0f4cec010ad839ddeb39d7c0b906b87e3b561852bcab67aa58de9243fda22d095525f52", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99a449da0b1d36290b77c4dd5429042ab414c6ef679164be5a427d602f255ed11ac552247590da2e5e442b2cca1a39e7a9aaec8338f542a6d0423af5d530719"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 03:20:58.694070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:20:58.694394) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496221000.251318-1498992489 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 03:20:58.778834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 03:20:58.782171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 03:20:58.782477) ========= ========= Total master_lag: 0.15 =========