builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1500131440.36 results: success (0) revision: 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.364151) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.364841) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.365131) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.422250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.422555) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-15 08:10:40-- 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% 42.3M=0s 2017-07-15 08:10:40 (42.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.200484 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.677582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.677926) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.064082 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:40.756598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-15 08:10:40.756968) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 --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 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 --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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-15 08:10:41,014 truncating revision to first 12 chars 2017-07-15 08:10:41,014 Setting DEBUG logging. 2017-07-15 08:10:41,014 attempt 1/10 2017-07-15 08:10:41,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/951ee1bfff5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-15 08:10:42,312 unpacking tar archive at: mozilla-central-951ee1bfff5f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.606859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-15 08:10:42.376832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:42.377184) ========= script_repo_revision: 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:42.377624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:42.377898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-15 08:10:42.390152) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-15 08:10:42.390591) ========= /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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:42 INFO - MultiFileLogger online at 20170715 08:10:42 in /builds/slave/test 08:10:42 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 08:10:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:42 INFO - {'append_to_log': False, 08:10:42 INFO - 'base_work_dir': '/builds/slave/test', 08:10:42 INFO - 'blob_upload_branch': 'Firefox', 08:10:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:42 INFO - 'branch': 'Firefox', 08:10:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:42 INFO - 'code_coverage': False, 08:10:42 INFO - 'config_files': ('talos/linux_config.py',), 08:10:42 INFO - 'default_actions': ('clobber', 08:10:42 INFO - 'read-buildbot-config', 08:10:42 INFO - 'download-and-extract', 08:10:42 INFO - 'populate-webroot', 08:10:42 INFO - 'create-virtualenv', 08:10:42 INFO - 'install', 08:10:42 INFO - 'setup-mitmproxy', 08:10:42 INFO - 'run-tests'), 08:10:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:42 INFO - 'disable_ccov_upload': False, 08:10:42 INFO - 'download_minidump_stackwalk': True, 08:10:42 INFO - 'download_symbols': 'ondemand', 08:10:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:42 INFO - 'gecko_profile': False, 08:10:42 INFO - 'gecko_profile_interval': 0, 08:10:42 INFO - 'installer_path': 'installer.exe', 08:10:42 INFO - 'log_level': 'info', 08:10:42 INFO - 'log_name': 'talos', 08:10:42 INFO - 'log_to_console': True, 08:10:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:42 INFO - 'opt_config_files': (), 08:10:42 INFO - 'pip_index': False, 08:10:42 INFO - 'suite': 'dromaeojs-e10s', 08:10:42 INFO - 'system_bits': '32', 08:10:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:42 INFO - 'title': 'talos-linux64-ix-029', 08:10:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:42 INFO - 'use_talos_json': True, 08:10:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:42 INFO - 'work_dir': 'build'} 08:10:42 INFO - [mozharness: 2017-07-15 15:10:42.851560Z] Running clobber step. 08:10:42 INFO - Running pre-action listener: _resource_record_pre_action 08:10:42 INFO - Running main action method: clobber 08:10:42 INFO - rmtree: /builds/slave/test/build 08:10:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:45 INFO - Running post-action listener: _resource_record_post_action 08:10:45 INFO - [mozharness: 2017-07-15 15:10:45.149855Z] Finished clobber step (success) 08:10:45 INFO - [mozharness: 2017-07-15 15:10:45.149957Z] Running read-buildbot-config step. 08:10:45 INFO - Running pre-action listener: _resource_record_pre_action 08:10:45 INFO - Running main action method: read_buildbot_config 08:10:45 INFO - Using buildbot properties: 08:10:45 INFO - { 08:10:45 INFO - "project": "", 08:10:45 INFO - "product": "firefox", 08:10:45 INFO - "who": "archaeopteryx@coole-files.de", 08:10:45 INFO - "installer_path": "public/build/target.tar.bz2", 08:10:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:10:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:10:45 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:10:45 INFO - "stage_platform": "linux64-stylosequential", 08:10:45 INFO - "basedir": "/builds/slave/test", 08:10:45 INFO - "buildnumber": 106, 08:10:45 INFO - "platform": "ubuntu64_hw_styloseq", 08:10:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:10:45 INFO - "slavebuilddir": "test", 08:10:45 INFO - "taskId": "XsLQEXeuTtqJ951HhHbFSA", 08:10:45 INFO - "branch": "mozilla-central", 08:10:45 INFO - "script_repo_revision": "production", 08:10:45 INFO - "revision": "951ee1bfff5fbffe8b52e48ede67c0f050c3ec27", 08:10:45 INFO - "slavename": "talos-linux64-ix-029", 08:10:45 INFO - "repo_path": "mozilla-central" 08:10:45 INFO - } 08:10:45 INFO - Finding installer, test and symbols from parent task. 08:10:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsLQEXeuTtqJ951HhHbFSA'}, attempt #1 08:10:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XsLQEXeuTtqJ951HhHbFSA'}, attempt #1 08:10:46 INFO - Task dependencies: Z9-nVwSpTM--hCKtNyFH-A 08:10:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A'}, attempt #1 08:10:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 08:10:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/test_packages.json 08:10:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.crashreporter-symbols.zip 08:10:46 INFO - Running post-action listener: _resource_record_post_action 08:10:46 INFO - [mozharness: 2017-07-15 15:10:46.553852Z] Finished read-buildbot-config step (success) 08:10:46 INFO - [mozharness: 2017-07-15 15:10:46.554075Z] Running download-and-extract step. 08:10:46 INFO - Running pre-action listener: _resource_record_pre_action 08:10:46 INFO - Running main action method: download_and_extract 08:10:46 INFO - mkdir: /builds/slave/test/build/tests 08:10: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')]} 08:10:46 INFO - trying https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.test_packages.json 08:10:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:10:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:10:47 INFO - Downloaded 989 bytes. 08:10:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:10:47 INFO - Using the following test package requirements: 08:10:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:10:47 INFO - u'common': [u'target.common.tests.zip'], 08:10:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:10:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:10:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:10:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:10:47 INFO - u'mozbase': [u'target.common.tests.zip'], 08:10:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:10:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:10:47 INFO - u'web-platform': [u'target.common.tests.zip', 08:10:47 INFO - u'target.web-platform.tests.tar.gz'], 08:10:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:10:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:10:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip 08:10:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:10:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip into memory 08:10:48 INFO - Content-Length response header: 72760319 08:10:48 INFO - Bytes received: 72760319 08:10:59 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:10:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip 08:10:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:10:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.common.tests.zip into memory 08:11:01 INFO - Content-Length response header: 72760319 08:11:01 INFO - Bytes received: 72760319 08:11:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.talos.tests.zip 08:11:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:11:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.talos.tests.zip into memory 08:11:15 INFO - Content-Length response header: 14495012 08:11:15 INFO - Bytes received: 14495012 08:11:15 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')]} 08:11:15 INFO - trying https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 08:11:15 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:11:16 INFO - Downloaded 61852610 bytes. 08:11:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 08:11:16 INFO - mkdir: /builds/slave/test/properties 08:11:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:16 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:16 INFO - Contents: 08:11:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 08:11:16 INFO - Running post-action listener: _resource_record_post_action 08:11:16 INFO - Running post-action listener: set_extra_try_arguments 08:11:16 INFO - [mozharness: 2017-07-15 15:11:16.538941Z] Finished download-and-extract step (success) 08:11:16 INFO - [mozharness: 2017-07-15 15:11:16.539039Z] Running populate-webroot step. 08:11:16 INFO - Running pre-action listener: _resource_record_pre_action 08:11:16 INFO - Running main action method: populate_webroot 08:11:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:16 INFO - '--tppagecycles', 08:11:16 INFO - '7'], 08:11:16 INFO - 'tests': ['tsvgm']}}, 08:11:16 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['damp', 'tps']}, 08:11:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'tests': ['damp', 'tps']}, 08:11:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['dromaeo_dom']}, 08:11:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:11:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:11:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:11:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_many_windows', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_many_windows', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_many_windows', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['a11yr', 08:11:16 INFO - 'ts_paint', 08:11:16 INFO - 'tpaint', 08:11:16 INFO - 'sessionrestore', 08:11:16 INFO - 'sessionrestore_no_auto_restore', 08:11:16 INFO - 'tabpaint']}, 08:11:16 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 08:11:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:11:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:11:16 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:11:16 INFO - 'talos_options': ['--mitmproxy', 08:11:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:11:16 INFO - '--firstNonBlankPaint'], 08:11:16 INFO - 'tests': ['quantum_pageload_google', 08:11:16 INFO - 'quantum_pageload_youtube', 08:11:16 INFO - 'quantum_pageload_amazon', 08:11:16 INFO - 'quantum_pageload_facebook']}, 08:11:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tsvgx', 08:11:16 INFO - 'tsvgr_opacity', 08:11:16 INFO - 'tart', 08:11:16 INFO - 'tscrollx', 08:11:16 INFO - 'cart', 08:11:16 INFO - 'tsvg_static']}, 08:11:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:16 INFO - 'tsvgr_opacity', 08:11:16 INFO - 'tart', 08:11:16 INFO - 'tscrollx', 08:11:16 INFO - 'cart', 08:11:16 INFO - 'tsvg_static']}, 08:11:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s'], 08:11:16 INFO - 'tests': ['tp5o']}, 08:11:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:11:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'talos_options': ['--disable-e10s', 08:11:16 INFO - '--xperf_path', 08:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:16 INFO - 'tests': ['tp5n']}, 08:11:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:11:16 INFO - 'talos_options': ['--xperf_path', 08:11:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:16 INFO - 'tests': ['tp5n']}}, 08:11:16 INFO - 'talos.zip': {'path': '', 08:11:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:16 INFO - Running post-action listener: _resource_record_post_action 08:11:16 INFO - [mozharness: 2017-07-15 15:11:16.554286Z] Finished populate-webroot step (success) 08:11:16 INFO - [mozharness: 2017-07-15 15:11:16.554376Z] Running create-virtualenv step. 08:11:16 INFO - Running pre-action listener: _resource_record_pre_action 08:11:16 INFO - Running main action method: create_virtualenv 08:11:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:16 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 08:11:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:11:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:16 INFO - Using real prefix '/usr' 08:11:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:19 INFO - Installing pip.................done. 08:11:19 INFO - Return code: 0 08:11:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:11:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:11:19 INFO - Reading from file tmpfile_stdout 08:11:19 INFO - Output received: 08:11:19 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) 08:11:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:19 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')]} 08:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:19 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')]} 08:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:19 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:19 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 08:11:19 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 08:11:19 INFO - Using env: {'DISPLAY': ':0', 08:11:19 INFO - 'HOME': '/home/cltbld', 08:11:19 INFO - 'LANG': 'en_US.UTF-8', 08:11:19 INFO - 'LANGUAGE': 'en_US:en', 08:11:19 INFO - 'LOGNAME': 'cltbld', 08:11:19 INFO - 'MAIL': '/var/mail/cltbld', 08:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:19 INFO - 'MOZ_NO_REMOTE': '1', 08:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:19 INFO - 'NO_EM_RESTART': '1', 08:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:19 INFO - 'PWD': '/builds/slave/test', 08:11:19 INFO - 'SHELL': '/bin/bash', 08:11:19 INFO - 'SHLVL': '1', 08:11:19 INFO - 'TERM': 'linux', 08:11:19 INFO - 'TMOUT': '86400', 08:11:19 INFO - 'USER': 'cltbld', 08:11:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:19 INFO - '_': '/tools/buildbot/bin/python'} 08:11:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:19 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 08:11:19 INFO - Cleaning up... 08:11:19 INFO - Return code: 0 08:11:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:19 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')]} 08:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:19 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')]} 08:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:19 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:19 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 08:11:19 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 08:11:19 INFO - Using env: {'DISPLAY': ':0', 08:11:19 INFO - 'HOME': '/home/cltbld', 08:11:19 INFO - 'LANG': 'en_US.UTF-8', 08:11:19 INFO - 'LANGUAGE': 'en_US:en', 08:11:19 INFO - 'LOGNAME': 'cltbld', 08:11:19 INFO - 'MAIL': '/var/mail/cltbld', 08:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:19 INFO - 'MOZ_NO_REMOTE': '1', 08:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:19 INFO - 'NO_EM_RESTART': '1', 08:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:19 INFO - 'PWD': '/builds/slave/test', 08:11:19 INFO - 'SHELL': '/bin/bash', 08:11:19 INFO - 'SHLVL': '1', 08:11:19 INFO - 'TERM': 'linux', 08:11:19 INFO - 'TMOUT': '86400', 08:11:19 INFO - 'USER': 'cltbld', 08:11:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:19 INFO - '_': '/tools/buildbot/bin/python'} 08:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:20 INFO - Downloading/unpacking psutil>=3.1.1 08:11:20 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 08:11:20 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 08:11:20 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 08:11:20 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 08:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:21 INFO - Installing collected packages: psutil 08:11:21 INFO - Running setup.py install for psutil 08:11:21 INFO - building 'psutil._psutil_linux' extension 08:11:21 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 08:11:22 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 08:11:22 INFO - building 'psutil._psutil_posix' extension 08:11:22 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 08:11:22 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 08:11:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:22 INFO - Successfully installed psutil 08:11:22 INFO - Cleaning up... 08:11:22 INFO - Return code: 0 08:11:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:22 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:22 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 08:11:22 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 08:11:22 INFO - Using env: {'DISPLAY': ':0', 08:11:22 INFO - 'HOME': '/home/cltbld', 08:11:22 INFO - 'LANG': 'en_US.UTF-8', 08:11:22 INFO - 'LANGUAGE': 'en_US:en', 08:11:22 INFO - 'LOGNAME': 'cltbld', 08:11:22 INFO - 'MAIL': '/var/mail/cltbld', 08:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:22 INFO - 'MOZ_NO_REMOTE': '1', 08:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:22 INFO - 'NO_EM_RESTART': '1', 08:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:22 INFO - 'PWD': '/builds/slave/test', 08:11:22 INFO - 'SHELL': '/bin/bash', 08:11:22 INFO - 'SHLVL': '1', 08:11:22 INFO - 'TERM': 'linux', 08:11:22 INFO - 'TMOUT': '86400', 08:11:22 INFO - 'USER': 'cltbld', 08:11:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:22 INFO - '_': '/tools/buildbot/bin/python'} 08:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:22 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 08:11:22 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 08:11:22 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 08:11:22 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 08:11:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:23 INFO - Installing collected packages: mozsystemmonitor 08:11:23 INFO - Running setup.py install for mozsystemmonitor 08:11:24 INFO - Successfully installed mozsystemmonitor 08:11:24 INFO - Cleaning up... 08:11:24 INFO - Return code: 0 08:11:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:24 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')]} 08:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:24 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')]} 08:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:24 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:24 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 08:11:24 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 08:11:24 INFO - Using env: {'DISPLAY': ':0', 08:11:24 INFO - 'HOME': '/home/cltbld', 08:11:24 INFO - 'LANG': 'en_US.UTF-8', 08:11:24 INFO - 'LANGUAGE': 'en_US:en', 08:11:24 INFO - 'LOGNAME': 'cltbld', 08:11:24 INFO - 'MAIL': '/var/mail/cltbld', 08:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:24 INFO - 'MOZ_NO_REMOTE': '1', 08:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:24 INFO - 'NO_EM_RESTART': '1', 08:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:24 INFO - 'PWD': '/builds/slave/test', 08:11:24 INFO - 'SHELL': '/bin/bash', 08:11:24 INFO - 'SHLVL': '1', 08:11:24 INFO - 'TERM': 'linux', 08:11:24 INFO - 'TMOUT': '86400', 08:11:24 INFO - 'USER': 'cltbld', 08:11:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:24 INFO - '_': '/tools/buildbot/bin/python'} 08:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:24 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:24 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 08:11:24 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 08:11:24 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 08:11:24 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 08:11:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:25 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:25 INFO - warning: no files found matching '*.txt' 08:11:25 INFO - no previously-included directories found matching 'build' 08:11:25 INFO - no previously-included directories found matching 'dist' 08:11:25 INFO - no previously-included directories found matching '.git*' 08:11:25 INFO - Installing collected packages: jsonschema, functools32 08:11:25 INFO - Running setup.py install for functools32 08:11:25 INFO - warning: no files found matching '*.txt' 08:11:25 INFO - no previously-included directories found matching 'build' 08:11:25 INFO - no previously-included directories found matching 'dist' 08:11:25 INFO - no previously-included directories found matching '.git*' 08:11:25 INFO - Successfully installed jsonschema functools32 08:11:25 INFO - Cleaning up... 08:11:25 INFO - Return code: 0 08:11:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11:25 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')]} 08:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:25 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')]} 08:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:25 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:25 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 08:11:25 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 08:11:25 INFO - Using env: {'DISPLAY': ':0', 08:11:25 INFO - 'HOME': '/home/cltbld', 08:11:25 INFO - 'LANG': 'en_US.UTF-8', 08:11:25 INFO - 'LANGUAGE': 'en_US:en', 08:11:25 INFO - 'LOGNAME': 'cltbld', 08:11:25 INFO - 'MAIL': '/var/mail/cltbld', 08:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:25 INFO - 'MOZ_NO_REMOTE': '1', 08:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:25 INFO - 'NO_EM_RESTART': '1', 08:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:25 INFO - 'PWD': '/builds/slave/test', 08:11:25 INFO - 'SHELL': '/bin/bash', 08:11:25 INFO - 'SHLVL': '1', 08:11:25 INFO - 'TERM': 'linux', 08:11:25 INFO - 'TMOUT': '86400', 08:11:25 INFO - 'USER': 'cltbld', 08:11:25 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:25 INFO - '_': '/tools/buildbot/bin/python'} 08:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:26 INFO - Cleaning up... 08:11:26 INFO - Return code: 0 08:11:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:26 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:26 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 08:11:26 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 08:11:26 INFO - Using env: {'DISPLAY': ':0', 08:11:26 INFO - 'HOME': '/home/cltbld', 08:11:26 INFO - 'LANG': 'en_US.UTF-8', 08:11:26 INFO - 'LANGUAGE': 'en_US:en', 08:11:26 INFO - 'LOGNAME': 'cltbld', 08:11:26 INFO - 'MAIL': '/var/mail/cltbld', 08:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:26 INFO - 'MOZ_NO_REMOTE': '1', 08:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:26 INFO - 'NO_EM_RESTART': '1', 08:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:26 INFO - 'PWD': '/builds/slave/test', 08:11:26 INFO - 'SHELL': '/bin/bash', 08:11:26 INFO - 'SHLVL': '1', 08:11:26 INFO - 'TERM': 'linux', 08:11:26 INFO - 'TMOUT': '86400', 08:11:26 INFO - 'USER': 'cltbld', 08:11:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:26 INFO - '_': '/tools/buildbot/bin/python'} 08:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 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 08:11:27 INFO - Downloading docopt-0.6.1.tar.gz 08:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:27 INFO - Running setup.py install for blobuploader 08:11:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:28 INFO - Running setup.py install for requests 08:11:28 INFO - Running setup.py install for docopt 08:11:28 INFO - Successfully installed blobuploader requests docopt 08:11:28 INFO - Cleaning up... 08:11:28 INFO - Return code: 0 08:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11: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')]} 08:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:28 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:28 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 08:11:28 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 08:11:28 INFO - Using env: {'DISPLAY': ':0', 08:11:28 INFO - 'HOME': '/home/cltbld', 08:11:28 INFO - 'LANG': 'en_US.UTF-8', 08:11:28 INFO - 'LANGUAGE': 'en_US:en', 08:11:28 INFO - 'LOGNAME': 'cltbld', 08:11:28 INFO - 'MAIL': '/var/mail/cltbld', 08:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:28 INFO - 'MOZ_NO_REMOTE': '1', 08:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:28 INFO - 'NO_EM_RESTART': '1', 08:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:28 INFO - 'PWD': '/builds/slave/test', 08:11:28 INFO - 'SHELL': '/bin/bash', 08:11:28 INFO - 'SHLVL': '1', 08:11:28 INFO - 'TERM': 'linux', 08:11:28 INFO - 'TMOUT': '86400', 08:11:28 INFO - 'USER': 'cltbld', 08:11:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:28 INFO - '_': '/tools/buildbot/bin/python'} 08:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:28 INFO - Running setup.py (path:/tmp/pip-7VPQtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:28 INFO - Running setup.py (path:/tmp/pip-n07W1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:28 INFO - Running setup.py (path:/tmp/pip-KF1Qzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:28 INFO - Running setup.py (path:/tmp/pip-84d4Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:28 INFO - Running setup.py (path:/tmp/pip-VewR9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:29 INFO - Running setup.py (path:/tmp/pip-LkSNYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:29 INFO - Running setup.py (path:/tmp/pip-Uj0D_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:29 INFO - Running setup.py (path:/tmp/pip-7f2zLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:29 INFO - Running setup.py (path:/tmp/pip-3Fnh_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:29 INFO - Running setup.py (path:/tmp/pip-D6GwuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:29 INFO - Running setup.py (path:/tmp/pip-fIcmcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:29 INFO - Running setup.py (path:/tmp/pip-bt2Qlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:29 INFO - Running setup.py (path:/tmp/pip-6oY0pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:29 INFO - Running setup.py (path:/tmp/pip-9QPeGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:29 INFO - Running setup.py (path:/tmp/pip-Cgg17D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:29 INFO - Running setup.py (path:/tmp/pip-696C2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:29 INFO - Running setup.py (path:/tmp/pip-Io3EqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:29 INFO - Running setup.py install for manifestparser 08:11:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for mozcrash 08:11:30 INFO - Running setup.py install for mozdebug 08:11:30 INFO - Running setup.py install for mozdevice 08:11:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for mozfile 08:11:30 INFO - Running setup.py install for mozhttpd 08:11:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for mozinfo 08:11:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for mozInstall 08:11:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for mozleak 08:11:30 INFO - Running setup.py install for mozlog 08:11:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:30 INFO - Running setup.py install for moznetwork 08:11:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozprocess 08:11:31 INFO - Running setup.py install for mozprofile 08:11:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozrunner 08:11:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Running setup.py install for mozscreenshot 08:11:31 INFO - Running setup.py install for moztest 08:11:31 INFO - Running setup.py install for mozversion 08:11:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:31 INFO - Cleaning up... 08:11:31 INFO - Return code: 0 08:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:31 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:31 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 08:11:31 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 08:11:31 INFO - Using env: {'DISPLAY': ':0', 08:11:31 INFO - 'HOME': '/home/cltbld', 08:11:31 INFO - 'LANG': 'en_US.UTF-8', 08:11:31 INFO - 'LANGUAGE': 'en_US:en', 08:11:31 INFO - 'LOGNAME': 'cltbld', 08:11:31 INFO - 'MAIL': '/var/mail/cltbld', 08:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:31 INFO - 'MOZ_NO_REMOTE': '1', 08:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:31 INFO - 'NO_EM_RESTART': '1', 08:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:31 INFO - 'PWD': '/builds/slave/test', 08:11:31 INFO - 'SHELL': '/bin/bash', 08:11:31 INFO - 'SHLVL': '1', 08:11:31 INFO - 'TERM': 'linux', 08:11:31 INFO - 'TMOUT': '86400', 08:11:31 INFO - 'USER': 'cltbld', 08:11:31 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:31 INFO - '_': '/tools/buildbot/bin/python'} 08:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:32 INFO - Running setup.py (path:/tmp/pip-D5j7qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:32 INFO - Running setup.py (path:/tmp/pip-tl9_wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:32 INFO - Running setup.py (path:/tmp/pip-puhdHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:32 INFO - Running setup.py (path:/tmp/pip-GLwvCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:32 INFO - Running setup.py (path:/tmp/pip-V0FQH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:32 INFO - Running setup.py (path:/tmp/pip-nzG365-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:32 INFO - Running setup.py (path:/tmp/pip-JlCI_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:32 INFO - Running setup.py (path:/tmp/pip-XZd0Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:32 INFO - Running setup.py (path:/tmp/pip-RJfaiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:32 INFO - Running setup.py (path:/tmp/pip-4NjR0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:32 INFO - Running setup.py (path:/tmp/pip-yDkrxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:32 INFO - Running setup.py (path:/tmp/pip-dqyxgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:32 INFO - Running setup.py (path:/tmp/pip-juWCrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:32 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)) 08:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:32 INFO - Running setup.py (path:/tmp/pip-ncnggr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:33 INFO - Running setup.py (path:/tmp/pip-EgJM2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:33 INFO - Running setup.py (path:/tmp/pip-E31O6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:33 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)) 08:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:33 INFO - Running setup.py (path:/tmp/pip-JVd_eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:33 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)) 08:11:33 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)) 08:11:33 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)) 08:11:33 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)) 08:11:33 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)) 08:11:33 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)) 08:11:33 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:11:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11: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 08:11: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 08:11: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 08:11: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 08:11:34 INFO - Downloading blessings-1.6.tar.gz 08:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:34 INFO - Installing collected packages: blessings 08:11:34 INFO - Running setup.py install for blessings 08:11:34 INFO - Successfully installed blessings 08:11:34 INFO - Cleaning up... 08:11:34 INFO - Return code: 0 08:11:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:34 INFO - Reading from file tmpfile_stdout 08:11:34 INFO - Current package versions: 08:11:34 INFO - argparse == 1.2.1 08:11:34 INFO - blessings == 1.6 08:11:34 INFO - blobuploader == 1.2.4 08:11:34 INFO - docopt == 0.6.1 08:11:34 INFO - functools32 == 3.2.3-2 08:11:34 INFO - jsonschema == 2.5.1 08:11:34 INFO - manifestparser == 1.1 08:11:34 INFO - mozInstall == 1.13 08:11:34 INFO - mozcrash == 1.0 08:11:34 INFO - mozdebug == 0.1 08:11:34 INFO - mozdevice == 0.51 08:11:34 INFO - mozfile == 1.2 08:11:34 INFO - mozhttpd == 0.7 08:11:34 INFO - mozinfo == 0.10 08:11:34 INFO - mozleak == 0.1 08:11:34 INFO - mozlog == 3.5 08:11:34 INFO - moznetwork == 0.27 08:11:34 INFO - mozprocess == 0.25 08:11:34 INFO - mozprofile == 0.28 08:11:34 INFO - mozrunner == 6.13 08:11:34 INFO - mozscreenshot == 0.1 08:11:34 INFO - mozsystemmonitor == 0.3 08:11:34 INFO - moztest == 0.8 08:11:34 INFO - mozversion == 1.4 08:11:34 INFO - psutil == 3.1.1 08:11:34 INFO - requests == 1.2.3 08:11:34 INFO - wsgiref == 0.1.2 08:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11: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')]} 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:34 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 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11:34 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 08:11:34 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 08:11:34 INFO - Using env: {'DISPLAY': ':0', 08:11:34 INFO - 'HOME': '/home/cltbld', 08:11:34 INFO - 'LANG': 'en_US.UTF-8', 08:11:34 INFO - 'LANGUAGE': 'en_US:en', 08:11:34 INFO - 'LOGNAME': 'cltbld', 08:11:34 INFO - 'MAIL': '/var/mail/cltbld', 08:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:34 INFO - 'MOZ_NO_REMOTE': '1', 08:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:34 INFO - 'NO_EM_RESTART': '1', 08:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:34 INFO - 'PWD': '/builds/slave/test', 08:11:34 INFO - 'SHELL': '/bin/bash', 08:11:34 INFO - 'SHLVL': '1', 08:11:34 INFO - 'TERM': 'linux', 08:11:34 INFO - 'TMOUT': '86400', 08:11:34 INFO - 'USER': 'cltbld', 08:11:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:34 INFO - '_': '/tools/buildbot/bin/python'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:34 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)) 08:11:35 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:11: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 08:11: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 08:11: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 08:11: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 08:11:36 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:11:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 08:11: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 08:11: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 08:11: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 08:11: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 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:11:36 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)) 08:11:36 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)) 08:11:36 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)) 08:11:36 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)) 08:11:36 INFO - Installing collected packages: marionette-driver, simplejson 08:11:36 INFO - Running setup.py install for marionette-driver 08:11:36 INFO - Running setup.py install for simplejson 08:11:36 INFO - building 'simplejson._speedups' extension 08:11:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 08:11:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 08:11:37 INFO - Successfully installed marionette-driver simplejson 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11: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')]} 08:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20081f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2377fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', '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 08:11: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', 'jsonschema'] in /builds/slave/test/build 08:11: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 jsonschema 08:11:37 INFO - Using env: {'DISPLAY': ':0', 08:11:37 INFO - 'HOME': '/home/cltbld', 08:11:37 INFO - 'LANG': 'en_US.UTF-8', 08:11:37 INFO - 'LANGUAGE': 'en_US:en', 08:11:37 INFO - 'LOGNAME': 'cltbld', 08:11:37 INFO - 'MAIL': '/var/mail/cltbld', 08:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:37 INFO - 'MOZ_NO_REMOTE': '1', 08:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:37 INFO - 'NO_EM_RESTART': '1', 08:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:37 INFO - 'PWD': '/builds/slave/test', 08:11:37 INFO - 'SHELL': '/bin/bash', 08:11:37 INFO - 'SHLVL': '1', 08:11:37 INFO - 'TERM': 'linux', 08:11:37 INFO - 'TMOUT': '86400', 08:11:37 INFO - 'USER': 'cltbld', 08:11:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:37 INFO - '_': '/tools/buildbot/bin/python'} 08:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Running post-action listener: _resource_record_post_action 08:11:37 INFO - Running post-action listener: _start_resource_monitoring 08:11:37 INFO - Starting resource monitoring. 08:11:37 INFO - [mozharness: 2017-07-15 15:11:37.939818Z] Finished create-virtualenv step (success) 08:11:37 INFO - [mozharness: 2017-07-15 15:11:37.940868Z] Running install step. 08:11:37 INFO - Running pre-action listener: _resource_record_pre_action 08:11:37 INFO - Running main action method: install 08:11:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:38 INFO - Reading from file tmpfile_stdout 08:11:38 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:38 INFO - Reading from file tmpfile_stdout 08:11:38 INFO - Output received: 08:11:38 INFO - Usage: mozinstall [options] installer 08:11:38 INFO - Options: 08:11:38 INFO - -h, --help show this help message and exit 08:11:38 INFO - -d DEST, --destination=DEST 08:11:38 INFO - Directory to install application into. [default: 08:11:38 INFO - "/builds/slave/test"] 08:11:38 INFO - --app=APP Application being installed. [default: firefox] 08:11:38 INFO - mkdir: /builds/slave/test/build/application 08:11:38 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'] 08:11:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:11:56 INFO - Reading from file tmpfile_stdout 08:11:56 INFO - Output received: 08:11:56 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:56 INFO - Running post-action listener: _resource_record_post_action 08:11:56 INFO - [mozharness: 2017-07-15 15:11:56.204109Z] Finished install step (success) 08:11:56 INFO - [mozharness: 2017-07-15 15:11:56.204258Z] Running setup-mitmproxy step. 08:11:56 INFO - Running pre-action listener: _resource_record_pre_action 08:11:56 INFO - Running main action method: setup_mitmproxy 08:11:56 INFO - Skipping: mitmproxy is not required 08:11:56 INFO - Running post-action listener: _resource_record_post_action 08:11:56 INFO - [mozharness: 2017-07-15 15:11:56.205212Z] Finished setup-mitmproxy step (success) 08:11:56 INFO - [mozharness: 2017-07-15 15:11:56.205433Z] Running run-tests step. 08:11:56 INFO - Running pre-action listener: _resource_record_pre_action 08:11:56 INFO - Running pre-action listener: _set_gcov_prefix 08:11:56 INFO - Running main action method: run_tests 08:11:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:56 INFO - Python 2.7.3 08:11:56 INFO - Return code: 0 08:11:56 INFO - grabbing minidump binary from tooltool 08:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:56 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 0x237b2a0>, '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 0x237c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23764d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:56 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 08:11:56 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 08:11:56 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 08:11:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:56 INFO - Return code: 0 08:11:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:56 INFO - ENV: RUST_BACKTRACE is now 1 08:11:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:56 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/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 08:11:56 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/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 08:11:56 INFO - Using env: {'DISPLAY': ':0', 08:11:56 INFO - 'HOME': '/home/cltbld', 08:11:56 INFO - 'LANG': 'en_US.UTF-8', 08:11:56 INFO - 'LANGUAGE': 'en_US:en', 08:11:56 INFO - 'LOGNAME': 'cltbld', 08:11:56 INFO - 'MAIL': '/var/mail/cltbld', 08:11:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:56 INFO - 'MOZ_NO_REMOTE': '1', 08:11:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:56 INFO - 'NO_EM_RESTART': '1', 08:11:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:56 INFO - 'PWD': '/builds/slave/test', 08:11:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:56 INFO - 'RUST_BACKTRACE': '1', 08:11:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:11:56 INFO - 'SHELL': '/bin/bash', 08:11:56 INFO - 'SHLVL': '1', 08:11:56 INFO - 'TERM': 'linux', 08:11:56 INFO - 'TMOUT': '86400', 08:11:56 INFO - 'USER': 'cltbld', 08:11:56 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700', 08:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:56 INFO - '_': '/tools/buildbot/bin/python'} 08:11:56 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/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 08:11:56 INFO - mozversion application_buildid: 20170715142621 08:11:56 INFO - mozversion application_changeset: 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 08:11:56 INFO - mozversion application_display_name: Nightly 08:11:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:56 INFO - mozversion application_name: Firefox 08:11:56 INFO - mozversion application_remotingname: firefox 08:11:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:11:56 INFO - mozversion application_vendor: Mozilla 08:11:56 INFO - mozversion application_version: 56.0a1 08:11:56 INFO - mozversion platform_buildid: 20170715142621 08:11:56 INFO - mozversion platform_changeset: 951ee1bfff5fbffe8b52e48ede67c0f050c3ec27 08:11:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:11:56 INFO - mozversion platform_version: 56.0a1 08:11:56 INFO - using testdate: 1500131516 08:11:56 INFO - actual date: 1500131516 08:11:56 INFO - starting webserver on 'localhost:44569' 08:11:56 INFO - SUITE-START | Running 2 tests 08:11:56 INFO - TEST-START | dromaeo_css 08:11:56 INFO - Initialising browser for dromaeo_css test... 08:11:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44569/getInfo.html -profile /tmp/tmpYesWmZ/profile 08:11:56 INFO - TEST-INFO | started process 3379 (/builds/slave/test/build/application/firefox/firefox http://localhost:44569/getInfo.html) 08:12:06 INFO - TEST-INFO | 3379: exit 0 08:12:06 INFO - Browser initialized. 08:12:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:06 INFO - TEST-INFO | started process 3605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYesWmZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:18 INFO - PID 3605 | RSS: Main: 172875776 08:12:18 INFO - PID 3605 | 08:15:17 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44569/tests/dromaeo/cssquery-ext.html) 08:15:18 INFO - PID 3605 | RSS: Main: 178122752 08:15:18 INFO - PID 3605 | 08:18:20 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-ext.html (next: http://localhost:44569/tests/dromaeo/cssquery-jquery.html) 08:18:20 INFO - PID 3605 | RSS: Main: 175923200 08:18:20 INFO - PID 3605 | 08:21:22 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44569/tests/dromaeo/cssquery-mootools.html) 08:21:23 INFO - PID 3605 | RSS: Main: 178765824 08:21:23 INFO - PID 3605 | 08:24:24 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44569/tests/dromaeo/cssquery-prototype.html) 08:24:25 INFO - PID 3605 | RSS: Main: 178352128 08:24:25 INFO - PID 3605 | 08:27:28 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44569/tests/dromaeo/cssquery-yui.html) 08:27:29 INFO - PID 3605 | RSS: Main: 177287168 08:27:29 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | Cycle 1(1): loaded http://localhost:44569/tests/dromaeo/cssquery-yui.html (next: http://localhost:44569/tests/dromaeo/cssquery-dojo.html) 08:30:31 INFO - PID 3605 | RSS: Main: 180854784 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | __start_tp_report 08:30:31 INFO - PID 3605 | _x_x_mozilla_page_load 08:30:31 INFO - PID 3605 | _x_x_mozilla_page_load_details 08:30:31 INFO - PID 3605 | |i|pagename|runs| 08:30:31 INFO - PID 3605 | |0;dojo.html;3052.8931487397945;3105.037438394098;3125.6092988376454;3132.216945763559;3138.890138845141;6030.849228769277;6054.576179667425;6082.391760823915;6084.847878803038;6126.724297406617;6083.270007599083;6111.755529778803;6113.633182009072;6115.052166914135;6117.755289788403;5568.025595520788;5576.079946808782;5609.35492418371;5638.943610563882;5653.4911857932775;5567.777288908439;5599.188117722928;5603.60774745768;5605.103183490643;5611.579131565129;5616.185653080301;5617.045102332593;5618.662880227179;5622.4939755422;5642.238297829802;5634.85912852182;5636.605437619368;5650.915236271459;5653.1520271959125;5654.151877218409;5527.585431092684;5579.414161513064;5597.776088956437;5616.719164041781;5716.256886604757;6008.579399442041;6069.969650151766;6099.542534309944;6119.969400152971;6126.663033533154;6338;6361.395667411589;6438.420542151229;6451.580647257913;6543.672816359163;6450.870982580323;6455.709493072776;6457.580257283308;6468.288488266334;6475.384838440341;6042.305134909498;6049.667268300242;6058.454739073461;6063.333033366326;6070.939290607082;6584.045313429574;6620.040094186316;6738.124043874265;6758.695858686371;6847.281035491202;6328;6385.840353991188;6410.391012853772;6502;6514.706838192293;6523.64119973406;6544.280129185786;6575.079488871562;6575.967120164369;6601.73593056282;6355.682215889279;6362.77730279438;6404.199475065617;6412.807615771534;6462.579932304385;6417.679116044179;6516.283208847023;6552.049952756824;6555.1478307820635;6632.0383544385795;5225.320708307896;5299.629025968223;5361.0618141825025;5368.5436737876935;5388.892222155613;4553.749543775058;4581.244094724333;4594.839180628662;4598.586127248497;4603.263477843529;5662.943370566324;5699.031164701928;5700.372958974593;5708.40061793514;5708.743106560215;6561.212654481493;6565.967170164118;6566.638834864033;6569.67151642416;6571.408573228432;5687.573431992617;5744.425557444306;5757.539396848326;5793.391693872167;5809.477147056785;5723.942760572424;5745.85635359111;5764.769409223668;5784.913226301609;5799.536037117021;6276.340984196594;6294.433500984934;6299.842503937438;6306.779262725782;6314.842128946813;6429.324920883427;6431.421172094534;6464.353564643498;6489.253735820441;6501.837454063497;6241.500679945502;6261.3112557617715;6284.874302513833;6418.871622567429;6507.544471886922;6398.264199617103;6430.1319321892815;6512.934870651233;6558.311377305315;6559.770408035696;6626.337366263335;6641.26946035926;6665.100211471583;6713.194416669836;6717.899231511434;6311.116443697794;6372.58578192416;6395.136656551306;6402.135711678864;6480.287168411565;6331.303556608677;6332.746690132343;6333.809985700436;6359.618422894641;6401.8719625608155;6257.2491301044165;6259.2488901332135;6304.779332723333;6308.179936608211;6314.242290925118;6475.3200913903365;6509;6511.120998665119;6546.24718157418;6597.670116494252;6226.346233645402;6261.217347831521;6322.778702745381;6331.90502142459;6332.715027823851 08:30:31 INFO - PID 3605 | |1;ext.html;768.9269519395656;813.5403497024184;836.778253762753;856.3662889461797;860.3031544448995;41067.79466102669;41614;41827.581724182746;41915.37126943091;41987.79006104969;37219.25561488768;37521.43717844234;37817.810910945474;37844.43233351495;37892.81053594728;6873;6988.895166572505;6989.4408447324095;6989.965050174767;7005.299470053005;6898.965505172467;6932.098827152488;6973.302669733037;6985.091938048072;6988.4409247260355;6949.20084190317;6961.025456436103;6964.547304425221;6971.163460384761;6973;6857.348551887562;6884.070650462174;6891.965540172318;6894.13823272091;6923.342282483156;6267.561270711007;6311.96844015777;6315.684215789192;6354.872902541923;6360.681965901686;33872.661273387195;34087.82956085228;34108.48837267443;34137.317253655034;34170.82914585411;3400.608929973035;3454.792712437237;3555.253396786678;3622.728295377857;3625.401808701561;31415;31558.526622100686;31578.684213157805;31619.36761264785;31621.841890790627;4943.480934501861;4948.975255123737;4974.204127339608;4983.576396006344;5052.4189718182515;183433;187407;188125;188397;188582;42159;46935.5306446938;47857.282140767216;48195;48227.517724823;50522;50619.493805062215;50684.493155067976;50740;50776;16535.503934881974;16653.50039498817;16668.916655416644;16678.833211667727;16687.83312166887;13748.93125534366;13795.172289662452;13800.171989680652;13851.792223116661;13892.235927023909;13734.65663358424;13751.106178098391;13769.586912392644;13909.721805563831;13971.231582263074;5626.578006649518;5650.886982260332;5680;5708.229389032511;5778.653280803165;977.9315447918719;1000.479750529735;1002.1832206751474;1014.5840205515851;1027.275770581738;22293.108275669118;22606.09575616957;22886.8855655724;22905.312840614475;23208.651870221962;1083.3175099687146;1083.869935607732;1121.8036843552345;1122.405125283601;1124.3478782306242;11949.701257468632;12130.939345303394;12206.877931220752;12234.75530489403;12372.505099795908;219803;220293;221013;221237;221578;52153.47846521486;52380;52538.73730631399;52571.73714131405;53016.73491632594;1438.9640258993818;1442.7186698593882;1478.2460944918168;1495.3719437836135;1513.7956375889114;22228.55542889101;22282.665760013937;27775.30561735973;28714.42571148607;28884.855575721987;50948.23577646264;51752;51919;51937.7403112982;52004.739976299876;202915;203076;203408;205436;207072;31312.843435782674;31727;32163.678363217005;34942;36882;39672.40491392689;43360.566394335656;43365.132697346504;43500.564994349654;43643.56356436395;31525.369492610476;31671.84164079165;32275.51586726154;32385.67614323921;32784.50823237701;31307.373852523277;31908.36183276368;31946.68053319437;32158.51762223615;32544;35343.29313413666;35391.646083538835;35500.822495887354;35677.108072297364;35731.285374292886;29548;31116;31137.377252455277;31391.21521961969;31662.525062123626;23305;23306.3008109757;23422.18022369209;23651.881740591187;24088.87955560211 08:30:31 INFO - PID 3605 | |2;jquery.html;558.9217509548662;568.3520786303615;574.9941857300498;580.9941900580993;602.8010756450371;22113.668294975567;22707.432314192112;23058.76941230587;23087;23189.884050579723;27134.5929811053;27506;27578.172654820337;27654.44691106177;27660.170194894134;6540.705668244928;6717.63053032083;6719.596824190564;6720.865582688368;6732.461403087766;5575.916361254584;6248.968755156217;6598.538102332838;6680.599164050148;6718.764843230488;6494.772682956098;6557.245916719567;6566.113574667406;6570.934290657104;6577.736890524373;6512.283648798629;6516.446102081329;6517.608943463408;6520.119783829194;6520.67396630169;6071.544634152457;6108.602940808878;6114.144019837227;6131.41751533608;6131.662758548278;27658.861705691543;29569.852150739323;29659.406811863857;30170.396592068035;30250.54624180639;1916.60709554541;1953.667876461005;1960.0199900049975;1960.2159136345433;1965.282671824788;18878.716819247722;19342.32301869428;19345.709814352795;19465;19575.80424195754;2355.0697474497647;2367.147826782357;2429.963550546743;2434.6713193718797;2437.2566367257978;135727.32136339354;138487.30756346256;139532;140076;140076.29961850125;14256.928715356356;15347;15571.532854014398;15797.684046319238;15988.920055399882;23928.521429571312;23950.64074038891;24060.518789624108;24075.879620601783;24234.394140146636;9793.951030244945;9857.55640996157;9892.15916647093;9898.653547125816;10028.097471227478;9022.368434209542;9024.052474490216;9026.684066057787;9063.637454501746;9119.270458363315;9115.863262051074;9428.952855235817;9572.808543829224;9658.275629327689;9751.414915105117;2769.1969328894797;2782.1653503949137;2789.8047136700643;2808.845513496777;2828.717128287155;950.5627411390699;955.350361754014;959.6449313753956;979.7893452907516;992.8609994600762;19741.60516789685;19980.50048748793;20065.699014514794;20369.490762730755;20569.07439165241;996.7091670359029;1000.7047920863363;1037.3412882819464;1043.3739756146251;1051.1380667852288;10831.566737330577;11001.449927503592;11074.335539867634;11343.886561134448;11407.771844563062;414119;438835;444857;454013;458966;110330;114310.42844785722;115325;115916.42041789737;116367.41816290864;1202.6897401313645;1213.7572485502935;1235.8764123587569;1240.8697086805937;1245.1408528115571;17032.48902532926;17598.94406335624;17617.383391581745;18455.169517371483;18702.719459207852;50182;55262.72368638131;55394;57385.426145738005;57742.42257577371;68383.65808170928;68999.65500172468;69491.30508694849;70011.64994174996;70165.29834701588;12423.937880310541;14668.77996830027;14735.484258050918;14899.404023838924;14900.62748431298;16345.159921100692;21656.242031528822;23702.762972370747;24011.159609413586;24294.51410971806;18708.906455467637;18761;18889.244430222636;18963.241470341032;19109.331173408864;16316.265768040705;16565.91717041407;17201.483955481355;17239.7414038787;17661.91169044198;19190;19404.126814293108;19506.21975121036;19527.21891124396;19834.90082549578;14540.709185816013;14678.63303417423;14711.117332960057;14733.852661473247;14761.852381476478;18399.080045997915;18489.260429583202;18716.438506844817;18725.531861703566;18797.34209302668 08:30:31 INFO - PID 3605 | |3;mootools.html;1269.2638269803513;1309.3060677840747;1324.6489680234733;1333.8399392072947;1338.0900987328616;13488.32558372081;14091.224982625952;14094.929525352372;14111.71776564468;14154.575362739108;13706.45174193031;14049.438022479115;14082.225477598728;14152.433902643881;14220.075695079813;2566.2686134451733;2626.080871694901;2636.446346267286;2648.1261183809297;2652.124798816386;2576.059738195564;2635.235781623327;2640;2641.273649746316;2645.7751091157274;2512.321673148249;2592.8833202505934;2607;2631.302704783234;2639.828411153269;2571.4728480661515;2695.191442567222;2709.376843326026;2716.1172618898936;2720.0479832058622;2578.548753968048;2579.703334116582;2610.0603782638236;2613.9215823525324;2622.8819703113213;13350.26573538455;13687.31563421825;13717.17696938187;13719.382627781773;13745.587632371045;7348.889766653505;7597.848043039164;7612.200718924489;7613.505122167041;7619.390448764086;4811.639127065449;4996.1756310208775;5094.694318340874;5095.388553373582;5097.23541468779;1738.5653586603348;1751.9912400437915;1754.6753850537564;1801.5766294920684;1831.6702993461172;22237.555248895093;22404.887975560017;22405.887970560205;22447.775522244894;22504.437389065242;6275.780347687809;6314.368563143741;6373.776917807947;6485.156929599217;6529.771457998947;15664;15699.921500392426;15702.9214853925;15725.056496610012;15750.291236894367;7351.081114860643;7480.251974802476;7487.513311634726;7491.213422590658;7491.887621685679;6837.042814006043;6849.48628852838;6949.235584085746;6976.825579360557;7019.368256856806;4837.346958160603;5005.474425185376;5087.643864929493;5108.565771909355;5173.327467429285;1466.288849907794;1477.6084337650532;1481.7258807120502;1506.841781612915;1509.682966577031;825.5459497276474;838.932885369169;842.4902933725131;868.639514601446;869.8825658536143;8347.958260208781;8649.610767515476;8699.956500217459;8741.950965884007;8814.603342849587;949.5015117063597;959.2278216036158;984.7439665686829;1001.8998100189923;1010.6109147978082;5049.9395127023;5306.97346513265;5389.191621256765;5395.2986111806;5489.58828087895;17758.822411775716;17954;18547.16537755804;18559.44321670325;18576.628467430844;18538.351157709414;19014.71477927832;19214.80785192158;19233.03834808282;19246.133923973455;10525.26323157387;10739.731506712395;10963.122950163968;10983.231173817756;11046;7868.409869259714;8003.159668234985;8028.799280018046;8333.95833020831;8335.124811894906;15791.605209869385;16149.59626009359;16208.918955405148;16383.5084947447;16621.584460388585;15959.361625534848;16661.833381666027;16824.915875420545;16871.831281687028;17081.74377384365;11501.597444089417;11747.765044699228;11782.587609433629;11786.233894796811;11787.11596630239;12686;12928.353582320658;12931.28877911724;13017;13065.542706005244;9854.852177217492;10397.584096636352;10477.16182705397;10590.523426445983;10610.151187905103;9910.950445247727;9928.15610673072;9932.652357167464;10243.38539687621;10418.895811042095;9485.857712134462;9642.951785241028;9682.080202380763;9713.951430243087;9719.222462202866;6615.536912416277;6861.245263021164;7056.54132481387;7201.063861698155;7268.927310726825;7268.200497945328;7272;7294.671739771617;7297.963510182415;7351.264873512606 08:30:31 INFO - PID 3605 | |4;prototype.html;487.2447706055613;506.90875642384367;521.9321488206533;522.1932114882507;532.1830989431223;6079.483243924266;6109.908351374727;6134.417230363119;6138.9999999999945;6195.513076861544;5814.447627475383;5941.494972927307;5961.761529538824;5976.88046239075;5993.610415323012;4812.639052071091;4865.781039853215;4873.610111191105;4898.632602554822;4900.289458028584;4826.541478559531;4842.159979207913;4855.834599696065;4864.197407427788;4896.2410826321975;4805.879853003686;4819.831305904294;4865.927011094836;4882.2432522959;4890.73100979446;4607.792649330771;4690.420268852117;4752.097101550694;4789.233722604401;4809.879753006167;4212.7472351659;4330.696851220416;4342.392065110887;4347.5217726050105;4416.84541041062;5731.770729170828;5808.448197421239;5850.3564607893095;5916.852078698024;5932.2584676915385;5523.337199536041;5534.667919924817;5557.833265002057;5567.2998595681465;5581.972090139523;6249.250089989185;6258.43674069336;6299.307076221612;6302.023186406114;6314.905276420857;4744.193487107165;4745.21703918853;4781.832635857728;4808.3027960945465;4821.421429428491;6638.6680665966505;6641.280882705652;6768.72925083001;6811.625360605214;6841.452683785285;4960.727160006162;4961.181405068195;4967.230079337708;4981.775820088104;5004.724740139254;4984.177610694195;5016.147254966664;5036.571891389273;5037.168867136881;5038.571721403721;5481.75332110056;5565.805196818092;5574.916376254359;5580.358258800209;5608.887822243532;6352.523560732963;6361.936380636134;6381.3937675920715;6393.488520918316;6404.967975160188;1708.7952993139806;1714.9742753858702;1724.499895030427;1724.6809340272089;1744.1889521372623;1134.325076579434;1215.525944881497;1216.9026477881748;1221.0902877356427;1231.802911534168;5466.753996070186;5536.263022459823;5642.943570564324;5679.744411501492;5755.827325180251;6252.374762523711;6411.519136064814;6429.58207716497;6541.672916354163;6588.110605068255;5601.60788744784;5631.4087020863035;5635;5651.971740141273;5690.2033715279895;3414.231797845465;3443.810590417501;3445.4831775233915;3464.272502774395;3512.6838584527004;6309.779157729457;6312.368763123651;6336.6831658416895;6345;6357;6615.6030638161865;6683.164604424447;6683.5989840608745;6684.565503242274;6701.1623547056615;6306.4639505642535;6351.682415879188;6369.617822930639;6388.425041746265;6401.255265669449;6499.545031847914;6533.314002029909;6558.573692709959;6574.408303252731;6587.835304117435;6461.483081353386;6521.543491955707;6553.4101930824545;6564;6571.178602674666;6212.47193988516;6264.624122552661;6342.904856427065;6365.108884756045;6378.425941665087;4779.4742578317055;4848.733319667452;4863.392075990501;4888.682235654671;4889.853304400874;6435.51733619971;6453.774117905851;6461.966085426309;6551.50863685216;6562.475001999733;6363.3000369958345;6369.121348943223;6386.361363863763;6408.7249026596755;6427.421532062137;6346.841328966812;6384.742951907064;6390.552661313849;6396.200474940632;6413.388285250406;6229.50163986889;6294.464970477561;6335.429811317003;6382.968085159545;6384.265809431789;6241.563090583615;6258.374162583706;6300.684965751602;6362;6375.768481031602;5543.25166102571;6048.576599637983;6154.415330543591;6157.076438534255;6183.81448556544 08:30:31 INFO - PID 3605 | |5;yui.html;825.9421840471169;852.1308265569115;903.2503022491333;918.2378625740636;949.0699114867427;17893.463196104123;18395.54011149722;18545.536361590952;18576.907115464437;18771.624567508676;19745.210191592356;21249.681254781153;21255.362339129813;21442.785572144276;21458.356249312546;1014.9441780702058;1045.4459136657545;1045.733337998813;1046.0428707732415;1047.539082803568;1068.839674048891;1072.9946350268237;1074.0280046557878;1074.3929679730966;1076.1821016027836;779.5829231361223;808.8988876390451;809.0574480729972;1051.5951358726907;1099.3074363151204;1079.7300674831292;1086.7011571817734;1087.8531398261252;1089.0634054712941;1090.8036553420382;787.6258777080898;796.6534557467462;797.3740613618281;798.078219656298;798.9161138080534;14623.122612643276;14638;14742.336594853257;14868;15794.289256983464;20070.49823754403;20451.48871278215;20760.169593216255;20834.68747968782;20896;15066;15106;15193.772093418607;15196.316165772567;15200;3410.6759857813468;3462.87879924204;3486.1981744198974;3509;3516.314318707853;109455;110040.4497977513;114000;114347;114929.4253528727;15692;15879;15900;16021.59946001336;16112.516624501284;28115.156545303675;28147.577786333222;29015.41969160605;29156.708432915824;29213.561796573067;7939.245771651684;7986.7603971880935;8007.959960200278;8034.758957231293;8080;3898.2788184186015;4086.346184610448;4113;4175.498940127204;4230.936535951963;4863.975680121647;5047.722375269395;5047.873803154877;5086.804600918781;5110.821121260738;854.3037424499014;886.4193952960821;886.4592598514901;995.6266400099962;1026.3328836256494;690.8307464671087;704.2745971649107;709.8260926073042;720.2653293640458;730.1274976403254;11957.760844783055;12017.819732704016;12231.877681223074;12570.560030398892;12700.174488658207;645.5255387290338;672.9528932974645;694.3750624437945;717.2177139807574;731.3162193349235;5475.342958844884;5570.41510641385;5591.161325801162;5621.353544342372;5631.802886898939;93535;96764;97330.51334743423;98905.50547247217;103351.48324258481;87524;88061.41593598099;88415;90611.54694226486;93615;76655;77097;77106;78222.6088869552;80561.59719201367;10893.727656808644;11054.22620416563;11337.206395552232;11926;12399;32950.34099318048;34893.127671808405;35318.82340588281;36129.819350903075;36776;60218.69890650519;61035.38964610297;61389.69305153624;62435.687821560605;63536;18200.362987295382;18334.633307334047;18606.16272267724;19061.428157155307;19087.141078651774;20405.183792648128;20646.69029964582;20903.268385606432;20987.790122098584;21580.028898699282;17208.483745487654;18313.816861831212;18919.148638311584;19185.52036199106;19216.61566768629;18832.811671883654;19459.8054019458;19618.313359032367;19879.30422435208;20226.59546809026;17575.384861529787;17873.73189402186;17925.551861203574;19181.904090479456;19971.800281996995;12864.356782161041;13018.414171362121;13482.258475783534;13589.45642174302;13852.584422467342;14110.365033573718;14365.425382984982;14379;14402.42390304376;14464.20446875432 08:30:31 INFO - PID 3605 | __end_tp_report 08:30:31 INFO - PID 3605 | __start_cc_report 08:30:31 INFO - PID 3605 | _x_x_mozilla_cycle_collect,370 08:30:31 INFO - PID 3605 | __end_cc_report 08:30:31 INFO - PID 3605 | __startTimestamp1500132631381__endTimestamp 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | ------- Summary: start ------- 08:30:31 INFO - PID 3605 | Number of tests: 6 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#0] dojo.html Cycles:165 Average:6026.36 Median:6284.87 stddev:694.52 (11.1%) stddev-sans-first:656.31 08:30:31 INFO - PID 3605 | Values: 3052.9 3105.0 3125.6 3132.2 3138.9 6030.8 6054.6 6082.4 6084.8 6126.7 6083.3 6111.8 6113.6 6115.1 6117.8 5568.0 5576.1 5609.4 5638.9 5653.5 5567.8 5599.2 5603.6 5605.1 5611.6 5616.2 5617.0 5618.7 5622.5 5642.2 5634.9 5636.6 5650.9 5653.2 5654.2 5527.6 5579.4 5597.8 5616.7 5716.3 6008.6 6070.0 6099.5 6120.0 6126.7 6338.0 6361.4 6438.4 6451.6 6543.7 6450.9 6455.7 6457.6 6468.3 6475.4 6042.3 6049.7 6058.5 6063.3 6070.9 6584.0 6620.0 6738.1 6758.7 6847.3 6328.0 6385.8 6410.4 6502.0 6514.7 6523.6 6544.3 6575.1 6576.0 6601.7 6355.7 6362.8 6404.2 6412.8 6462.6 6417.7 6516.3 6552.0 6555.1 6632.0 5225.3 5299.6 5361.1 5368.5 5388.9 4553.7 4581.2 4594.8 4598.6 4603.3 5662.9 5699.0 5700.4 5708.4 5708.7 6561.2 6566.0 6566.6 6569.7 6571.4 5687.6 5744.4 5757.5 5793.4 5809.5 5723.9 5745.9 5764.8 5784.9 5799.5 6276.3 6294.4 6299.8 6306.8 6314.8 6429.3 6431.4 6464.4 6489.3 6501.8 6241.5 6261.3 6284.9 6418.9 6507.5 6398.3 6430.1 6512.9 6558.3 6559.8 6626.3 6641.3 6665.1 6713.2 6717.9 6311.1 6372.6 6395.1 6402.1 6480.3 6331.3 6332.7 6333.8 6359.6 6401.9 6257.2 6259.2 6304.8 6308.2 6314.2 6475.3 6509.0 6511.1 6546.2 6597.7 6226.3 6261.2 6322.8 6331.9 6332.7 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#1] ext.html Cycles:180 Average:37420.26 Median:34122.90 stddev:53049.31 (155.5%) stddev-sans-first:53126.74 08:30:31 INFO - PID 3605 | Values: 768.9 813.5 836.8 856.4 860.3 41067.8 41614.0 41827.6 41915.4 41987.8 37219.3 37521.4 37817.8 37844.4 37892.8 6873.0 6988.9 6989.4 6990.0 7005.3 6899.0 6932.1 6973.3 6985.1 6988.4 6949.2 6961.0 6964.5 6971.2 6973.0 6857.3 6884.1 6892.0 6894.1 6923.3 6267.6 6312.0 6315.7 6354.9 6360.7 33872.7 34087.8 34108.5 34137.3 34170.8 3400.6 3454.8 3555.3 3622.7 3625.4 31415.0 31558.5 31578.7 31619.4 31621.8 4943.5 4949.0 4974.2 4983.6 5052.4 183433.0 187407.0 188125.0 188397.0 188582.0 42159.0 46935.5 47857.3 48195.0 48227.5 50522.0 50619.5 50684.5 50740.0 50776.0 16535.5 16653.5 16668.9 16678.8 16687.8 13748.9 13795.2 13800.2 13851.8 13892.2 13734.7 13751.1 13769.6 13909.7 13971.2 5626.6 5650.9 5680.0 5708.2 5778.7 977.9 1000.5 1002.2 1014.6 1027.3 22293.1 22606.1 22886.9 22905.3 23208.7 1083.3 1083.9 1121.8 1122.4 1124.3 11949.7 12130.9 12206.9 12234.8 12372.5 219803.0 220293.0 221013.0 221237.0 221578.0 52153.5 52380.0 52538.7 52571.7 53016.7 1439.0 1442.7 1478.2 1495.4 1513.8 22228.6 22282.7 27775.3 28714.4 28884.9 50948.2 51752.0 51919.0 51937.7 52004.7 202915.0 203076.0 203408.0 205436.0 207072.0 31312.8 31727.0 32163.7 34942.0 36882.0 39672.4 43360.6 43365.1 43500.6 43643.6 31525.4 31671.8 32275.5 32385.7 32784.5 31307.4 31908.4 31946.7 32158.5 32544.0 35343.3 35391.6 35500.8 35677.1 35731.3 29548.0 31116.0 31137.4 31391.2 31662.5 23305.0 23306.3 23422.2 23651.9 24088.9 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#2] jquery.html Cycles:180 Average:33454.49 Median:23939.58 stddev:75240.57 (314.3%) stddev-sans-first:75411.10 08:30:31 INFO - PID 3605 | Values: 558.9 568.4 575.0 581.0 602.8 22113.7 22707.4 23058.8 23087.0 23189.9 27134.6 27506.0 27578.2 27654.4 27660.2 6540.7 6717.6 6719.6 6720.9 6732.5 5575.9 6249.0 6598.5 6680.6 6718.8 6494.8 6557.2 6566.1 6570.9 6577.7 6512.3 6516.4 6517.6 6520.1 6520.7 6071.5 6108.6 6114.1 6131.4 6131.7 27658.9 29569.9 29659.4 30170.4 30250.5 1916.6 1953.7 1960.0 1960.2 1965.3 18878.7 19342.3 19345.7 19465.0 19575.8 2355.1 2367.1 2430.0 2434.7 2437.3 135727.3 138487.3 139532.0 140076.0 140076.3 14256.9 15347.0 15571.5 15797.7 15988.9 23928.5 23950.6 24060.5 24075.9 24234.4 9794.0 9857.6 9892.2 9898.7 10028.1 9022.4 9024.1 9026.7 9063.6 9119.3 9115.9 9429.0 9572.8 9658.3 9751.4 2769.2 2782.2 2789.8 2808.8 2828.7 950.6 955.4 959.6 979.8 992.9 19741.6 19980.5 20065.7 20369.5 20569.1 996.7 1000.7 1037.3 1043.4 1051.1 10831.6 11001.4 11074.3 11343.9 11407.8 414119.0 438835.0 444857.0 454013.0 458966.0 110330.0 114310.4 115325.0 115916.4 116367.4 1202.7 1213.8 1235.9 1240.9 1245.1 17032.5 17598.9 17617.4 18455.2 18702.7 50182.0 55262.7 55394.0 57385.4 57742.4 68383.7 68999.7 69491.3 70011.6 70165.3 12423.9 14668.8 14735.5 14899.4 14900.6 16345.2 21656.2 23702.8 24011.2 24294.5 18708.9 18761.0 18889.2 18963.2 19109.3 16316.3 16565.9 17201.5 17239.7 17661.9 19190.0 19404.1 19506.2 19527.2 19834.9 14540.7 14678.6 14711.1 14733.9 14761.9 18399.1 18489.3 18716.4 18725.5 18797.3 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#3] mootools.html Cycles:180 Average:8610.45 Median:2608.53 stddev:5765.19 (221.0%) stddev-sans-first:5754.97 08:30:31 INFO - PID 3605 | Values: 1269.3 1309.3 1324.6 1333.8 1338.1 13488.3 14091.2 14094.9 14111.7 14154.6 13706.5 14049.4 14082.2 14152.4 14220.1 2566.3 2626.1 2636.4 2648.1 2652.1 2576.1 2635.2 2640.0 2641.3 2645.8 2512.3 2592.9 2607.0 2631.3 2639.8 2571.5 2695.2 2709.4 2716.1 2720.0 2578.5 2579.7 2610.1 2613.9 2622.9 13350.3 13687.3 13717.2 13719.4 13745.6 7348.9 7597.8 7612.2 7613.5 7619.4 4811.6 4996.2 5094.7 5095.4 5097.2 1738.6 1752.0 1754.7 1801.6 1831.7 22237.6 22404.9 22405.9 22447.8 22504.4 6275.8 6314.4 6373.8 6485.2 6529.8 15664.0 15699.9 15702.9 15725.1 15750.3 7351.1 7480.3 7487.5 7491.2 7491.9 6837.0 6849.5 6949.2 6976.8 7019.4 4837.3 5005.5 5087.6 5108.6 5173.3 1466.3 1477.6 1481.7 1506.8 1509.7 825.5 838.9 842.5 868.6 869.9 8348.0 8649.6 8700.0 8742.0 8814.6 949.5 959.2 984.7 1001.9 1010.6 5049.9 5307.0 5389.2 5395.3 5489.6 17758.8 17954.0 18547.2 18559.4 18576.6 18538.4 19014.7 19214.8 19233.0 19246.1 10525.3 10739.7 10963.1 10983.2 11046.0 7868.4 8003.2 8028.8 8334.0 8335.1 15791.6 16149.6 16208.9 16383.5 16621.6 15959.4 16661.8 16824.9 16871.8 17081.7 11501.6 11747.8 11782.6 11786.2 11787.1 12686.0 12928.4 12931.3 13017.0 13065.5 9854.9 10397.6 10477.2 10590.5 10610.2 9911.0 9928.2 9932.7 10243.4 10418.9 9485.9 9643.0 9682.1 9714.0 9719.2 6615.5 6861.2 7056.5 7201.1 7268.9 7268.2 7272.0 7294.7 7298.0 7351.3 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#4] prototype.html Cycles:180 Average:5361.03 Median:5924.56 stddev:1496.93 (25.3%) stddev-sans-first:1455.74 08:30:31 INFO - PID 3605 | Values: 487.2 506.9 521.9 522.2 532.2 6079.5 6109.9 6134.4 6139.0 6195.5 5814.4 5941.5 5961.8 5976.9 5993.6 4812.6 4865.8 4873.6 4898.6 4900.3 4826.5 4842.2 4855.8 4864.2 4896.2 4805.9 4819.8 4865.9 4882.2 4890.7 4607.8 4690.4 4752.1 4789.2 4809.9 4212.7 4330.7 4342.4 4347.5 4416.8 5731.8 5808.4 5850.4 5916.9 5932.3 5523.3 5534.7 5557.8 5567.3 5582.0 6249.3 6258.4 6299.3 6302.0 6314.9 4744.2 4745.2 4781.8 4808.3 4821.4 6638.7 6641.3 6768.7 6811.6 6841.5 4960.7 4961.2 4967.2 4981.8 5004.7 4984.2 5016.1 5036.6 5037.2 5038.6 5481.8 5565.8 5574.9 5580.4 5608.9 6352.5 6361.9 6381.4 6393.5 6405.0 1708.8 1715.0 1724.5 1724.7 1744.2 1134.3 1215.5 1216.9 1221.1 1231.8 5466.8 5536.3 5642.9 5679.7 5755.8 6252.4 6411.5 6429.6 6541.7 6588.1 5601.6 5631.4 5635.0 5652.0 5690.2 3414.2 3443.8 3445.5 3464.3 3512.7 6309.8 6312.4 6336.7 6345.0 6357.0 6615.6 6683.2 6683.6 6684.6 6701.2 6306.5 6351.7 6369.6 6388.4 6401.3 6499.5 6533.3 6558.6 6574.4 6587.8 6461.5 6521.5 6553.4 6564.0 6571.2 6212.5 6264.6 6342.9 6365.1 6378.4 4779.5 4848.7 4863.4 4888.7 4889.9 6435.5 6453.8 6462.0 6551.5 6562.5 6363.3 6369.1 6386.4 6408.7 6427.4 6346.8 6384.7 6390.6 6396.2 6413.4 6229.5 6294.5 6335.4 6383.0 6384.3 6241.6 6258.4 6300.7 6362.0 6375.8 5543.3 6048.6 6154.4 6157.1 6183.8 08:30:31 INFO - PID 3605 | 08:30:31 INFO - PID 3605 | [#5] yui.html Cycles:180 Average:21998.25 Median:20865.34 stddev:28683.89 (137.5%) stddev-sans-first:28720.30 08:30:31 INFO - PID 3605 | Values: 825.9 852.1 903.3 918.2 949.1 17893.5 18395.5 18545.5 18576.9 18771.6 19745.2 21249.7 21255.4 21442.8 21458.4 1014.9 1045.4 1045.7 1046.0 1047.5 1068.8 1073.0 1074.0 1074.4 1076.2 779.6 808.9 809.1 1051.6 1099.3 1079.7 1086.7 1087.9 1089.1 1090.8 787.6 796.7 797.4 798.1 798.9 14623.1 14638.0 14742.3 14868.0 15794.3 20070.5 20451.5 20760.2 20834.7 20896.0 15066.0 15106.0 15193.8 15196.3 15200.0 3410.7 3462.9 3486.2 3509.0 3516.3 109455.0 110040.4 114000.0 114347.0 114929.4 15692.0 15879.0 15900.0 16021.6 16112.5 28115.2 28147.6 29015.4 29156.7 29213.6 7939.2 7986.8 8008.0 8034.8 8080.0 3898.3 4086.3 4113.0 4175.5 4230.9 4864.0 5047.7 5047.9 5086.8 5110.8 854.3 886.4 886.5 995.6 1026.3 690.8 704.3 709.8 720.3 730.1 11957.8 12017.8 12231.9 12570.6 12700.2 645.5 673.0 694.4 717.2 731.3 5475.3 5570.4 5591.2 5621.4 5631.8 93535.0 96764.0 97330.5 98905.5 103351.5 87524.0 88061.4 88415.0 90611.5 93615.0 76655.0 77097.0 77106.0 78222.6 80561.6 10893.7 11054.2 11337.2 11926.0 12399.0 32950.3 34893.1 35318.8 36129.8 36776.0 60218.7 61035.4 61389.7 62435.7 63536.0 18200.4 18334.6 18606.2 19061.4 19087.1 20405.2 20646.7 20903.3 20987.8 21580.0 17208.5 18313.8 18919.1 19185.5 19216.6 18832.8 19459.8 19618.3 19879.3 20226.6 17575.4 17873.7 17925.6 19181.9 19971.8 12864.4 13018.4 13482.3 13589.5 13852.6 14110.4 14365.4 14379.0 14402.4 14464.2 08:30:31 INFO - PID 3605 | -------- Summary: end -------- 08:30:31 INFO - PID 3605 | 08:30:31 INFO - TEST-INFO | 3605: exit 0 08:30:32 INFO - TEST-OK | dromaeo_css | took 1115334ms 08:30:32 INFO - TEST-START | kraken 08:30:32 INFO - Initialising browser for kraken test... 08:30:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44569/getInfo.html -profile /tmp/tmpdLz4mn/profile 08:30:32 INFO - TEST-INFO | started process 4025 (/builds/slave/test/build/application/firefox/firefox http://localhost:44569/getInfo.html) 08:30:39 INFO - TEST-INFO | 4025: exit 0 08:30:39 INFO - Browser initialized. 08:30:39 INFO - Running cycle 1/1 for kraken test... 08:30:39 INFO - TEST-INFO | started process 4249 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdLz4mn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:50 INFO - PID 4249 | RSS: Main: 170733568 08:30:50 INFO - PID 4249 | 08:30:53 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44569/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:54 INFO - PID 4249 | RSS: Main: 177213440 08:30:54 INFO - PID 4249 | 08:30:56 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44569/tests/kraken/driver.html?testName=audio-dft) 08:30:57 INFO - PID 4249 | RSS: Main: 177262592 08:30:57 INFO - PID 4249 | 08:31:00 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44569/tests/kraken/driver.html?testName=audio-fft) 08:31:00 INFO - PID 4249 | RSS: Main: 170864640 08:31:00 INFO - PID 4249 | 08:31:02 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44569/tests/kraken/driver.html?testName=audio-oscillator) 08:31:03 INFO - PID 4249 | RSS: Main: 172154880 08:31:03 INFO - PID 4249 | 08:31:05 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:06 INFO - PID 4249 | RSS: Main: 172027904 08:31:06 INFO - PID 4249 | 08:31:09 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44569/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:09 INFO - PID 4249 | RSS: Main: 176164864 08:31:09 INFO - PID 4249 | 08:31:13 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44569/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:13 INFO - PID 4249 | RSS: Main: 176926720 08:31:13 INFO - PID 4249 | 08:31:16 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44569/tests/kraken/driver.html?testName=json-parse-financial) 08:31:17 INFO - PID 4249 | RSS: Main: 176824320 08:31:17 INFO - PID 4249 | 08:31:18 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:19 INFO - PID 4249 | RSS: Main: 176066560 08:31:19 INFO - PID 4249 | 08:31:21 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:21 INFO - PID 4249 | RSS: Main: 175906816 08:31:21 INFO - PID 4249 | 08:31:23 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:24 INFO - PID 4249 | RSS: Main: 176025600 08:31:24 INFO - PID 4249 | 08:31:27 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:28 INFO - PID 4249 | RSS: Main: 175804416 08:31:28 INFO - PID 4249 | 08:31:31 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:31 INFO - PID 4249 | RSS: Main: 176091136 08:31:31 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | Cycle 1(1): loaded http://localhost:44569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44569/tests/kraken/driver.html?testName=ai-astar) 08:31:33 INFO - PID 4249 | RSS: Main: 177586176 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | __start_tp_report 08:31:33 INFO - PID 4249 | _x_x_mozilla_page_load 08:31:33 INFO - PID 4249 | _x_x_mozilla_page_load_details 08:31:33 INFO - PID 4249 | |i|pagename|runs| 08:31:33 INFO - PID 4249 | |0;ai-astar;101;112;109;107;108;108;108;108;109;109 08:31:33 INFO - PID 4249 | |1;audio-beat-detection;151;129;145;167;123;157;144;125;173;121 08:31:33 INFO - PID 4249 | |2;audio-dft;163;160;164;161;162;172;163;164;164;167 08:31:33 INFO - PID 4249 | |3;audio-fft;75;75;75;166;78;77;74;74;99;75 08:31:33 INFO - PID 4249 | |4;audio-oscillator;82;83;162;81;81;82;135;80;82;130 08:31:33 INFO - PID 4249 | |5;imaging-gaussian-blur;114;113;114;114;114;114;113;113;114;114 08:31:33 INFO - PID 4249 | |6;imaging-darkroom;150;150;149;149;149;150;149;149;149;149 08:31:33 INFO - PID 4249 | |7;imaging-desaturate;95;94;94;95;94;94;94;94;94;93 08:31:33 INFO - PID 4249 | |8;json-parse-financial;54;54;55;54;54;56;54;57;54;59 08:31:33 INFO - PID 4249 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;55;54;53 08:31:33 INFO - PID 4249 | |10;stanford-crypto-aes;81;77;79;85;77;78;84;79;76;77 08:31:33 INFO - PID 4249 | |11;stanford-crypto-ccm;129;127;141;129;127;141;125;136;132;169 08:31:33 INFO - PID 4249 | |12;stanford-crypto-pbkdf2;190;187;186;182;183;184;183;190;183;198 08:31:33 INFO - PID 4249 | |13;stanford-crypto-sha256-iterative;70;69;71;74;71;73;69;72;76;69 08:31:33 INFO - PID 4249 | __end_tp_report 08:31:33 INFO - PID 4249 | __start_cc_report 08:31:33 INFO - PID 4249 | _x_x_mozilla_cycle_collect,970 08:31:33 INFO - PID 4249 | __end_cc_report 08:31:33 INFO - PID 4249 | __startTimestamp1500132693766__endTimestamp 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | ------- Summary: start ------- 08:31:33 INFO - PID 4249 | Number of tests: 14 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#0] ai-astar Cycles:10 Average:107.90 Median:108.50 stddev:2.77 (2.6%) stddev-sans-first:1.41 08:31:33 INFO - PID 4249 | Values: 101.0 112.0 109.0 107.0 108.0 108.0 108.0 108.0 109.0 109.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:148.00 stddev:18.69 (12.6%) stddev-sans-first:19.62 08:31:33 INFO - PID 4249 | Values: 151.0 129.0 145.0 167.0 123.0 157.0 144.0 125.0 173.0 121.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:3.40 (2.1%) stddev-sans-first:3.59 08:31:33 INFO - PID 4249 | Values: 163.0 160.0 164.0 161.0 162.0 172.0 163.0 164.0 164.0 167.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#3] audio-fft Cycles:10 Average:86.80 Median:75.00 stddev:28.83 (38.4%) stddev-sans-first:30.26 08:31:33 INFO - PID 4249 | Values: 75.0 75.0 75.0 166.0 78.0 77.0 74.0 74.0 99.0 75.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#4] audio-oscillator Cycles:10 Average:99.80 Median:81.50 stddev:30.46 (37.4%) stddev-sans-first:31.62 08:31:33 INFO - PID 4249 | Values: 82.0 83.0 162.0 81.0 81.0 82.0 135.0 80.0 82.0 130.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:31:33 INFO - PID 4249 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 113.0 113.0 114.0 114.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:31:33 INFO - PID 4249 | Values: 150.0 150.0 149.0 149.0 149.0 150.0 149.0 149.0 149.0 149.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:31:33 INFO - PID 4249 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 94.0 93.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.50 stddev:1.73 (3.2%) stddev-sans-first:1.79 08:31:33 INFO - PID 4249 | Values: 54.0 54.0 55.0 54.0 54.0 56.0 54.0 57.0 54.0 59.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 08:31:33 INFO - PID 4249 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 53.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:79.00 stddev:3.09 (3.9%) stddev-sans-first:3.22 08:31:33 INFO - PID 4249 | Values: 81.0 77.0 79.0 85.0 77.0 78.0 84.0 79.0 76.0 77.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#11] stanford-crypto-ccm Cycles:10 Average:135.60 Median:134.00 stddev:13.06 (9.7%) stddev-sans-first:13.63 08:31:33 INFO - PID 4249 | Values: 129.0 127.0 141.0 129.0 127.0 141.0 125.0 136.0 132.0 169.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:186.50 stddev:4.95 (2.7%) stddev-sans-first:5.09 08:31:33 INFO - PID 4249 | Values: 190.0 187.0 186.0 182.0 183.0 184.0 183.0 190.0 183.0 198.0 08:31:33 INFO - PID 4249 | 08:31:33 INFO - PID 4249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:2.37 (3.3%) stddev-sans-first:2.46 08:31:33 INFO - PID 4249 | Values: 70.0 69.0 71.0 74.0 71.0 73.0 69.0 72.0 76.0 69.0 08:31:33 INFO - PID 4249 | -------- Summary: end -------- 08:31:33 INFO - PID 4249 | 08:31:34 INFO - PID 4249 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:31:34 INFO - TEST-INFO | 4249: exit 0 08:31:34 INFO - TEST-OK | kraken | took 62566ms 08:31:34 INFO - SUITE-END | took 1177s 08:31:34 INFO - Completed test suite (00:19:38) 08:31:34 INFO - javascript benchmark 08:31:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8322.780410342333, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.8931487397945, 3105.037438394098, 3125.6092988376454, 3132.216945763559, 3138.890138845141, 6030.849228769277, 6054.576179667425, 6082.391760823915, 6084.847878803038, 6126.724297406617, 6083.270007599083, 6111.755529778803, 6113.633182009072, 6115.052166914135, 6117.755289788403, 5568.025595520788, 5576.079946808782, 5609.35492418371, 5638.943610563882, 5653.4911857932775, 5567.777288908439, 5599.188117722928, 5603.60774745768, 5605.103183490643, 5611.579131565129, 5616.185653080301, 5617.045102332593, 5618.662880227179, 5622.4939755422, 5642.238297829802, 5634.85912852182, 5636.605437619368, 5650.915236271459, 5653.1520271959125, 5654.151877218409, 5527.585431092684, 5579.414161513064, 5597.776088956437, 5616.719164041781, 5716.256886604757, 6008.579399442041, 6069.969650151766, 6099.542534309944, 6119.969400152971, 6126.663033533154, 6338.0, 6361.395667411589, 6438.420542151229, 6451.580647257913, 6543.672816359163, 6450.870982580323, 6455.709493072776, 6457.580257283308, 6468.288488266334, 6475.384838440341, 6042.305134909498, 6049.667268300242, 6058.454739073461, 6063.333033366326, 6070.939290607082, 6584.045313429574, 6620.040094186316, 6738.124043874265, 6758.695858686371, 6847.281035491202, 6328.0, 6385.840353991188, 6410.391012853772, 6502.0, 6514.706838192293, 6523.64119973406, 6544.280129185786, 6575.079488871562, 6575.967120164369, 6601.73593056282, 6355.682215889279, 6362.77730279438, 6404.199475065617, 6412.807615771534, 6462.579932304385, 6417.679116044179, 6516.283208847023, 6552.049952756824, 6555.1478307820635, 6632.0383544385795, 5225.320708307896, 5299.629025968223, 5361.0618141825025, 5368.5436737876935, 5388.892222155613, 4553.749543775058, 4581.244094724333, 4594.839180628662, 4598.586127248497, 4603.263477843529, 5662.943370566324, 5699.031164701928, 5700.372958974593, 5708.40061793514, 5708.743106560215, 6561.212654481493, 6565.967170164118, 6566.638834864033, 6569.67151642416, 6571.408573228432, 5687.573431992617, 5744.425557444306, 5757.539396848326, 5793.391693872167, 5809.477147056785, 5723.942760572424, 5745.85635359111, 5764.769409223668, 5784.913226301609, 5799.536037117021, 6276.340984196594, 6294.433500984934, 6299.842503937438, 6306.779262725782, 6314.842128946813, 6429.324920883427, 6431.421172094534, 6464.353564643498, 6489.253735820441, 6501.837454063497, 6241.500679945502, 6261.3112557617715, 6284.874302513833, 6418.871622567429, 6507.544471886922, 6398.264199617103, 6430.1319321892815, 6512.934870651233, 6558.311377305315, 6559.770408035696, 6626.337366263335, 6641.26946035926, 6665.100211471583, 6713.194416669836, 6717.899231511434, 6311.116443697794, 6372.58578192416, 6395.136656551306, 6402.135711678864, 6480.287168411565, 6331.303556608677, 6332.746690132343, 6333.809985700436, 6359.618422894641, 6401.8719625608155, 6257.2491301044165, 6259.2488901332135, 6304.779332723333, 6308.179936608211, 6314.242290925118, 6475.3200913903365, 6509.0, 6511.120998665119, 6546.24718157418, 6597.670116494252, 6226.346233645402, 6261.217347831521, 6322.778702745381, 6331.90502142459, 6332.715027823851], "value": 5975.174236146426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.9269519395656, 813.5403497024184, 836.778253762753, 856.3662889461797, 860.3031544448995, 41067.79466102669, 41614.0, 41827.581724182746, 41915.37126943091, 41987.79006104969, 37219.25561488768, 37521.43717844234, 37817.810910945474, 37844.43233351495, 37892.81053594728, 6873.0, 6988.895166572505, 6989.4408447324095, 6989.965050174767, 7005.299470053005, 6898.965505172467, 6932.098827152488, 6973.302669733037, 6985.091938048072, 6988.4409247260355, 6949.20084190317, 6961.025456436103, 6964.547304425221, 6971.163460384761, 6973.0, 6857.348551887562, 6884.070650462174, 6891.965540172318, 6894.13823272091, 6923.342282483156, 6267.561270711007, 6311.96844015777, 6315.684215789192, 6354.872902541923, 6360.681965901686, 33872.661273387195, 34087.82956085228, 34108.48837267443, 34137.317253655034, 34170.82914585411, 3400.608929973035, 3454.792712437237, 3555.253396786678, 3622.728295377857, 3625.401808701561, 31415.0, 31558.526622100686, 31578.684213157805, 31619.36761264785, 31621.841890790627, 4943.480934501861, 4948.975255123737, 4974.204127339608, 4983.576396006344, 5052.4189718182515, 183433.0, 187407.0, 188125.0, 188397.0, 188582.0, 42159.0, 46935.5306446938, 47857.282140767216, 48195.0, 48227.517724823, 50522.0, 50619.493805062215, 50684.493155067976, 50740.0, 50776.0, 16535.503934881974, 16653.50039498817, 16668.916655416644, 16678.833211667727, 16687.83312166887, 13748.93125534366, 13795.172289662452, 13800.171989680652, 13851.792223116661, 13892.235927023909, 13734.65663358424, 13751.106178098391, 13769.586912392644, 13909.721805563831, 13971.231582263074, 5626.578006649518, 5650.886982260332, 5680.0, 5708.229389032511, 5778.653280803165, 977.9315447918719, 1000.479750529735, 1002.1832206751474, 1014.5840205515851, 1027.275770581738, 22293.108275669118, 22606.09575616957, 22886.8855655724, 22905.312840614475, 23208.651870221962, 1083.3175099687146, 1083.869935607732, 1121.8036843552345, 1122.405125283601, 1124.3478782306242, 11949.701257468632, 12130.939345303394, 12206.877931220752, 12234.75530489403, 12372.505099795908, 219803.0, 220293.0, 221013.0, 221237.0, 221578.0, 52153.47846521486, 52380.0, 52538.73730631399, 52571.73714131405, 53016.73491632594, 1438.9640258993818, 1442.7186698593882, 1478.2460944918168, 1495.3719437836135, 1513.7956375889114, 22228.55542889101, 22282.665760013937, 27775.30561735973, 28714.42571148607, 28884.855575721987, 50948.23577646264, 51752.0, 51919.0, 51937.7403112982, 52004.739976299876, 202915.0, 203076.0, 203408.0, 205436.0, 207072.0, 31312.843435782674, 31727.0, 32163.678363217005, 34942.0, 36882.0, 39672.40491392689, 43360.566394335656, 43365.132697346504, 43500.564994349654, 43643.56356436395, 31525.369492610476, 31671.84164079165, 32275.51586726154, 32385.67614323921, 32784.50823237701, 31307.373852523277, 31908.36183276368, 31946.68053319437, 32158.51762223615, 32544.0, 35343.29313413666, 35391.646083538835, 35500.822495887354, 35677.108072297364, 35731.285374292886, 29548.0, 31116.0, 31137.377252455277, 31391.21521961969, 31662.525062123626, 23305.0, 23306.3008109757, 23422.18022369209, 23651.881740591187, 24088.87955560211], "value": 16899.402882522118, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9217509548662, 568.3520786303615, 574.9941857300498, 580.9941900580993, 602.8010756450371, 22113.668294975567, 22707.432314192112, 23058.76941230587, 23087.0, 23189.884050579723, 27134.5929811053, 27506.0, 27578.172654820337, 27654.44691106177, 27660.170194894134, 6540.705668244928, 6717.63053032083, 6719.596824190564, 6720.865582688368, 6732.461403087766, 5575.916361254584, 6248.968755156217, 6598.538102332838, 6680.599164050148, 6718.764843230488, 6494.772682956098, 6557.245916719567, 6566.113574667406, 6570.934290657104, 6577.736890524373, 6512.283648798629, 6516.446102081329, 6517.608943463408, 6520.119783829194, 6520.67396630169, 6071.544634152457, 6108.602940808878, 6114.144019837227, 6131.41751533608, 6131.662758548278, 27658.861705691543, 29569.852150739323, 29659.406811863857, 30170.396592068035, 30250.54624180639, 1916.60709554541, 1953.667876461005, 1960.0199900049975, 1960.2159136345433, 1965.282671824788, 18878.716819247722, 19342.32301869428, 19345.709814352795, 19465.0, 19575.80424195754, 2355.0697474497647, 2367.147826782357, 2429.963550546743, 2434.6713193718797, 2437.2566367257978, 135727.32136339354, 138487.30756346256, 139532.0, 140076.0, 140076.29961850125, 14256.928715356356, 15347.0, 15571.532854014398, 15797.684046319238, 15988.920055399882, 23928.521429571312, 23950.64074038891, 24060.518789624108, 24075.879620601783, 24234.394140146636, 9793.951030244945, 9857.55640996157, 9892.15916647093, 9898.653547125816, 10028.097471227478, 9022.368434209542, 9024.052474490216, 9026.684066057787, 9063.637454501746, 9119.270458363315, 9115.863262051074, 9428.952855235817, 9572.808543829224, 9658.275629327689, 9751.414915105117, 2769.1969328894797, 2782.1653503949137, 2789.8047136700643, 2808.845513496777, 2828.717128287155, 950.5627411390699, 955.350361754014, 959.6449313753956, 979.7893452907516, 992.8609994600762, 19741.60516789685, 19980.50048748793, 20065.699014514794, 20369.490762730755, 20569.07439165241, 996.7091670359029, 1000.7047920863363, 1037.3412882819464, 1043.3739756146251, 1051.1380667852288, 10831.566737330577, 11001.449927503592, 11074.335539867634, 11343.886561134448, 11407.771844563062, 414119.0, 438835.0, 444857.0, 454013.0, 458966.0, 110330.0, 114310.42844785722, 115325.0, 115916.42041789737, 116367.41816290864, 1202.6897401313645, 1213.7572485502935, 1235.8764123587569, 1240.8697086805937, 1245.1408528115571, 17032.48902532926, 17598.94406335624, 17617.383391581745, 18455.169517371483, 18702.719459207852, 50182.0, 55262.72368638131, 55394.0, 57385.426145738005, 57742.42257577371, 68383.65808170928, 68999.65500172468, 69491.30508694849, 70011.64994174996, 70165.29834701588, 12423.937880310541, 14668.77996830027, 14735.484258050918, 14899.404023838924, 14900.62748431298, 16345.159921100692, 21656.242031528822, 23702.762972370747, 24011.159609413586, 24294.51410971806, 18708.906455467637, 18761.0, 18889.244430222636, 18963.241470341032, 19109.331173408864, 16316.265768040705, 16565.91717041407, 17201.483955481355, 17239.7414038787, 17661.91169044198, 19190.0, 19404.126814293108, 19506.21975121036, 19527.21891124396, 19834.90082549578, 14540.709185816013, 14678.63303417423, 14711.117332960057, 14733.852661473247, 14761.852381476478, 18399.080045997915, 18489.260429583202, 18716.438506844817, 18725.531861703566, 18797.34209302668], "value": 11983.87429831414, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.2638269803513, 1309.3060677840747, 1324.6489680234733, 1333.8399392072947, 1338.0900987328616, 13488.32558372081, 14091.224982625952, 14094.929525352372, 14111.71776564468, 14154.575362739108, 13706.45174193031, 14049.438022479115, 14082.225477598728, 14152.433902643881, 14220.075695079813, 2566.2686134451733, 2626.080871694901, 2636.446346267286, 2648.1261183809297, 2652.124798816386, 2576.059738195564, 2635.235781623327, 2640.0, 2641.273649746316, 2645.7751091157274, 2512.321673148249, 2592.8833202505934, 2607.0, 2631.302704783234, 2639.828411153269, 2571.4728480661515, 2695.191442567222, 2709.376843326026, 2716.1172618898936, 2720.0479832058622, 2578.548753968048, 2579.703334116582, 2610.0603782638236, 2613.9215823525324, 2622.8819703113213, 13350.26573538455, 13687.31563421825, 13717.17696938187, 13719.382627781773, 13745.587632371045, 7348.889766653505, 7597.848043039164, 7612.200718924489, 7613.505122167041, 7619.390448764086, 4811.639127065449, 4996.1756310208775, 5094.694318340874, 5095.388553373582, 5097.23541468779, 1738.5653586603348, 1751.9912400437915, 1754.6753850537564, 1801.5766294920684, 1831.6702993461172, 22237.555248895093, 22404.887975560017, 22405.887970560205, 22447.775522244894, 22504.437389065242, 6275.780347687809, 6314.368563143741, 6373.776917807947, 6485.156929599217, 6529.771457998947, 15664.0, 15699.921500392426, 15702.9214853925, 15725.056496610012, 15750.291236894367, 7351.081114860643, 7480.251974802476, 7487.513311634726, 7491.213422590658, 7491.887621685679, 6837.042814006043, 6849.48628852838, 6949.235584085746, 6976.825579360557, 7019.368256856806, 4837.346958160603, 5005.474425185376, 5087.643864929493, 5108.565771909355, 5173.327467429285, 1466.288849907794, 1477.6084337650532, 1481.7258807120502, 1506.841781612915, 1509.682966577031, 825.5459497276474, 838.932885369169, 842.4902933725131, 868.639514601446, 869.8825658536143, 8347.958260208781, 8649.610767515476, 8699.956500217459, 8741.950965884007, 8814.603342849587, 949.5015117063597, 959.2278216036158, 984.7439665686829, 1001.8998100189923, 1010.6109147978082, 5049.9395127023, 5306.97346513265, 5389.191621256765, 5395.2986111806, 5489.58828087895, 17758.822411775716, 17954.0, 18547.16537755804, 18559.44321670325, 18576.628467430844, 18538.351157709414, 19014.71477927832, 19214.80785192158, 19233.03834808282, 19246.133923973455, 10525.26323157387, 10739.731506712395, 10963.122950163968, 10983.231173817756, 11046.0, 7868.409869259714, 8003.159668234985, 8028.799280018046, 8333.95833020831, 8335.124811894906, 15791.605209869385, 16149.59626009359, 16208.918955405148, 16383.5084947447, 16621.584460388585, 15959.361625534848, 16661.833381666027, 16824.915875420545, 16871.831281687028, 17081.74377384365, 11501.597444089417, 11747.765044699228, 11782.587609433629, 11786.233894796811, 11787.11596630239, 12686.0, 12928.353582320658, 12931.28877911724, 13017.0, 13065.542706005244, 9854.852177217492, 10397.584096636352, 10477.16182705397, 10590.523426445983, 10610.151187905103, 9910.950445247727, 9928.15610673072, 9932.652357167464, 10243.38539687621, 10418.895811042095, 9485.857712134462, 9642.951785241028, 9682.080202380763, 9713.951430243087, 9719.222462202866, 6615.536912416277, 6861.245263021164, 7056.54132481387, 7201.063861698155, 7268.927310726825, 7268.200497945328, 7272.0, 7294.671739771617, 7297.963510182415, 7351.264873512606], "value": 6314.1590664364785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.2447706055613, 506.90875642384367, 521.9321488206533, 522.1932114882507, 532.1830989431223, 6079.483243924266, 6109.908351374727, 6134.417230363119, 6138.9999999999945, 6195.513076861544, 5814.447627475383, 5941.494972927307, 5961.761529538824, 5976.88046239075, 5993.610415323012, 4812.639052071091, 4865.781039853215, 4873.610111191105, 4898.632602554822, 4900.289458028584, 4826.541478559531, 4842.159979207913, 4855.834599696065, 4864.197407427788, 4896.2410826321975, 4805.879853003686, 4819.831305904294, 4865.927011094836, 4882.2432522959, 4890.73100979446, 4607.792649330771, 4690.420268852117, 4752.097101550694, 4789.233722604401, 4809.879753006167, 4212.7472351659, 4330.696851220416, 4342.392065110887, 4347.5217726050105, 4416.84541041062, 5731.770729170828, 5808.448197421239, 5850.3564607893095, 5916.852078698024, 5932.2584676915385, 5523.337199536041, 5534.667919924817, 5557.833265002057, 5567.2998595681465, 5581.972090139523, 6249.250089989185, 6258.43674069336, 6299.307076221612, 6302.023186406114, 6314.905276420857, 4744.193487107165, 4745.21703918853, 4781.832635857728, 4808.3027960945465, 4821.421429428491, 6638.6680665966505, 6641.280882705652, 6768.72925083001, 6811.625360605214, 6841.452683785285, 4960.727160006162, 4961.181405068195, 4967.230079337708, 4981.775820088104, 5004.724740139254, 4984.177610694195, 5016.147254966664, 5036.571891389273, 5037.168867136881, 5038.571721403721, 5481.75332110056, 5565.805196818092, 5574.916376254359, 5580.358258800209, 5608.887822243532, 6352.523560732963, 6361.936380636134, 6381.3937675920715, 6393.488520918316, 6404.967975160188, 1708.7952993139806, 1714.9742753858702, 1724.499895030427, 1724.6809340272089, 1744.1889521372623, 1134.325076579434, 1215.525944881497, 1216.9026477881748, 1221.0902877356427, 1231.802911534168, 5466.753996070186, 5536.263022459823, 5642.943570564324, 5679.744411501492, 5755.827325180251, 6252.374762523711, 6411.519136064814, 6429.58207716497, 6541.672916354163, 6588.110605068255, 5601.60788744784, 5631.4087020863035, 5635.0, 5651.971740141273, 5690.2033715279895, 3414.231797845465, 3443.810590417501, 3445.4831775233915, 3464.272502774395, 3512.6838584527004, 6309.779157729457, 6312.368763123651, 6336.6831658416895, 6345.0, 6357.0, 6615.6030638161865, 6683.164604424447, 6683.5989840608745, 6684.565503242274, 6701.1623547056615, 6306.4639505642535, 6351.682415879188, 6369.617822930639, 6388.425041746265, 6401.255265669449, 6499.545031847914, 6533.314002029909, 6558.573692709959, 6574.408303252731, 6587.835304117435, 6461.483081353386, 6521.543491955707, 6553.4101930824545, 6564.0, 6571.178602674666, 6212.47193988516, 6264.624122552661, 6342.904856427065, 6365.108884756045, 6378.425941665087, 4779.4742578317055, 4848.733319667452, 4863.392075990501, 4888.682235654671, 4889.853304400874, 6435.51733619971, 6453.774117905851, 6461.966085426309, 6551.50863685216, 6562.475001999733, 6363.3000369958345, 6369.121348943223, 6386.361363863763, 6408.7249026596755, 6427.421532062137, 6346.841328966812, 6384.742951907064, 6390.552661313849, 6396.200474940632, 6413.388285250406, 6229.50163986889, 6294.464970477561, 6335.429811317003, 6382.968085159545, 6384.265809431789, 6241.563090583615, 6258.374162583706, 6300.684965751602, 6362.0, 6375.768481031602, 5543.25166102571, 6048.576599637983, 6154.415330543591, 6157.076438534255, 6183.81448556544], "value": 4925.030928078534, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [825.9421840471169, 852.1308265569115, 903.2503022491333, 918.2378625740636, 949.0699114867427, 17893.463196104123, 18395.54011149722, 18545.536361590952, 18576.907115464437, 18771.624567508676, 19745.210191592356, 21249.681254781153, 21255.362339129813, 21442.785572144276, 21458.356249312546, 1014.9441780702058, 1045.4459136657545, 1045.733337998813, 1046.0428707732415, 1047.539082803568, 1068.839674048891, 1072.9946350268237, 1074.0280046557878, 1074.3929679730966, 1076.1821016027836, 779.5829231361223, 808.8988876390451, 809.0574480729972, 1051.5951358726907, 1099.3074363151204, 1079.7300674831292, 1086.7011571817734, 1087.8531398261252, 1089.0634054712941, 1090.8036553420382, 787.6258777080898, 796.6534557467462, 797.3740613618281, 798.078219656298, 798.9161138080534, 14623.122612643276, 14638.0, 14742.336594853257, 14868.0, 15794.289256983464, 20070.49823754403, 20451.48871278215, 20760.169593216255, 20834.68747968782, 20896.0, 15066.0, 15106.0, 15193.772093418607, 15196.316165772567, 15200.0, 3410.6759857813468, 3462.87879924204, 3486.1981744198974, 3509.0, 3516.314318707853, 109455.0, 110040.4497977513, 114000.0, 114347.0, 114929.4253528727, 15692.0, 15879.0, 15900.0, 16021.59946001336, 16112.516624501284, 28115.156545303675, 28147.577786333222, 29015.41969160605, 29156.708432915824, 29213.561796573067, 7939.245771651684, 7986.7603971880935, 8007.959960200278, 8034.758957231293, 8080.0, 3898.2788184186015, 4086.346184610448, 4113.0, 4175.498940127204, 4230.936535951963, 4863.975680121647, 5047.722375269395, 5047.873803154877, 5086.804600918781, 5110.821121260738, 854.3037424499014, 886.4193952960821, 886.4592598514901, 995.6266400099962, 1026.3328836256494, 690.8307464671087, 704.2745971649107, 709.8260926073042, 720.2653293640458, 730.1274976403254, 11957.760844783055, 12017.819732704016, 12231.877681223074, 12570.560030398892, 12700.174488658207, 645.5255387290338, 672.9528932974645, 694.3750624437945, 717.2177139807574, 731.3162193349235, 5475.342958844884, 5570.41510641385, 5591.161325801162, 5621.353544342372, 5631.802886898939, 93535.0, 96764.0, 97330.51334743423, 98905.50547247217, 103351.48324258481, 87524.0, 88061.41593598099, 88415.0, 90611.54694226486, 93615.0, 76655.0, 77097.0, 77106.0, 78222.6088869552, 80561.59719201367, 10893.727656808644, 11054.22620416563, 11337.206395552232, 11926.0, 12399.0, 32950.34099318048, 34893.127671808405, 35318.82340588281, 36129.819350903075, 36776.0, 60218.69890650519, 61035.38964610297, 61389.69305153624, 62435.687821560605, 63536.0, 18200.362987295382, 18334.633307334047, 18606.16272267724, 19061.428157155307, 19087.141078651774, 20405.183792648128, 20646.69029964582, 20903.268385606432, 20987.790122098584, 21580.028898699282, 17208.483745487654, 18313.816861831212, 18919.148638311584, 19185.52036199106, 19216.61566768629, 18832.811671883654, 19459.8054019458, 19618.313359032367, 19879.30422435208, 20226.59546809026, 17575.384861529787, 17873.73189402186, 17925.551861203574, 19181.904090479456, 19971.800281996995, 12864.356782161041, 13018.414171362121, 13482.258475783534, 13589.45642174302, 13852.584422467342, 14110.365033573718, 14365.425382984982, 14379.0, 14402.42390304376, 14464.20446875432], "value": 8831.598048673864, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 109.0, 107.0, 108.0, 108.0, 108.0, 108.0, 109.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 145.0, 167.0, 123.0, 157.0, 144.0, 125.0, 173.0, 121.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 164.0, 161.0, 162.0, 172.0, 163.0, 164.0, 164.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 166.0, 78.0, 77.0, 74.0, 74.0, 99.0, 75.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 162.0, 81.0, 81.0, 82.0, 135.0, 80.0, 82.0, 130.0], "value": 99.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 56.0, 54.0, 57.0, 54.0, 59.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 79.0, 85.0, 77.0, 78.0, 84.0, 79.0, 76.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 127.0, 141.0, 129.0, 127.0, 141.0, 125.0, 136.0, 132.0, 169.0], "value": 135.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 187.0, 186.0, 182.0, 183.0, 184.0, 183.0, 190.0, 183.0, 198.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 71.0, 74.0, 71.0, 73.0, 69.0, 72.0, 76.0, 69.0], "value": 71.4, "unit": "score"}]}]} 08:31:35 INFO - Return code: 0 08:31:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:35 INFO - # TBPL SUCCESS # 08:31:35 INFO - Running post-action listener: _package_coverage_data 08:31:35 INFO - Running post-action listener: _resource_record_post_action 08:31:35 INFO - [mozharness: 2017-07-15 15:31:35.084234Z] Finished run-tests step (success) 08:31:35 INFO - Running post-run listener: _resource_record_post_run 08:31:35 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5935104; Write bytes: 431316992; Read time: 3268; Write time: 515888 08:31:35 INFO - TinderboxPrint: CPU usage
13.1% 08:31:35 INFO - TinderboxPrint: I/O read bytes / time
5,935,104 / 3,268 08:31:35 INFO - TinderboxPrint: I/O write bytes / time
431,316,992 / 515,888 08:31:35 INFO - TinderboxPrint: CPU idle
8,293.5 (86.9%) 08:31:35 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 08:31:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107229184; Read time: 0; Write time: 201456 08:31:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:31:35 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3518464; Write bytes: 324087808; Read time: 2736; Write time: 314432 08:31:35 INFO - Running post-run listener: _upload_blobber_files 08:31:35 INFO - Blob upload gear active. 08:31:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:35 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 08:31:35 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'] 08:31:35 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 08:31:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:37 INFO - (blobuploader) - INFO - Done attempting. 08:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:38 INFO - (blobuploader) - INFO - Done attempting. 08:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:38 INFO - (blobuploader) - INFO - Done attempting. 08:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:42 INFO - (blobuploader) - INFO - Done attempting. 08:31:42 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:42 INFO - Return code: 0 08:31:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0006edf34601a95a0ad626cd901141b872f42b03db05d157d7c556c94d109eb55ccea4ed5daa99a2f16a14bad56a928614ec497236f317f31a949d2d4d6067d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d3c8674cb0a6317d54bfdc710d9cd0b8a87f5a0a21b4bad5800fc99dc2eeed4d3163a8224deb74ab710521acecd5d7eab174c9425432c523dc5d003b397ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e1dbaacf4835035595e8663a1a9d045976aee5345a757c870b1d5b4b09448bd889ff21d1843de53db7c7b01c1bdf3b4ca43946cac906a6f72737e85047aad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c011151975a014d2d8ed5837331e98f3a016d293d8cac70cbe682b3109926dc1fa8f71f9b80d61b4922270f8ee693d52b806308625a6162788db79cf0eb8bf"} 08:31:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:42 INFO - Contents: 08:31:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0006edf34601a95a0ad626cd901141b872f42b03db05d157d7c556c94d109eb55ccea4ed5daa99a2f16a14bad56a928614ec497236f317f31a949d2d4d6067d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d3c8674cb0a6317d54bfdc710d9cd0b8a87f5a0a21b4bad5800fc99dc2eeed4d3163a8224deb74ab710521acecd5d7eab174c9425432c523dc5d003b397ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e1dbaacf4835035595e8663a1a9d045976aee5345a757c870b1d5b4b09448bd889ff21d1843de53db7c7b01c1bdf3b4ca43946cac906a6f72737e85047aad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c011151975a014d2d8ed5837331e98f3a016d293d8cac70cbe682b3109926dc1fa8f71f9b80d61b4922270f8ee693d52b806308625a6162788db79cf0eb8bf"} 08:31:42 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:42 INFO - Copying logs to upload dir... 08:31:42 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.459466 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-07-15 08:31:42.016865) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-15 08:31:42.021238) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 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/f0006edf34601a95a0ad626cd901141b872f42b03db05d157d7c556c94d109eb55ccea4ed5daa99a2f16a14bad56a928614ec497236f317f31a949d2d4d6067d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d3c8674cb0a6317d54bfdc710d9cd0b8a87f5a0a21b4bad5800fc99dc2eeed4d3163a8224deb74ab710521acecd5d7eab174c9425432c523dc5d003b397ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e1dbaacf4835035595e8663a1a9d045976aee5345a757c870b1d5b4b09448bd889ff21d1843de53db7c7b01c1bdf3b4ca43946cac906a6f72737e85047aad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c011151975a014d2d8ed5837331e98f3a016d293d8cac70cbe682b3109926dc1fa8f71f9b80d61b4922270f8ee693d52b806308625a6162788db79cf0eb8bf"} build_url:https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/Z9-nVwSpTM--hCKtNyFH-A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0006edf34601a95a0ad626cd901141b872f42b03db05d157d7c556c94d109eb55ccea4ed5daa99a2f16a14bad56a928614ec497236f317f31a949d2d4d6067d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c2d3c8674cb0a6317d54bfdc710d9cd0b8a87f5a0a21b4bad5800fc99dc2eeed4d3163a8224deb74ab710521acecd5d7eab174c9425432c523dc5d003b397ffe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0e1dbaacf4835035595e8663a1a9d045976aee5345a757c870b1d5b4b09448bd889ff21d1843de53db7c7b01c1bdf3b4ca43946cac906a6f72737e85047aad6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35c011151975a014d2d8ed5837331e98f3a016d293d8cac70cbe682b3109926dc1fa8f71f9b80d61b4922270f8ee693d52b806308625a6162788db79cf0eb8bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-15 08:31:42.052666) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:31:42.057125) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500128914.77125-1157199700 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-15 08:31:42.135644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-15 08:31:42.138030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-15 08:31:42.138362) ========= ========= Total master_lag: 0.34 =========