builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1498686399.7 results: success (0) revision: 217b7fcf58944f927118b465769faeb1e613130a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.701996) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.702370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.702627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.796012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.796259) ========= 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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-28 14:46: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% 32.2M=0s 2017-06-28 14:46:40 (32.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.917642) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.920950) ========= 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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022860 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:39.970076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-28 14:46:39.970365) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 217b7fcf58944f927118b465769faeb1e613130a --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 217b7fcf58944f927118b465769faeb1e613130a --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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-28 14:46:40,978 truncating revision to first 12 chars 2017-06-28 14:46:40,978 Setting DEBUG logging. 2017-06-28 14:46:40,978 attempt 1/10 2017-06-28 14:46:40,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/217b7fcf5894?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-28 14:46:42,045 unpacking tar archive at: mozilla-central-217b7fcf5894/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371462 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-28 14:46:41.359725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:41.360020) ========= script_repo_revision: 217b7fcf58944f927118b465769faeb1e613130a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:41.360411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:41.360665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-28 14:46:41.377151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-28 14:46:41.377447) ========= /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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:46:42 INFO - MultiFileLogger online at 20170628 14:46:42 in /builds/slave/test 14:46: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 14:46:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:46:42 INFO - {'append_to_log': False, 14:46:42 INFO - 'base_work_dir': '/builds/slave/test', 14:46:42 INFO - 'blob_upload_branch': 'Firefox', 14:46:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:46:42 INFO - 'branch': 'Firefox', 14:46:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:46:42 INFO - 'config_files': ('talos/linux_config.py',), 14:46:42 INFO - 'default_actions': ('clobber', 14:46:42 INFO - 'read-buildbot-config', 14:46:42 INFO - 'download-and-extract', 14:46:42 INFO - 'populate-webroot', 14:46:42 INFO - 'create-virtualenv', 14:46:42 INFO - 'install', 14:46:42 INFO - 'setup-mitmproxy', 14:46:42 INFO - 'run-tests'), 14:46:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:46:42 INFO - 'download_minidump_stackwalk': True, 14:46:42 INFO - 'download_symbols': 'ondemand', 14:46:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:46:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:46:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:46:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:46:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:46:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:46:42 INFO - 'gecko_profile': False, 14:46:42 INFO - 'gecko_profile_interval': 0, 14:46:42 INFO - 'installer_path': 'installer.exe', 14:46:42 INFO - 'log_level': 'info', 14:46:42 INFO - 'log_name': 'talos', 14:46:42 INFO - 'log_to_console': True, 14:46:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:46:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:46:42 INFO - 'opt_config_files': (), 14:46:42 INFO - 'pip_index': False, 14:46:42 INFO - 'suite': 'dromaeojs-e10s', 14:46:42 INFO - 'system_bits': '32', 14:46:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:46:42 INFO - 'title': 'talos-linux64-ix-045', 14:46:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:46:42 INFO - 'use_talos_json': True, 14:46:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:46:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:46:42 INFO - 'work_dir': 'build'} 14:46:42 INFO - [mozharness: 2017-06-28 21:46:42.486082Z] Running clobber step. 14:46:42 INFO - Running pre-action listener: _resource_record_pre_action 14:46:42 INFO - Running main action method: clobber 14:46:42 INFO - rmtree: /builds/slave/test/build 14:46:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:46:44 INFO - Running post-action listener: _resource_record_post_action 14:46:44 INFO - [mozharness: 2017-06-28 21:46:44.036072Z] Finished clobber step (success) 14:46:44 INFO - [mozharness: 2017-06-28 21:46:44.036170Z] Running read-buildbot-config step. 14:46:44 INFO - Running pre-action listener: _resource_record_pre_action 14:46:44 INFO - Running main action method: read_buildbot_config 14:46:44 INFO - Using buildbot properties: 14:46:44 INFO - { 14:46:44 INFO - "project": "", 14:46:44 INFO - "product": "firefox", 14:46:44 INFO - "who": "ffxbld@noreply.mozilla.org", 14:46:44 INFO - "installer_path": "public/build/target.tar.bz2", 14:46:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:46:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:46:44 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:46:44 INFO - "stage_platform": "linux64-stylosequential", 14:46:44 INFO - "basedir": "/builds/slave/test", 14:46:44 INFO - "buildnumber": 87, 14:46:44 INFO - "platform": "ubuntu64_hw_styloseq", 14:46:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:46:44 INFO - "slavebuilddir": "test", 14:46:44 INFO - "taskId": "aCJrKJwlTuCIjpWIjDGhDQ", 14:46:44 INFO - "branch": "mozilla-central", 14:46:44 INFO - "script_repo_revision": "production", 14:46:44 INFO - "revision": "217b7fcf58944f927118b465769faeb1e613130a", 14:46:44 INFO - "slavename": "talos-linux64-ix-045", 14:46:44 INFO - "repo_path": "mozilla-central" 14:46:44 INFO - } 14:46:44 INFO - Finding installer, test and symbols from parent task. 14:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCJrKJwlTuCIjpWIjDGhDQ'}, attempt #1 14:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aCJrKJwlTuCIjpWIjDGhDQ'}, attempt #1 14:46:44 INFO - Task dependencies: HjzDKNl1RmS00UgGSOH2vQ 14:46:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ'}, attempt #1 14:46:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 14:46:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/test_packages.json 14:46:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.crashreporter-symbols.zip 14:46:45 INFO - Running post-action listener: _resource_record_post_action 14:46:45 INFO - [mozharness: 2017-06-28 21:46:45.433759Z] Finished read-buildbot-config step (success) 14:46:45 INFO - [mozharness: 2017-06-28 21:46:45.433978Z] Running download-and-extract step. 14:46:45 INFO - Running pre-action listener: _resource_record_pre_action 14:46:45 INFO - Running main action method: download_and_extract 14:46:45 INFO - mkdir: /builds/slave/test/build/tests 14:46:45 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')]} 14:46:45 INFO - trying https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.test_packages.json 14:46:45 INFO - Downloading https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:46:45 INFO - Downloaded 989 bytes. 14:46:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:46:45 INFO - Using the following test package requirements: 14:46:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:46:45 INFO - u'common': [u'target.common.tests.zip'], 14:46:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:46:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:46:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:46:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:46:45 INFO - u'mozbase': [u'target.common.tests.zip'], 14:46:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:46:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:46:45 INFO - u'web-platform': [u'target.common.tests.zip', 14:46:45 INFO - u'target.web-platform.tests.tar.gz'], 14:46:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:46:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:46:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip 14:46:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:46:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip into memory 14:46:47 INFO - Content-Length response header: 67756357 14:46:47 INFO - Bytes received: 67756357 14:46:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:46:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip 14:46:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:46:58 INFO - Fetch https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.common.tests.zip into memory 14:46:59 INFO - Content-Length response header: 67756357 14:46:59 INFO - Bytes received: 67756357 14:47:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.talos.tests.zip 14:47:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:47:11 INFO - Fetch https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.talos.tests.zip into memory 14:47:11 INFO - Content-Length response header: 14442527 14:47:11 INFO - Bytes received: 14442527 14:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:12 INFO - trying https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 14:47:12 INFO - Downloading https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:47:13 INFO - Downloaded 61958163 bytes. 14:47:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 14:47:13 INFO - mkdir: /builds/slave/test/properties 14:47:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:47:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:47:13 INFO - Contents: 14:47:13 INFO - build_url:https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 14:47:13 INFO - Running post-action listener: _resource_record_post_action 14:47:13 INFO - Running post-action listener: set_extra_try_arguments 14:47:13 INFO - [mozharness: 2017-06-28 21:47:13.341226Z] Finished download-and-extract step (success) 14:47:13 INFO - [mozharness: 2017-06-28 21:47:13.341336Z] Running populate-webroot step. 14:47:13 INFO - Running pre-action listener: _resource_record_pre_action 14:47:13 INFO - Running main action method: populate_webroot 14:47:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:47:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:47:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:47:13 INFO - '--tppagecycles', 14:47:13 INFO - '7'], 14:47:13 INFO - 'tests': ['tsvgm']}}, 14:47:13 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:47:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:47:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:47:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:47:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['damp', 'tps']}, 14:47:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'tests': ['damp', 'tps']}, 14:47:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['dromaeo_dom']}, 14:47:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:47:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:47:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:47:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:47:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['a11yr', 14:47:13 INFO - 'ts_paint', 14:47:13 INFO - 'tpaint', 14:47:13 INFO - 'sessionrestore', 14:47:13 INFO - 'sessionrestore_no_auto_restore', 14:47:13 INFO - 'tabpaint']}, 14:47:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:47:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:47:13 INFO - 'bloom_basic_ref']}, 14:47:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:47:13 INFO - 'talos_options': ['--mitmproxy', 14:47:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:47:13 INFO - '--firstNonBlankPaint'], 14:47:13 INFO - 'tests': ['quantum_pageload_google', 14:47:13 INFO - 'quantum_pageload_youtube', 14:47:13 INFO - 'quantum_pageload_amazon', 14:47:13 INFO - 'quantum_pageload_facebook']}, 14:47:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['tsvgx', 14:47:13 INFO - 'tsvgr_opacity', 14:47:13 INFO - 'tart', 14:47:13 INFO - 'tscrollx', 14:47:13 INFO - 'cart', 14:47:13 INFO - 'tsvg_static']}, 14:47:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:47:13 INFO - 'tsvgr_opacity', 14:47:13 INFO - 'tart', 14:47:13 INFO - 'tscrollx', 14:47:13 INFO - 'cart', 14:47:13 INFO - 'tsvg_static']}, 14:47:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'talos_options': ['--disable-e10s'], 14:47:13 INFO - 'tests': ['tp5o']}, 14:47:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:47:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'talos_options': ['--disable-e10s', 14:47:13 INFO - '--xperf_path', 14:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:13 INFO - 'tests': ['tp5n']}, 14:47:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:47:13 INFO - 'talos_options': ['--xperf_path', 14:47:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:47:13 INFO - 'tests': ['tp5n']}}, 14:47:13 INFO - 'talos.zip': {'path': '', 14:47:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:47:13 INFO - Running post-action listener: _resource_record_post_action 14:47:13 INFO - [mozharness: 2017-06-28 21:47:13.356132Z] Finished populate-webroot step (success) 14:47:13 INFO - [mozharness: 2017-06-28 21:47:13.356221Z] Running create-virtualenv step. 14:47:13 INFO - Running pre-action listener: _resource_record_pre_action 14:47:13 INFO - Running main action method: create_virtualenv 14:47:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:47:13 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 14:47:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:47:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:47:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:47:13 INFO - Using real prefix '/usr' 14:47:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:47:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:47:15 INFO - Installing pip.................done. 14:47:15 INFO - Return code: 0 14:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:47:16 INFO - Reading from file tmpfile_stdout 14:47:16 INFO - Output received: 14:47:16 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) 14:47:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:47:16 INFO - Using env: {'DISPLAY': ':0', 14:47:16 INFO - 'HOME': '/home/cltbld', 14:47:16 INFO - 'LANG': 'en_US.UTF-8', 14:47:16 INFO - 'LANGUAGE': 'en_US:en', 14:47:16 INFO - 'LOGNAME': 'cltbld', 14:47:16 INFO - 'MAIL': '/var/mail/cltbld', 14:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:16 INFO - 'MOZ_NO_REMOTE': '1', 14:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:16 INFO - 'NO_EM_RESTART': '1', 14:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:16 INFO - 'PWD': '/builds/slave/test', 14:47:16 INFO - 'SHELL': '/bin/bash', 14:47:16 INFO - 'SHLVL': '1', 14:47:16 INFO - 'TERM': 'linux', 14:47:16 INFO - 'TMOUT': '86400', 14:47:16 INFO - 'USER': 'cltbld', 14:47:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:16 INFO - '_': '/tools/buildbot/bin/python'} 14:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:16 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 14:47:16 INFO - Cleaning up... 14:47:16 INFO - Return code: 0 14:47:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:47:16 INFO - Using env: {'DISPLAY': ':0', 14:47:16 INFO - 'HOME': '/home/cltbld', 14:47:16 INFO - 'LANG': 'en_US.UTF-8', 14:47:16 INFO - 'LANGUAGE': 'en_US:en', 14:47:16 INFO - 'LOGNAME': 'cltbld', 14:47:16 INFO - 'MAIL': '/var/mail/cltbld', 14:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:16 INFO - 'MOZ_NO_REMOTE': '1', 14:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:16 INFO - 'NO_EM_RESTART': '1', 14:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:16 INFO - 'PWD': '/builds/slave/test', 14:47:16 INFO - 'SHELL': '/bin/bash', 14:47:16 INFO - 'SHLVL': '1', 14:47:16 INFO - 'TERM': 'linux', 14:47:16 INFO - 'TMOUT': '86400', 14:47:16 INFO - 'USER': 'cltbld', 14:47:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:16 INFO - '_': '/tools/buildbot/bin/python'} 14:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:16 INFO - Downloading/unpacking psutil>=3.1.1 14:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:47:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:17 INFO - Installing collected packages: psutil 14:47:17 INFO - Running setup.py install for psutil 14:47:17 INFO - building 'psutil._psutil_linux' extension 14:47:17 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 14:47:18 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 14:47:18 INFO - building 'psutil._psutil_posix' extension 14:47:18 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 14:47:18 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 14:47:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:47:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:47:18 INFO - Successfully installed psutil 14:47:18 INFO - Cleaning up... 14:47:18 INFO - Return code: 0 14:47:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:47:18 INFO - Using env: {'DISPLAY': ':0', 14:47:18 INFO - 'HOME': '/home/cltbld', 14:47:18 INFO - 'LANG': 'en_US.UTF-8', 14:47:18 INFO - 'LANGUAGE': 'en_US:en', 14:47:18 INFO - 'LOGNAME': 'cltbld', 14:47:18 INFO - 'MAIL': '/var/mail/cltbld', 14:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:18 INFO - 'MOZ_NO_REMOTE': '1', 14:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:18 INFO - 'NO_EM_RESTART': '1', 14:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:18 INFO - 'PWD': '/builds/slave/test', 14:47:18 INFO - 'SHELL': '/bin/bash', 14:47:18 INFO - 'SHLVL': '1', 14:47:18 INFO - 'TERM': 'linux', 14:47:18 INFO - 'TMOUT': '86400', 14:47:18 INFO - 'USER': 'cltbld', 14:47:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:18 INFO - '_': '/tools/buildbot/bin/python'} 14:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:47:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:47:19 INFO - Installing collected packages: mozsystemmonitor 14:47:19 INFO - Running setup.py install for mozsystemmonitor 14:47:19 INFO - Successfully installed mozsystemmonitor 14:47:19 INFO - Cleaning up... 14:47:19 INFO - Return code: 0 14:47:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47: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')]} 14:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47: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', '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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:47: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 jsonschema==2.5.1 14:47:19 INFO - Using env: {'DISPLAY': ':0', 14:47:19 INFO - 'HOME': '/home/cltbld', 14:47:19 INFO - 'LANG': 'en_US.UTF-8', 14:47:19 INFO - 'LANGUAGE': 'en_US:en', 14:47:19 INFO - 'LOGNAME': 'cltbld', 14:47:19 INFO - 'MAIL': '/var/mail/cltbld', 14:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:19 INFO - 'MOZ_NO_REMOTE': '1', 14:47:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:19 INFO - 'NO_EM_RESTART': '1', 14:47:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:19 INFO - 'PWD': '/builds/slave/test', 14:47:19 INFO - 'SHELL': '/bin/bash', 14:47:19 INFO - 'SHLVL': '1', 14:47:19 INFO - 'TERM': 'linux', 14:47:19 INFO - 'TMOUT': '86400', 14:47:19 INFO - 'USER': 'cltbld', 14:47:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:19 INFO - '_': '/tools/buildbot/bin/python'} 14:47:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:20 INFO - Downloading/unpacking jsonschema==2.5.1 14:47: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 14:47: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 14:47: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 14:47: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 14:47:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:47:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:47:21 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 14:47:21 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 14:47:21 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 14:47:21 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 14:47:21 INFO - Downloading functools32-3.2.3-2.tar.gz 14:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:47:21 INFO - warning: no files found matching '*.txt' 14:47:21 INFO - no previously-included directories found matching 'build' 14:47:21 INFO - no previously-included directories found matching 'dist' 14:47:21 INFO - no previously-included directories found matching '.git*' 14:47:21 INFO - Installing collected packages: jsonschema, functools32 14:47:21 INFO - Running setup.py install for functools32 14:47:21 INFO - warning: no files found matching '*.txt' 14:47:21 INFO - no previously-included directories found matching 'build' 14:47:21 INFO - no previously-included directories found matching 'dist' 14:47:21 INFO - no previously-included directories found matching '.git*' 14:47:21 INFO - Successfully installed jsonschema functools32 14:47:21 INFO - Cleaning up... 14:47:21 INFO - Return code: 0 14:47:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:47:21 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')]} 14:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:21 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')]} 14:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:21 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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:21 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 14:47:21 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 14:47:21 INFO - Using env: {'DISPLAY': ':0', 14:47:21 INFO - 'HOME': '/home/cltbld', 14:47:21 INFO - 'LANG': 'en_US.UTF-8', 14:47:21 INFO - 'LANGUAGE': 'en_US:en', 14:47:21 INFO - 'LOGNAME': 'cltbld', 14:47:21 INFO - 'MAIL': '/var/mail/cltbld', 14:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:21 INFO - 'MOZ_NO_REMOTE': '1', 14:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:21 INFO - 'NO_EM_RESTART': '1', 14:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:21 INFO - 'PWD': '/builds/slave/test', 14:47:21 INFO - 'SHELL': '/bin/bash', 14:47:21 INFO - 'SHLVL': '1', 14:47:21 INFO - 'TERM': 'linux', 14:47:21 INFO - 'TMOUT': '86400', 14:47:21 INFO - 'USER': 'cltbld', 14:47:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:21 INFO - '_': '/tools/buildbot/bin/python'} 14:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:47:21 INFO - Cleaning up... 14:47:21 INFO - Return code: 0 14:47:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:47:21 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')]} 14:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:21 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')]} 14:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:21 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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:21 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 14:47:21 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 14:47:21 INFO - Using env: {'DISPLAY': ':0', 14:47:21 INFO - 'HOME': '/home/cltbld', 14:47:21 INFO - 'LANG': 'en_US.UTF-8', 14:47:21 INFO - 'LANGUAGE': 'en_US:en', 14:47:21 INFO - 'LOGNAME': 'cltbld', 14:47:21 INFO - 'MAIL': '/var/mail/cltbld', 14:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:21 INFO - 'MOZ_NO_REMOTE': '1', 14:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:21 INFO - 'NO_EM_RESTART': '1', 14:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:21 INFO - 'PWD': '/builds/slave/test', 14:47:21 INFO - 'SHELL': '/bin/bash', 14:47:21 INFO - 'SHLVL': '1', 14:47:21 INFO - 'TERM': 'linux', 14:47:21 INFO - 'TMOUT': '86400', 14:47:21 INFO - 'USER': 'cltbld', 14:47:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:21 INFO - '_': '/tools/buildbot/bin/python'} 14:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:21 INFO - Downloading/unpacking blobuploader==1.2.4 14:47:21 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 14:47:21 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 14:47:21 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 14:47:21 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 14:47:22 INFO - Downloading blobuploader-1.2.4.tar.gz 14:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:47:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:47:23 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 14:47:23 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 14:47:23 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 14:47:23 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 14:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:47:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:47:23 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 14:47:23 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 14:47:23 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 14:47:23 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 14:47:23 INFO - Downloading docopt-0.6.1.tar.gz 14:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:47:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:47:23 INFO - Running setup.py install for blobuploader 14:47:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:47:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:47:23 INFO - Running setup.py install for requests 14:47:24 INFO - Running setup.py install for docopt 14:47:24 INFO - Successfully installed blobuploader requests docopt 14:47:24 INFO - Cleaning up... 14:47:24 INFO - Return code: 0 14:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47: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')]} 14:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:24 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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:24 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 14:47:24 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 14:47:24 INFO - Using env: {'DISPLAY': ':0', 14:47:24 INFO - 'HOME': '/home/cltbld', 14:47:24 INFO - 'LANG': 'en_US.UTF-8', 14:47:24 INFO - 'LANGUAGE': 'en_US:en', 14:47:24 INFO - 'LOGNAME': 'cltbld', 14:47:24 INFO - 'MAIL': '/var/mail/cltbld', 14:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:24 INFO - 'MOZ_NO_REMOTE': '1', 14:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:24 INFO - 'NO_EM_RESTART': '1', 14:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:24 INFO - 'PWD': '/builds/slave/test', 14:47:24 INFO - 'SHELL': '/bin/bash', 14:47:24 INFO - 'SHLVL': '1', 14:47:24 INFO - 'TERM': 'linux', 14:47:24 INFO - 'TMOUT': '86400', 14:47:24 INFO - 'USER': 'cltbld', 14:47:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:24 INFO - '_': '/tools/buildbot/bin/python'} 14:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:24 INFO - Running setup.py (path:/tmp/pip-DdXxPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:24 INFO - Running setup.py (path:/tmp/pip-AkrRlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:24 INFO - Running setup.py (path:/tmp/pip-WpX7Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:24 INFO - Running setup.py (path:/tmp/pip-Qzt5Yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:24 INFO - Running setup.py (path:/tmp/pip-d05E1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:24 INFO - Running setup.py (path:/tmp/pip-FSS4Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:24 INFO - Running setup.py (path:/tmp/pip-Ed7S35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:24 INFO - Running setup.py (path:/tmp/pip-tv043K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:24 INFO - Running setup.py (path:/tmp/pip-BDg35r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:25 INFO - Running setup.py (path:/tmp/pip-N31zgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:25 INFO - Running setup.py (path:/tmp/pip-B0Taxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:25 INFO - Running setup.py (path:/tmp/pip-qWDAow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:25 INFO - Running setup.py (path:/tmp/pip-9y7xbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:25 INFO - Running setup.py (path:/tmp/pip-Z9s_s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:25 INFO - Running setup.py (path:/tmp/pip-oL_8Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:25 INFO - Running setup.py (path:/tmp/pip-73VJRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:25 INFO - Running setup.py (path:/tmp/pip-8oCjq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:47:25 INFO - Running setup.py install for manifestparser 14:47:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:47:25 INFO - Running setup.py install for mozcrash 14:47:25 INFO - Running setup.py install for mozdebug 14:47:25 INFO - Running setup.py install for mozdevice 14:47:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozfile 14:47:26 INFO - Running setup.py install for mozhttpd 14:47:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozinfo 14:47:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozInstall 14:47:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozleak 14:47:26 INFO - Running setup.py install for mozlog 14:47:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for moznetwork 14:47:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozprocess 14:47:26 INFO - Running setup.py install for mozprofile 14:47:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:47:26 INFO - Running setup.py install for mozrunner 14:47:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:47:27 INFO - Running setup.py install for mozscreenshot 14:47:27 INFO - Running setup.py install for moztest 14:47:27 INFO - Running setup.py install for mozversion 14:47:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:47:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:47:27 INFO - Cleaning up... 14:47:27 INFO - Return code: 0 14:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:27 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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:27 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 14:47:27 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 14:47:27 INFO - Using env: {'DISPLAY': ':0', 14:47:27 INFO - 'HOME': '/home/cltbld', 14:47:27 INFO - 'LANG': 'en_US.UTF-8', 14:47:27 INFO - 'LANGUAGE': 'en_US:en', 14:47:27 INFO - 'LOGNAME': 'cltbld', 14:47:27 INFO - 'MAIL': '/var/mail/cltbld', 14:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:27 INFO - 'MOZ_NO_REMOTE': '1', 14:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:27 INFO - 'NO_EM_RESTART': '1', 14:47:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:27 INFO - 'PWD': '/builds/slave/test', 14:47:27 INFO - 'SHELL': '/bin/bash', 14:47:27 INFO - 'SHLVL': '1', 14:47:27 INFO - 'TERM': 'linux', 14:47:27 INFO - 'TMOUT': '86400', 14:47:27 INFO - 'USER': 'cltbld', 14:47:27 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:27 INFO - '_': '/tools/buildbot/bin/python'} 14:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:47:27 INFO - Running setup.py (path:/tmp/pip-yH4pLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:47:27 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)) 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:47:27 INFO - Running setup.py (path:/tmp/pip-ojnVxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:47:27 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)) 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:47:27 INFO - Running setup.py (path:/tmp/pip-XlSZxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:47:27 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)) 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:47:27 INFO - Running setup.py (path:/tmp/pip-emuMx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:47:27 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)) 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:47:27 INFO - Running setup.py (path:/tmp/pip-zf2dBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:47:27 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)) 14:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:47:27 INFO - Running setup.py (path:/tmp/pip-YcQjYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:47:28 INFO - Running setup.py (path:/tmp/pip-vaMZ0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:47:28 INFO - Running setup.py (path:/tmp/pip-2aBRLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:47:28 INFO - Running setup.py (path:/tmp/pip-UtTB1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:47:28 INFO - Running setup.py (path:/tmp/pip-QXrDG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:47:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:47:28 INFO - Running setup.py (path:/tmp/pip-lOUqbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:47:28 INFO - Running setup.py (path:/tmp/pip-iXnbjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:47:28 INFO - Running setup.py (path:/tmp/pip-nzlrg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:47:28 INFO - Running setup.py (path:/tmp/pip-7cSIpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:28 INFO - Running setup.py (path:/tmp/pip-H_ORwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:47:28 INFO - Running setup.py (path:/tmp/pip-u8anPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:47:28 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)) 14:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:47:28 INFO - Running setup.py (path:/tmp/pip-n8DeWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:47:28 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)) 14:47:28 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)) 14:47:28 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)) 14:47:28 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)) 14:47:28 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)) 14:47:28 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)) 14:47:28 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)) 14:47:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:29 INFO - Downloading blessings-1.6.tar.gz 14:47:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:47:30 INFO - Installing collected packages: blessings 14:47:30 INFO - Running setup.py install for blessings 14:47:30 INFO - Successfully installed blessings 14:47:30 INFO - Cleaning up... 14:47:30 INFO - Return code: 0 14:47:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:47:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:30 INFO - Reading from file tmpfile_stdout 14:47:30 INFO - Current package versions: 14:47:30 INFO - argparse == 1.2.1 14:47:30 INFO - blessings == 1.6 14:47:30 INFO - blobuploader == 1.2.4 14:47:30 INFO - docopt == 0.6.1 14:47:30 INFO - functools32 == 3.2.3-2 14:47:30 INFO - jsonschema == 2.5.1 14:47:30 INFO - manifestparser == 1.1 14:47:30 INFO - mozInstall == 1.13 14:47:30 INFO - mozcrash == 1.0 14:47:30 INFO - mozdebug == 0.1 14:47:30 INFO - mozdevice == 0.51 14:47:30 INFO - mozfile == 1.2 14:47:30 INFO - mozhttpd == 0.7 14:47:30 INFO - mozinfo == 0.10 14:47:30 INFO - mozleak == 0.1 14:47:30 INFO - mozlog == 3.4 14:47:30 INFO - moznetwork == 0.27 14:47:30 INFO - mozprocess == 0.25 14:47:30 INFO - mozprofile == 0.28 14:47:30 INFO - mozrunner == 6.13 14:47:30 INFO - mozscreenshot == 0.1 14:47:30 INFO - mozsystemmonitor == 0.3 14:47:30 INFO - moztest == 0.8 14:47:30 INFO - mozversion == 1.4 14:47:30 INFO - psutil == 3.1.1 14:47:30 INFO - requests == 1.2.3 14:47:30 INFO - wsgiref == 0.1.2 14:47:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:47:30 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')]} 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47:30 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')]} 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:30 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 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:30 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 14:47:30 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 14:47:30 INFO - Using env: {'DISPLAY': ':0', 14:47:30 INFO - 'HOME': '/home/cltbld', 14:47:30 INFO - 'LANG': 'en_US.UTF-8', 14:47:30 INFO - 'LANGUAGE': 'en_US:en', 14:47:30 INFO - 'LOGNAME': 'cltbld', 14:47:30 INFO - 'MAIL': '/var/mail/cltbld', 14:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:30 INFO - 'MOZ_NO_REMOTE': '1', 14:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:30 INFO - 'NO_EM_RESTART': '1', 14:47:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:30 INFO - 'PWD': '/builds/slave/test', 14:47:30 INFO - 'SHELL': '/bin/bash', 14:47:30 INFO - 'SHLVL': '1', 14:47:30 INFO - 'TERM': 'linux', 14:47:30 INFO - 'TMOUT': '86400', 14:47:30 INFO - 'USER': 'cltbld', 14:47:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:30 INFO - '_': '/tools/buildbot/bin/python'} 14:47:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 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)) 14:47:30 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:47:31 INFO - Downloading marionette_driver-1.4.0.tar.gz 14:47:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 14:47:31 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)) 14:47:31 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)) 14:47:31 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)) 14:47:31 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)) 14:47:31 INFO - Installing collected packages: marionette-driver 14:47:31 INFO - Running setup.py install for marionette-driver 14:47:31 INFO - Successfully installed marionette-driver 14:47:31 INFO - Cleaning up... 14:47:31 INFO - Return code: 0 14:47:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:47: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')]} 14:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:47: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')]} 14:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:47:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ab3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26299a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, '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': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', '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 14:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:47:31 INFO - Using env: {'DISPLAY': ':0', 14:47:31 INFO - 'HOME': '/home/cltbld', 14:47:31 INFO - 'LANG': 'en_US.UTF-8', 14:47:31 INFO - 'LANGUAGE': 'en_US:en', 14:47:31 INFO - 'LOGNAME': 'cltbld', 14:47:31 INFO - 'MAIL': '/var/mail/cltbld', 14:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:31 INFO - 'MOZ_NO_REMOTE': '1', 14:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:31 INFO - 'NO_EM_RESTART': '1', 14:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:31 INFO - 'PWD': '/builds/slave/test', 14:47:31 INFO - 'SHELL': '/bin/bash', 14:47:31 INFO - 'SHLVL': '1', 14:47:31 INFO - 'TERM': 'linux', 14:47:31 INFO - 'TMOUT': '86400', 14:47:31 INFO - 'USER': 'cltbld', 14:47:31 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:31 INFO - '_': '/tools/buildbot/bin/python'} 14:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:47:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:47:32 INFO - Cleaning up... 14:47:32 INFO - Return code: 0 14:47:32 INFO - Running post-action listener: _resource_record_post_action 14:47:32 INFO - Running post-action listener: _start_resource_monitoring 14:47:32 INFO - Starting resource monitoring. 14:47:32 INFO - [mozharness: 2017-06-28 21:47:32.174684Z] Finished create-virtualenv step (success) 14:47:32 INFO - [mozharness: 2017-06-28 21:47:32.175149Z] Running install step. 14:47:32 INFO - Running pre-action listener: _resource_record_pre_action 14:47:32 INFO - Running main action method: install 14:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:47:32 INFO - Reading from file tmpfile_stdout 14:47:32 INFO - Detecting whether we're running mozinstall >=1.0... 14:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:47:32 INFO - Reading from file tmpfile_stdout 14:47:32 INFO - Output received: 14:47:32 INFO - Usage: mozinstall [options] installer 14:47:32 INFO - Options: 14:47:32 INFO - -h, --help show this help message and exit 14:47:32 INFO - -d DEST, --destination=DEST 14:47:32 INFO - Directory to install application into. [default: 14:47:32 INFO - "/builds/slave/test"] 14:47:32 INFO - --app=APP Application being installed. [default: firefox] 14:47:32 INFO - mkdir: /builds/slave/test/build/application 14:47:32 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'] 14:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:47:50 INFO - Reading from file tmpfile_stdout 14:47:50 INFO - Output received: 14:47:50 INFO - /builds/slave/test/build/application/firefox/firefox 14:47:50 INFO - Running post-action listener: _resource_record_post_action 14:47:50 INFO - [mozharness: 2017-06-28 21:47:50.403863Z] Finished install step (success) 14:47:50 INFO - [mozharness: 2017-06-28 21:47:50.404020Z] Running setup-mitmproxy step. 14:47:50 INFO - Running pre-action listener: _resource_record_pre_action 14:47:50 INFO - Running main action method: setup_mitmproxy 14:47:50 INFO - Skipping: mitmproxy is not required 14:47:50 INFO - Running post-action listener: _resource_record_post_action 14:47:50 INFO - [mozharness: 2017-06-28 21:47:50.404563Z] Finished setup-mitmproxy step (success) 14:47:50 INFO - [mozharness: 2017-06-28 21:47:50.404667Z] Running run-tests step. 14:47:50 INFO - Running pre-action listener: _resource_record_pre_action 14:47:50 INFO - Running main action method: run_tests 14:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:47:50 INFO - Python 2.7.3 14:47:50 INFO - Return code: 0 14:47:50 INFO - grabbing minidump binary from tooltool 14:47:50 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')]} 14:47:50 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 0x2627140>, '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 0x2627a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2627ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:47:50 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 14:47:50 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 14:47:50 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 14:47:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:47:50 INFO - Return code: 0 14:47:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:47:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:47:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:47:50 INFO - ENV: RUST_BACKTRACE is now 1 14:47:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:47:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:47:50 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/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:47:50 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/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 14:47:50 INFO - Using env: {'DISPLAY': ':0', 14:47:50 INFO - 'HOME': '/home/cltbld', 14:47:50 INFO - 'LANG': 'en_US.UTF-8', 14:47:50 INFO - 'LANGUAGE': 'en_US:en', 14:47:50 INFO - 'LOGNAME': 'cltbld', 14:47:50 INFO - 'MAIL': '/var/mail/cltbld', 14:47:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:47:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:47:50 INFO - 'MOZ_NO_REMOTE': '1', 14:47:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:47:50 INFO - 'NO_EM_RESTART': '1', 14:47:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:47:50 INFO - 'PWD': '/builds/slave/test', 14:47:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:47:50 INFO - 'RUST_BACKTRACE': '1', 14:47:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:47:50 INFO - 'SHELL': '/bin/bash', 14:47:50 INFO - 'SHLVL': '1', 14:47:50 INFO - 'TERM': 'linux', 14:47:50 INFO - 'TMOUT': '86400', 14:47:50 INFO - 'USER': 'cltbld', 14:47:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498673696.270601-1673155222', 14:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:47:50 INFO - '_': '/tools/buildbot/bin/python'} 14:47:50 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/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 14:47:50 INFO - mozversion application_buildid: 20170628205510 14:47:50 INFO - mozversion application_changeset: 217b7fcf58944f927118b465769faeb1e613130a 14:47:50 INFO - mozversion application_display_name: Nightly 14:47:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:47:50 INFO - mozversion application_name: Firefox 14:47:50 INFO - mozversion application_remotingname: firefox 14:47:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:47:50 INFO - mozversion application_vendor: Mozilla 14:47:50 INFO - mozversion application_version: 56.0a1 14:47:50 INFO - mozversion platform_buildid: 20170628205510 14:47:50 INFO - mozversion platform_changeset: 217b7fcf58944f927118b465769faeb1e613130a 14:47:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:47:50 INFO - mozversion platform_version: 56.0a1 14:47:50 INFO - using testdate: 1498686470 14:47:50 INFO - actual date: 1498686470 14:47:50 INFO - starting webserver on 'localhost:49488' 14:47:50 INFO - SUITE-START | Running 2 tests 14:47:50 INFO - TEST-START | dromaeo_css 14:47:50 INFO - operating with platform_type : linux_ 14:47:50 INFO - Initialising browser for dromaeo_css test... 14:47:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49488/getInfo.html -profile /tmp/tmp0HZaEa/profile 14:47:50 INFO - TEST-INFO | started process 4600 (/builds/slave/test/build/application/firefox/firefox http://localhost:49488/getInfo.html) 14:47:56 INFO - TEST-INFO | 4600: exit 0 14:47:57 INFO - Browser initialized. 14:47:57 INFO - Running cycle 1/1 for dromaeo_css test... 14:47:57 INFO - TEST-INFO | started process 4824 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0HZaEa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:48:08 INFO - PID 4824 | RSS: Main: 171872256 14:48:08 INFO - PID 4824 | 14:51:13 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49488/tests/dromaeo/cssquery-ext.html) 14:51:14 INFO - PID 4824 | RSS: Main: 178769920 14:51:14 INFO - PID 4824 | 14:54:16 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-ext.html (next: http://localhost:49488/tests/dromaeo/cssquery-jquery.html) 14:54:16 INFO - PID 4824 | RSS: Main: 177451008 14:54:16 INFO - PID 4824 | 14:57:18 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49488/tests/dromaeo/cssquery-mootools.html) 14:57:19 INFO - PID 4824 | RSS: Main: 179789824 14:57:19 INFO - PID 4824 | 15:00:20 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49488/tests/dromaeo/cssquery-prototype.html) 15:00:21 INFO - PID 4824 | RSS: Main: 179294208 15:00:21 INFO - PID 4824 | 15:03:24 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49488/tests/dromaeo/cssquery-yui.html) 15:03:24 INFO - PID 4824 | RSS: Main: 178704384 15:03:24 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | Cycle 1(1): loaded http://localhost:49488/tests/dromaeo/cssquery-yui.html (next: http://localhost:49488/tests/dromaeo/cssquery-dojo.html) 15:06:26 INFO - PID 4824 | RSS: Main: 181714944 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | __start_tp_report 15:06:26 INFO - PID 4824 | _x_x_mozilla_page_load 15:06:26 INFO - PID 4824 | _x_x_mozilla_page_load_details 15:06:26 INFO - PID 4824 | |i|pagename|runs| 15:06:26 INFO - PID 4824 | |0;dojo.html;3049.1157564306354;3078.322768990822;3103.394838006588;3112.066380085974;3119.033099739081;6026.728797204125;6089.330173680892;6112.199536562809;6116.244470650287;6147.0164773636225;6147.661878596687;6198.318184999646;6206.069089636557;6209.192804935364;6222.12890195373;5703.287089113871;5719.8570035749235;5787.623804452718;5791.420857914217;5823.912641310384;5544.944550554484;5707.914381284284;5712.685802280873;5721.170430287606;5726.971365143189;5600.859978500529;5600.943990560083;5610.579206559524;5612.270404847384;5627.774889004435;5688.175214593902;5702.059160238556;5732.856678583027;5757.913631295534;5783.277090363705;5666.801661941853;5697.230873832021;5713.285839270091;5716.371199168088;5718.828435146952;6104.267487901436;6146.477549408306;6168.660723660197;6173.135760993465;6212.81361559154;6446.290908000116;6447.54867159299;6507.2191337039385;6518.185226846645;6739.326067393222;6632.701528431232;6638.966805165944;6642.202935647705;6643.667816609151;6687.49843761715;6110.077186749992;6168.629882207082;6174.969125154345;6175.382461753788;6187.226596675416;6623.4038936495945;6731.798046058626;6733.730650773914;6769.22153952292;6775.62734049632;6359.777407790705;6387.457066149336;6486.027095935648;6505.934940650627;6510.153680021662;6655;6666.83332916681;6684.598924064474;6689.4982876284475;6691.330866913367;6415.1981002374705;6520.119783829217;6525.869482610321;6630.071789949411;6667.233268174125;6425.807225783141;6533.836654083686;6549.9345006550275;6550.868982620416;6582.506312026617;5374.543163831118;5440.483154100354;5473.17902314656;5478.342598888079;5480.26016487777;4577.793999270041;4593.19619066662;4593.425821772278;4595.379623750818;4631.95368046322;5798.5071268941765;5807.593468457252;5809.128630705428;5813.128030795415;5814.215080964101;6421.646809425433;6448.355164483608;6539.574927629689;6554.967225163844;6693.096431981718;5718.285214348207;5728.570357223225;5781.5952883298605;5791.131330300404;5799.2750906136735;5820.679862607512;5876.911846322223;5976.312724036705;5999.610025348338;6000.849978750479;6534.1178940844275;6539.836504087436;6547.377999090078;6550.836229094215;6576.309487503839;6721.428678562182;6727.596344219362;6744.7976560703255;6752.864942701217;6753.527253092237;6286.18279623646;6353.650549219652;6372.617642941438;6509.7396104155305;6518.57629254097;6349.079383489276;6407.775727849503;6467.611943283418;6487.124238227968;6502.544821862613;6695.9665201675625;6801.455883529206;6804.11546498952;6808.7276508939085;6820;6298.1812364392335;6561.606303621798;6572.342765723581;6572.737090516326;6595.571287866465;6321.11504389395;6451.612903225821;6476.481881449378;6481.837954051187;6492.5455218134275;6363.236411630634;6397.552171348148;6440.227172739301;6480.740770369132;6494.058361537645;6517.902231466437;6531.444827189742;6532.673366331569;6535.3137920517665;6570.408663220333;6207.348228435949;6209.379062093754;6294.527910406646;6295.622262664255;6305.5270854687 15:06:26 INFO - PID 4824 | |1;ext.html;767.6814122139313;791.6516732637642;821.8643923752581;848.4188330993268;851.6337974670893;40847.795761021225;41606.375904361455;41632;41640.79179604101;41880.581194188126;36425.81787091061;36487.63512364875;36561;36807.26385472296;36808;6822.351876571718;6890.827729306782;6930.064441300436;6941.861162776741;6960.721571137148;6849.589024658511;6891.586504809702;6933.72265109395;6936.445084393236;6950.756723514678;6870.931290687104;6918.550294230884;6924.792256232321;6925.238223795379;6941.167059952812;6904;6941.930580694229;6942.409895158918;6947.270536593635;6951.304869513034;6253.7185826637915;6255.718492667841;6266.185395898504;6271.153394291758;6285.654289014103;33314.833425832956;33471.6652833471;33555;33583.16042098943;33592;3354.2117602363423;3562.305350456662;3662.230931504387;3670.210904655485;3678.6321367863266;31320.53019204714;31519.36961260762;31656.366872662416;31668.524972125437;31693.52459713106;4709.7174169549935;4947.307376967192;4965.602751779849;5046.26829109777;5052.570531504826;188970;190271;191171;193605;194822;48214.75892620515;48455.75772121117;48493.5150648489;48565;48706.756466218154;51092.74453627782;51112.74443627758;51309.743451282506;51313.74343128261;51339.48660513422;14475.131492110508;14509.347079381454;14557.78163327551;14623.195724235056;14630.19533925623;11490.25313354646;11548.249363791327;11596.652100437;11652.592159274385;11672.474738636782;14534.854651453561;14554.417823287162;14668.55994320172;14697;14798.778018329735;5747.4252574742195;5829.708514574254;5860.208871802337;5877.441643043904;5883.882322353615;1009.7021378693303;1018.974525636865;1037.273908264218;1046.3198920701604;1055.3245922609535;22813.885930570574;22984.7701522986;23012.309630711105;23391.88304058469;23678.763212368;1093.4805967165532;1106.8616422947132;1134.4157758754247;1138.612871623652;1144.7653231087606;11823.88176118245;11885.28688278706;12211.938940305241;12254;12304.323262220663;229917;231756;231866;232023;232275;50599.24101138486;50622.24066639003;50711.239331410055;50724.23913641298;50735.746321268896;1448.5509492057497;1483.2880217495447;1499.6101013736507;1514.121809350574;1528.3428125905966;21698.132074716836;21901.89971041576;22329.330120096423;22604;22891.08435662555;36167.09582260464;36356;36388.27223455569;36433;36625;134592;135836;135951.32024339816;136216;136291;33295.33409331751;36959;37102.81448592848;37261;37721.62278377291;44908.550914490435;45701;45962;46427;46849.06301873875;31441.528377073904;33200.66799331976;33461.49807752837;34026.829865850515;34751;32617;33664.66335336615;33665;33800.49299260464;33932.830335848164;36958.815205924875;37626.81186594049;37689.81155094317;37717.62282377141;37874.62125378821;30868.536971945887;31388;33021.50467742938;33139;33229.83385083156;23324.6501302484;23933.042678292673;24202;24433.51132977366;24592.139275125286 15:06:26 INFO - PID 4824 | |2;jquery.html;566.7931205110136;570.116319704458;576.9942300576996;577.7746678795271;588.1677426441585;21647.567048659017;22410.32769016928;22509.54980900383;22545.09819607218;22629.434264143365;23734.762652373473;25909.22272331833;26188.345291367725;26199.08303209388;26285.737142628615;6508.642024688652;6624.867502649944;6660.300668429793;6669.266380698144;6678.465722742193;6530;6577;6595.20857497101;6622.205335359764;6623.3045530219115;6096.603720758137;6453.16108905844;6466.6766661666725;6527.249366322886;6599.868002639944;6356.68216589171;6498.3826536478955;6504.219493660744;6517.771877984248;6520.087187793689;6075.149479072889;6081.452669259788;6088.086786981944;6093.512518998469;6103.23709536308;27339.633018349203;28675.56986645202;28843.134705958644;28913.132606021853;29075;1953.179664540882;2011.989940050305;2014.7985201479735;2018.1927229108328;2024.0082359643816;18208.544786380313;18743.78165419257;18762.24951001958;18771.718424223647;18783.24867005318;2293.7362203346497;2316.073570571768;2333.9649905251435;2362.870042147681;2381.666566680666;118699.4065029678;122890;123787;124142;124261;13829.585112446643;14536.636584085483;14813.777793333109;14959.40162393492;15119.622009449631;23139;23235.651465228035;23257.7674223259;23344.182953596544;23359.53280934406;9453.196478299284;9510;9615.711528654152;9756.609735610497;9853.605855765833;8684.913150868411;8724.738257852274;8753.47479151253;8824.073472285447;8882;9045.366824322235;9068.45589264633;9104.81790364189;9128.771780705536;9285.25717942563;2682.195341397573;2736.370634754018;2742.9588556171675;2804.467151241258;2926.7415011544813;970.6748239339759;984.625842179967;989.3694366390846;1008.3647302199568;1031.138998935882;19210.327638532584;19757.40727778169;21705.34883953484;23617.763822361558;23920.641190382157;1046.9162467002623;1055.1137044882337;1056.1550759392455;1079.422508957704;1103.1450625764935;10556.524956376981;10564.683059508227;10999.945000274947;11177.72055698614;11349.489272982735;474197;501536;519473;536458;537447;108838.45580772046;109219;111404.99999999838;112194.87805122008;112758;1237.3874931908763;1270.7712611729792;1289.071868254855;1293.909426340147;1296.1834044551872;16552;17417.39039133624;17532.474025779247;17633.206505707018;17698.203580839152;49980;53251.733741331045;53458;56343.71828140833;56642;68380.31619683739;70005.64997174981;70209.29790702027;70251.64874175597;71884;17593.736093958345;17930.103494825467;18074;18194.090295484908;18213.726794098366;19387.4183774487;19716.901415493405;19763.703544447133;19950.50123746918;20029;15614.843851561793;15685.529434116996;15958.680826383175;16172.514824555283;16367.099809510592;13449.798253026016;13659.248741319323;13812.585622431343;14378.28108594587;14995.625109371917;16080.919595401949;16674.49976500707;16802.915985419993;16841.74737378916;16919.492415227563;18068.63862722712;18349.266029358678;18359.81640183581;18421.53946151357;18513.72229416587;15373.923130384277;16236.675266494367;16284.43004494837;16286.67426651484;16313.347466101697 15:06:26 INFO - PID 4824 | |3;mootools.html;1358.748631503172;1394.2401391241772;1405.5431984605;1420.112429731418;1420.8366037905637;13275.269860157687;13828.170309781408;13835.792463113035;13888.861111388884;13971.580852574427;13320.733585328311;13607.251601161932;14024;14117.29413529322;14143;2582.52223338682;2621.1874318961086;2624.501344744502;2625.2255584602494;2629.2243788082465;2494.550980823451;2557.6802899637546;2568.1653462624627;2574.4207553300544;2576.3945472813875;2432.866192359428;2535.9239222823344;2558.6417901493805;2584.508943300776;2586.5473542130144;2526.355779276282;2603.5053339865367;2613.8562379069144;2616.3982284074673;2616.8037397195285;2495.5757521221435;2519.4709111086695;2520.6975162980375;2529.8988040478357;2537.796976241896;13353.666158346023;13377.73244535104;13490.392932317971;13496.527621533298;13556.186628802303;6798.456123510107;7162.355388015104;7162.820929476753;7165.6775445105095;7166.3908567771805;4619.676622636417;4653.88365290867;5025.7235852028125;5042.823501177441;5073.188289873602;1757.8769486135975;1762.7708397908318;1793.3812834572052;1823.3253696132383;1830.8169183081718;22078.448038798997;22180.11279548816;22323.218687346027;22416.439589010242;22491.55016899669;5702.258706368229;5817.923684118452;5886.352501224862;5977.970110149508;6075.696215189223;15182.392704291704;15203.771943420857;15205.695886082216;15255.694886102216;15272.618184545476;7047.859042819115;7138.286171382821;7187.712491500386;7200.135983681992;7238.23998480152;6554.410103090745;6708.463322934251;6735.124433823572;6743.561668491532;6827.965860170667;4686.039361930796;4733.455652599926;4801.591864691471;4852.053849499384;4905.3132561441425;1290.6063650586661;1293.9353032348345;1304.5042883704132;1319.4722111155422;1335.619348485677;878.4026861733954;881.9823603527893;895.0825403960862;896.9596368163449;925.4539821505344;7241.52930059555;7846.176151504124;7960.044794624682;8079.5960201989665;8146.714864979697;701.7683765625259;723.3706675192616;739.9630018499054;740.3632875726871;748.4611080022376;4440.955590444119;5120.436751957282;5128.769205385766;5135.075686376488;5225.425203227642;17544.649107018042;17666.823331766518;18536.165872535767;18565.35021274249;18725.81274187268;18227.270909163486;18249.81750182481;18335.90832045858;18556.81443185578;19065.904670476837;10645.308054976556;10691.091257243066;10714;10805.729856753644;10805.891941080647;7637.121731001006;7737.497062690907;7750.341220996278;8016.759497215093;8152.510849349058;15124.243787810345;15632.140232287333;15710;15859.52421427359;15901.52295431139;15714.76427853606;16254.349826006828;16287.592810179367;16421.343146274015;16680.082595457367;10097.697069087939;10129.64546240878;10270.178385729274;10301.278910476494;10470.581176752845;12477.438515266653;12736.23582585048;12746.936265318614;12767.170133941265;12770.106092573802;10145.340552864336;10355.223358248311;10423.114035307084;10610.204234682275;10852.077573406348;9812.901870981199;10053.849192261976;10082.092611664692;10175.84736228972;10239.7440063999;8851.46891186531;8972.102789720975;9001.414908030956;9001.459912405277;9023;6750.6624668767345;7060.6469676517;7091.43268538526;7092.822679433056;7139.821504462222;6986.580805151707;7282;7338.816529586803;7377.483576149618;7385.29839665231 15:06:26 INFO - PID 4824 | |4;prototype.html;478.94971028042033;489.23923299269643;490.7374554613281;511.9718415487147;516.5325380530619;6320.652364119977;6327.905081423771;6329.2088488938825;6336.841578960528;6434.260060093091;5953.315368732597;6189.845253868655;6220.564560480768;6226.844328891769;6230.657313847737;5012.448630650625;5021.071101846161;5043.84868453947;5059.6964182149;5070.569001634865;5025.296458495814;5049.116404629193;5052.646314757969;5066.897237646373;5094.235864620318;5026.798928042874;5034;5047.369078865142;5049.747512624373;5056.79772809089;4829.275608658694;5032.597392208614;5037.244413337992;5041.369828771422;5045.747712614391;4488.910221795579;4508;4533.5013148553635;4535.659825513099;4549.909001819979;6061.909071363933;6115.357887421801;6118.479929205978;6126.172966649535;6148.139260503488;5753.590370359247;5772.826815195551;5776.249087618583;5777.959967205901;5803.578123359762;6663.900041499382;6669.466442684574;6672.666366681695;6678.165229346332;6682.264950855402;4888.388951381077;4923.138450771101;4928.926066109011;4956.157453232959;4957.801687932479;6894.517383783137;6930.480213983921;6959.478039147034;6974.965125174393;7005.614691191982;5096.464871188546;5096.980603879239;5103.157978933508;5112.821051263262;5115.18157094863;5175.146100893386;5177.430482646906;5178.533931946067;5180.870478238075;5197.168453047494;5820.708964551755;5823.56323275756;5828.213191219131;5838.416158384212;5840.620359676607;6751.683421732813;6771;6772.93227067723;6780.796576102724;6784;1688.1727953302793;1792.3726695656417;1797.2361746257789;1807.3493542324752;1809.6380723855282;1238.8885000350012;1239.1635645938954;1242.8188529131316;1243.8507379114565;1273.216971562501;5622.971885140548;5779.162021506858;5809.186713860063;5840.5035571976005;5845.649261044351;6702.530822842355;6721.361470660279;6831.69257383419;6842.623655698984;6875.3124687531845;5802.88394232113;5806.332271788714;5813.7383817728305;5815.924054050014;5853.560982926298;3590.281943611288;3609.3322735294055;3622.2574372253625;3628.639260277396;3630.9092272692865;6595.4393876521035;6596;6609.224125867051;6621.86756264872;6681.897486914605;6921.653917304216;6962.677091352627;6973.58158510491;6986.567753610498;6988.405985491188;6572.671366431659;6580.539362244597;6587.407133357925;6612.933870661232;6621.50338724588;6657.900131498128;6755.223149337692;6785.1518560179975;6785.558938669168;6820.215675197416;6620.801375958729;6733.932660673527;6757.729690812313;6764.5603035802515;6765.797026089225;6324.810255692337;6573.211214654272;6577.210734711865;6583.210014798255;6595.868082638224;5019.196928491424;5061.240813877947;5061.266116413026;5069.670471419346;5076.492350764894;6797.6941037654415;6811.761588344384;6825.624590647562;6842.760503382557;6847;6551.50863685216;6594.538382313192;6618.470522358296;6626.171728533934;6631.834204144742;6520.250171230369;6525.967370163119;6526.804195874131;6540.542162048801;6569.047488114292;6394.360563943755;6506.642134682638;6552.312007239171;6554.442872355903;6569.211694596679;6617.669116544057;6629.6353700545005;6634.800955971328;6670.032845237511;6683.097781799394;6369.649669268235;6405.423511883952;6445.871082578416;6461.838454038687;6491.188601424822 15:06:26 INFO - PID 4824 | |5;yui.html;901.9549022548875;911.1480765484273;922.5940586142093;926.1155596405433;937.0395344771606;17213.139343032846;18339.08304584772;18341.816581834177;18347.541311467205;18389.816101838995;15310.0813951163;15358.078515289062;15379.307931143125;16527.173641317917;17297.82702172978;1042.7653777899989;1064.435849000031;1065.0999905080196;1066.4188017530425;1066.9519871605758;1049.375621505203;1062.1237479079753;1065.4193464561833;1066.386827574144;1068.1134658233648;1114.6098865397087;1115.8995690387862;1125.4597793059336;1126.9943650281778;1128.7573171768067;1004.8090862736129;1028.4343611013912;1099.9065079468214;1123.1015187849728;1124.8144056230713;795.5982228974389;795.9084705258912;798.1539568057877;800.9799755006113;801.234820746186;18280.45158645243;18454.723179152323;18469.168887400097;18484.53788655281;18484.630307393913;17866;18857.717134242997;18932.71600925987;18991;19029.524261893424;14955.177465239407;15562.688746225012;15696.372145114181;15757.60605984848;15790.921045394814;3478.060923550627;3487.2153765402836;3513.4027215373194;3532.6114127445962;3536.681698647134;94535.52732236295;95939;96562;97107.51446242724;101598.49200754096;14030.368633411317;14131.788023179455;14365.13809171453;14372.856271437151;14457.277136143151;26414;27321.043763468184;27725.445491090468;27807.30481737973;28244;7862.921370786219;8030.678772849021;8035.477693949874;8037.678492860337;8074.959625201836;3844.7308688392104;3855.9614403855603;3968.722189446711;3976.5426975897562;4024.4566983457444;4671.15919134559;4728.1252968201;4731.053789242096;4754.23932170851;4754.334393184957;823.7816978500703;852.7100785732756;862.607513581319;864.3258258558335;864.8616221404545;623.6943897490197;656.8226578823691;691.8858388365963;702.7399862051074;711.7010855440727;10937.890621093688;11528.76942461146;11817.763644727058;11897.107716921266;12175.0868684849;657.3459407889085;660.8380946668098;666.4501786026451;682.5733916302311;687.8349196192878;5159.638825282269;5192.3769147702515;5297.920531191958;5306.177542480922;5310.486511344326;91156.54421727848;94734;95975.52012239894;96870.59990084283;98403.50798246106;68304.65847670729;84302.57848710717;84630;84995.5750221245;90363;66135.66932165308;71125;73475.63262183654;74971.25028749752;77014;12104.51581936748;12397.504099835905;12461.563845265373;12555.246685198917;12562.309073001074;31914.840425797724;33675.326493470486;34463.65536344604;34698.826505867306;35454.645453545134;42664.573354267304;43726.78136609297;44796.77601611971;45189.54810451985;46410.30384544302;15808.209589520708;15924.203789810232;15944.362225511313;16048.1173535452;16135.596610084373;15883;16277;16385;16504.83495165033;16683.66632667364;17554.91222543879;17730.5567360817;17851.553711156805;17867.106644667976;18148.455546333633;15302.61743456378;15354.769678454608;15354.84645153534;15382;15611.375544978073;15775.842241577897;16227.837721623106;16813.495595132164;16833.91583042077;17100.401485947932;12314.876851231373;12413.689657758629;12461.314627695201;12491.188072775603;12595.05537084704;11574.768504629692;11728.70678233051;11802.82295765547;11844.881551184379;11850.407479625812 15:06:26 INFO - PID 4824 | __end_tp_report 15:06:26 INFO - PID 4824 | __start_cc_report 15:06:26 INFO - PID 4824 | _x_x_mozilla_cycle_collect,363 15:06:26 INFO - PID 4824 | __end_cc_report 15:06:26 INFO - PID 4824 | __startTimestamp1498687586723__endTimestamp 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | ------- Summary: start ------- 15:06:26 INFO - PID 4824 | Number of tests: 6 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#0] dojo.html Cycles:165 Average:6107.08 Median:6321.12 stddev:713.77 (11.3%) stddev-sans-first:674.45 15:06:26 INFO - PID 4824 | Values: 3049.1 3078.3 3103.4 3112.1 3119.0 6026.7 6089.3 6112.2 6116.2 6147.0 6147.7 6198.3 6206.1 6209.2 6222.1 5703.3 5719.9 5787.6 5791.4 5823.9 5544.9 5707.9 5712.7 5721.2 5727.0 5600.9 5600.9 5610.6 5612.3 5627.8 5688.2 5702.1 5732.9 5757.9 5783.3 5666.8 5697.2 5713.3 5716.4 5718.8 6104.3 6146.5 6168.7 6173.1 6212.8 6446.3 6447.5 6507.2 6518.2 6739.3 6632.7 6639.0 6642.2 6643.7 6687.5 6110.1 6168.6 6175.0 6175.4 6187.2 6623.4 6731.8 6733.7 6769.2 6775.6 6359.8 6387.5 6486.0 6505.9 6510.2 6655.0 6666.8 6684.6 6689.5 6691.3 6415.2 6520.1 6525.9 6630.1 6667.2 6425.8 6533.8 6549.9 6550.9 6582.5 5374.5 5440.5 5473.2 5478.3 5480.3 4577.8 4593.2 4593.4 4595.4 4632.0 5798.5 5807.6 5809.1 5813.1 5814.2 6421.6 6448.4 6539.6 6555.0 6693.1 5718.3 5728.6 5781.6 5791.1 5799.3 5820.7 5876.9 5976.3 5999.6 6000.8 6534.1 6539.8 6547.4 6550.8 6576.3 6721.4 6727.6 6744.8 6752.9 6753.5 6286.2 6353.7 6372.6 6509.7 6518.6 6349.1 6407.8 6467.6 6487.1 6502.5 6696.0 6801.5 6804.1 6808.7 6820.0 6298.2 6561.6 6572.3 6572.7 6595.6 6321.1 6451.6 6476.5 6481.8 6492.5 6363.2 6397.6 6440.2 6480.7 6494.1 6517.9 6531.4 6532.7 6535.3 6570.4 6207.3 6209.4 6294.5 6295.6 6305.5 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#1] ext.html Cycles:180 Average:35655.78 Median:34388.91 stddev:49550.65 (144.1%) stddev-sans-first:49620.40 15:06:26 INFO - PID 4824 | Values: 767.7 791.7 821.9 848.4 851.6 40847.8 41606.4 41632.0 41640.8 41880.6 36425.8 36487.6 36561.0 36807.3 36808.0 6822.4 6890.8 6930.1 6941.9 6960.7 6849.6 6891.6 6933.7 6936.4 6950.8 6870.9 6918.6 6924.8 6925.2 6941.2 6904.0 6941.9 6942.4 6947.3 6951.3 6253.7 6255.7 6266.2 6271.2 6285.7 33314.8 33471.7 33555.0 33583.2 33592.0 3354.2 3562.3 3662.2 3670.2 3678.6 31320.5 31519.4 31656.4 31668.5 31693.5 4709.7 4947.3 4965.6 5046.3 5052.6 188970.0 190271.0 191171.0 193605.0 194822.0 48214.8 48455.8 48493.5 48565.0 48706.8 51092.7 51112.7 51309.7 51313.7 51339.5 14475.1 14509.3 14557.8 14623.2 14630.2 11490.3 11548.2 11596.7 11652.6 11672.5 14534.9 14554.4 14668.6 14697.0 14798.8 5747.4 5829.7 5860.2 5877.4 5883.9 1009.7 1019.0 1037.3 1046.3 1055.3 22813.9 22984.8 23012.3 23391.9 23678.8 1093.5 1106.9 1134.4 1138.6 1144.8 11823.9 11885.3 12211.9 12254.0 12304.3 229917.0 231756.0 231866.0 232023.0 232275.0 50599.2 50622.2 50711.2 50724.2 50735.7 1448.6 1483.3 1499.6 1514.1 1528.3 21698.1 21901.9 22329.3 22604.0 22891.1 36167.1 36356.0 36388.3 36433.0 36625.0 134592.0 135836.0 135951.3 136216.0 136291.0 33295.3 36959.0 37102.8 37261.0 37721.6 44908.6 45701.0 45962.0 46427.0 46849.1 31441.5 33200.7 33461.5 34026.8 34751.0 32617.0 33664.7 33665.0 33800.5 33932.8 36958.8 37626.8 37689.8 37717.6 37874.6 30868.5 31388.0 33021.5 33139.0 33229.8 23324.7 23933.0 24202.0 24433.5 24592.1 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#2] jquery.html Cycles:180 Average:34564.49 Median:12716.37 stddev:85755.46 (674.4%) stddev-sans-first:85958.03 15:06:26 INFO - PID 4824 | Values: 566.8 570.1 577.0 577.8 588.2 21647.6 22410.3 22509.5 22545.1 22629.4 23734.8 25909.2 26188.3 26199.1 26285.7 6508.6 6624.9 6660.3 6669.3 6678.5 6530.0 6577.0 6595.2 6622.2 6623.3 6096.6 6453.2 6466.7 6527.2 6599.9 6356.7 6498.4 6504.2 6517.8 6520.1 6075.1 6081.5 6088.1 6093.5 6103.2 27339.6 28675.6 28843.1 28913.1 29075.0 1953.2 2012.0 2014.8 2018.2 2024.0 18208.5 18743.8 18762.2 18771.7 18783.2 2293.7 2316.1 2334.0 2362.9 2381.7 118699.4 122890.0 123787.0 124142.0 124261.0 13829.6 14536.6 14813.8 14959.4 15119.6 23139.0 23235.7 23257.8 23344.2 23359.5 9453.2 9510.0 9615.7 9756.6 9853.6 8684.9 8724.7 8753.5 8824.1 8882.0 9045.4 9068.5 9104.8 9128.8 9285.3 2682.2 2736.4 2743.0 2804.5 2926.7 970.7 984.6 989.4 1008.4 1031.1 19210.3 19757.4 21705.3 23617.8 23920.6 1046.9 1055.1 1056.2 1079.4 1103.1 10556.5 10564.7 10999.9 11177.7 11349.5 474197.0 501536.0 519473.0 536458.0 537447.0 108838.5 109219.0 111405.0 112194.9 112758.0 1237.4 1270.8 1289.1 1293.9 1296.2 16552.0 17417.4 17532.5 17633.2 17698.2 49980.0 53251.7 53458.0 56343.7 56642.0 68380.3 70005.6 70209.3 70251.6 71884.0 17593.7 17930.1 18074.0 18194.1 18213.7 19387.4 19716.9 19763.7 19950.5 20029.0 15614.8 15685.5 15958.7 16172.5 16367.1 13449.8 13659.2 13812.6 14378.3 14995.6 16080.9 16674.5 16802.9 16841.7 16919.5 18068.6 18349.3 18359.8 18421.5 18513.7 15373.9 16236.7 16284.4 16286.7 16313.3 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#3] mootools.html Cycles:180 Average:8358.77 Median:2532.91 stddev:5675.66 (224.1%) stddev-sans-first:5667.21 15:06:26 INFO - PID 4824 | Values: 1358.7 1394.2 1405.5 1420.1 1420.8 13275.3 13828.2 13835.8 13888.9 13971.6 13320.7 13607.3 14024.0 14117.3 14143.0 2582.5 2621.2 2624.5 2625.2 2629.2 2494.6 2557.7 2568.2 2574.4 2576.4 2432.9 2535.9 2558.6 2584.5 2586.5 2526.4 2603.5 2613.9 2616.4 2616.8 2495.6 2519.5 2520.7 2529.9 2537.8 13353.7 13377.7 13490.4 13496.5 13556.2 6798.5 7162.4 7162.8 7165.7 7166.4 4619.7 4653.9 5025.7 5042.8 5073.2 1757.9 1762.8 1793.4 1823.3 1830.8 22078.4 22180.1 22323.2 22416.4 22491.6 5702.3 5817.9 5886.4 5978.0 6075.7 15182.4 15203.8 15205.7 15255.7 15272.6 7047.9 7138.3 7187.7 7200.1 7238.2 6554.4 6708.5 6735.1 6743.6 6828.0 4686.0 4733.5 4801.6 4852.1 4905.3 1290.6 1293.9 1304.5 1319.5 1335.6 878.4 882.0 895.1 897.0 925.5 7241.5 7846.2 7960.0 8079.6 8146.7 701.8 723.4 740.0 740.4 748.5 4441.0 5120.4 5128.8 5135.1 5225.4 17544.6 17666.8 18536.2 18565.4 18725.8 18227.3 18249.8 18335.9 18556.8 19065.9 10645.3 10691.1 10714.0 10805.7 10805.9 7637.1 7737.5 7750.3 8016.8 8152.5 15124.2 15632.1 15710.0 15859.5 15901.5 15714.8 16254.3 16287.6 16421.3 16680.1 10097.7 10129.6 10270.2 10301.3 10470.6 12477.4 12736.2 12746.9 12767.2 12770.1 10145.3 10355.2 10423.1 10610.2 10852.1 9812.9 10053.8 10082.1 10175.8 10239.7 8851.5 8972.1 9001.4 9001.5 9023.0 6750.7 7060.6 7091.4 7092.8 7139.8 6986.6 7282.0 7338.8 7377.5 7385.3 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#4] prototype.html Cycles:180 Average:5579.73 Median:6168.99 stddev:1564.85 (25.4%) stddev-sans-first:1521.69 15:06:26 INFO - PID 4824 | Values: 478.9 489.2 490.7 512.0 516.5 6320.7 6327.9 6329.2 6336.8 6434.3 5953.3 6189.8 6220.6 6226.8 6230.7 5012.4 5021.1 5043.8 5059.7 5070.6 5025.3 5049.1 5052.6 5066.9 5094.2 5026.8 5034.0 5047.4 5049.7 5056.8 4829.3 5032.6 5037.2 5041.4 5045.7 4488.9 4508.0 4533.5 4535.7 4549.9 6061.9 6115.4 6118.5 6126.2 6148.1 5753.6 5772.8 5776.2 5778.0 5803.6 6663.9 6669.5 6672.7 6678.2 6682.3 4888.4 4923.1 4928.9 4956.2 4957.8 6894.5 6930.5 6959.5 6975.0 7005.6 5096.5 5097.0 5103.2 5112.8 5115.2 5175.1 5177.4 5178.5 5180.9 5197.2 5820.7 5823.6 5828.2 5838.4 5840.6 6751.7 6771.0 6772.9 6780.8 6784.0 1688.2 1792.4 1797.2 1807.3 1809.6 1238.9 1239.2 1242.8 1243.9 1273.2 5623.0 5779.2 5809.2 5840.5 5845.6 6702.5 6721.4 6831.7 6842.6 6875.3 5802.9 5806.3 5813.7 5815.9 5853.6 3590.3 3609.3 3622.3 3628.6 3630.9 6595.4 6596.0 6609.2 6621.9 6681.9 6921.7 6962.7 6973.6 6986.6 6988.4 6572.7 6580.5 6587.4 6612.9 6621.5 6657.9 6755.2 6785.2 6785.6 6820.2 6620.8 6733.9 6757.7 6764.6 6765.8 6324.8 6573.2 6577.2 6583.2 6595.9 5019.2 5061.2 5061.3 5069.7 5076.5 6797.7 6811.8 6825.6 6842.8 6847.0 6551.5 6594.5 6618.5 6626.2 6631.8 6520.3 6526.0 6526.8 6540.5 6569.0 6394.4 6506.6 6552.3 6554.4 6569.2 6617.7 6629.6 6634.8 6670.0 6683.1 6369.6 6405.4 6445.9 6461.8 6491.2 15:06:26 INFO - PID 4824 | 15:06:26 INFO - PID 4824 | [#5] yui.html Cycles:180 Average:19969.87 Median:18484.58 stddev:25919.80 (140.2%) stddev-sans-first:25952.97 15:06:26 INFO - PID 4824 | Values: 902.0 911.1 922.6 926.1 937.0 17213.1 18339.1 18341.8 18347.5 18389.8 15310.1 15358.1 15379.3 16527.2 17297.8 1042.8 1064.4 1065.1 1066.4 1067.0 1049.4 1062.1 1065.4 1066.4 1068.1 1114.6 1115.9 1125.5 1127.0 1128.8 1004.8 1028.4 1099.9 1123.1 1124.8 795.6 795.9 798.2 801.0 801.2 18280.5 18454.7 18469.2 18484.5 18484.6 17866.0 18857.7 18932.7 18991.0 19029.5 14955.2 15562.7 15696.4 15757.6 15790.9 3478.1 3487.2 3513.4 3532.6 3536.7 94535.5 95939.0 96562.0 97107.5 101598.5 14030.4 14131.8 14365.1 14372.9 14457.3 26414.0 27321.0 27725.4 27807.3 28244.0 7862.9 8030.7 8035.5 8037.7 8075.0 3844.7 3856.0 3968.7 3976.5 4024.5 4671.2 4728.1 4731.1 4754.2 4754.3 823.8 852.7 862.6 864.3 864.9 623.7 656.8 691.9 702.7 711.7 10937.9 11528.8 11817.8 11897.1 12175.1 657.3 660.8 666.5 682.6 687.8 5159.6 5192.4 5297.9 5306.2 5310.5 91156.5 94734.0 95975.5 96870.6 98403.5 68304.7 84302.6 84630.0 84995.6 90363.0 66135.7 71125.0 73475.6 74971.3 77014.0 12104.5 12397.5 12461.6 12555.2 12562.3 31914.8 33675.3 34463.7 34698.8 35454.6 42664.6 43726.8 44796.8 45189.5 46410.3 15808.2 15924.2 15944.4 16048.1 16135.6 15883.0 16277.0 16385.0 16504.8 16683.7 17554.9 17730.6 17851.6 17867.1 18148.5 15302.6 15354.8 15354.8 15382.0 15611.4 15775.8 16227.8 16813.5 16833.9 17100.4 12314.9 12413.7 12461.3 12491.2 12595.1 11574.8 11728.7 11802.8 11844.9 11850.4 15:06:26 INFO - PID 4824 | -------- Summary: end -------- 15:06:26 INFO - PID 4824 | 15:06:27 INFO - TEST-INFO | 4824: exit 0 15:06:27 INFO - TEST-OK | dromaeo_css | took 1116523ms 15:06:27 INFO - TEST-START | kraken 15:06:27 INFO - operating with platform_type : linux_ 15:06:27 INFO - Initialising browser for kraken test... 15:06:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49488/getInfo.html -profile /tmp/tmpJ6lb0n/profile 15:06:27 INFO - TEST-INFO | started process 5236 (/builds/slave/test/build/application/firefox/firefox http://localhost:49488/getInfo.html) 15:06:33 INFO - TEST-INFO | 5236: exit 0 15:06:33 INFO - Browser initialized. 15:06:33 INFO - Running cycle 1/1 for kraken test... 15:06:33 INFO - TEST-INFO | started process 5456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ6lb0n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:06:44 INFO - PID 5456 | RSS: Main: 172036096 15:06:44 INFO - PID 5456 | 15:06:47 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection) 15:06:48 INFO - PID 5456 | RSS: Main: 176664576 15:06:48 INFO - PID 5456 | 15:06:51 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-dft) 15:06:51 INFO - PID 5456 | RSS: Main: 177430528 15:06:51 INFO - PID 5456 | 15:06:54 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-fft) 15:06:55 INFO - PID 5456 | RSS: Main: 172269568 15:06:55 INFO - PID 5456 | 15:06:57 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator) 15:06:58 INFO - PID 5456 | RSS: Main: 172822528 15:06:58 INFO - PID 5456 | 15:07:00 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:07:00 INFO - PID 5456 | RSS: Main: 172941312 15:07:00 INFO - PID 5456 | 15:07:03 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom) 15:07:04 INFO - PID 5456 | RSS: Main: 176308224 15:07:04 INFO - PID 5456 | 15:07:07 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate) 15:07:08 INFO - PID 5456 | RSS: Main: 177627136 15:07:08 INFO - PID 5456 | 15:07:11 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial) 15:07:11 INFO - PID 5456 | RSS: Main: 177078272 15:07:11 INFO - PID 5456 | 15:07:13 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:07:14 INFO - PID 5456 | RSS: Main: 176787456 15:07:14 INFO - PID 5456 | 15:07:15 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:07:16 INFO - PID 5456 | RSS: Main: 177131520 15:07:16 INFO - PID 5456 | 15:07:18 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:07:19 INFO - PID 5456 | RSS: Main: 177590272 15:07:19 INFO - PID 5456 | 15:07:21 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:07:22 INFO - PID 5456 | RSS: Main: 177025024 15:07:22 INFO - PID 5456 | 15:07:25 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:07:26 INFO - PID 5456 | RSS: Main: 177176576 15:07:26 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:49488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49488/tests/kraken/driver.html?testName=ai-astar) 15:07:28 INFO - PID 5456 | RSS: Main: 178688000 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | __start_tp_report 15:07:28 INFO - PID 5456 | _x_x_mozilla_page_load 15:07:28 INFO - PID 5456 | _x_x_mozilla_page_load_details 15:07:28 INFO - PID 5456 | |i|pagename|runs| 15:07:28 INFO - PID 5456 | |0;ai-astar;100;107;109;107;108;108;110;110;109;110 15:07:28 INFO - PID 5456 | |1;audio-beat-detection;144;119;150;185;122;152;154;125;172;121 15:07:28 INFO - PID 5456 | |2;audio-dft;163;162;162;162;161;172;162;164;164;171 15:07:28 INFO - PID 5456 | |3;audio-fft;74;75;74;164;75;75;75;74;106;75 15:07:28 INFO - PID 5456 | |4;audio-oscillator;82;82;139;81;82;82;138;83;81;129 15:07:28 INFO - PID 5456 | |5;imaging-gaussian-blur;114;115;114;113;114;114;115;114;113;114 15:07:28 INFO - PID 5456 | |6;imaging-darkroom;150;150;148;150;150;149;150;150;149;150 15:07:28 INFO - PID 5456 | |7;imaging-desaturate;94;94;94;94;95;95;95;94;94;94 15:07:28 INFO - PID 5456 | |8;json-parse-financial;53;59;53;53;57;57;54;59;52;54 15:07:28 INFO - PID 5456 | |9;json-stringify-tinderbox;54;54;53;53;53;54;54;54;54;53 15:07:28 INFO - PID 5456 | |10;stanford-crypto-aes;78;86;77;80;76;78;76;77;90;77 15:07:28 INFO - PID 5456 | |11;stanford-crypto-ccm;129;136;128;138;141;148;128;124;136;160 15:07:28 INFO - PID 5456 | |12;stanford-crypto-pbkdf2;189;185;192;185;179;188;184;184;180;194 15:07:28 INFO - PID 5456 | |13;stanford-crypto-sha256-iterative;68;72;67;70;66;68;72;65;67;74 15:07:28 INFO - PID 5456 | __end_tp_report 15:07:28 INFO - PID 5456 | __start_cc_report 15:07:28 INFO - PID 5456 | _x_x_mozilla_cycle_collect,906 15:07:28 INFO - PID 5456 | __end_cc_report 15:07:28 INFO - PID 5456 | __startTimestamp1498687648254__endTimestamp 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | ------- Summary: start ------- 15:07:28 INFO - PID 5456 | Number of tests: 14 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.00 stddev:2.97 (2.7%) stddev-sans-first:1.22 15:07:28 INFO - PID 5456 | Values: 100.0 107.0 109.0 107.0 108.0 108.0 110.0 110.0 109.0 110.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:151.00 stddev:22.76 (15.1%) stddev-sans-first:24.14 15:07:28 INFO - PID 5456 | Values: 144.0 119.0 150.0 185.0 122.0 152.0 154.0 125.0 172.0 121.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.92 (2.4%) stddev-sans-first:4.13 15:07:28 INFO - PID 5456 | Values: 163.0 162.0 162.0 162.0 161.0 172.0 162.0 164.0 164.0 171.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#3] audio-fft Cycles:10 Average:86.70 Median:75.00 stddev:28.90 (38.5%) stddev-sans-first:30.28 15:07:28 INFO - PID 5456 | Values: 74.0 75.0 74.0 164.0 75.0 75.0 75.0 74.0 106.0 75.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:82.00 stddev:25.97 (31.7%) stddev-sans-first:26.90 15:07:28 INFO - PID 5456 | Values: 82.0 82.0 139.0 81.0 82.0 82.0 138.0 83.0 81.0 129.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 15:07:28 INFO - PID 5456 | Values: 114.0 115.0 114.0 113.0 114.0 114.0 115.0 114.0 113.0 114.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:07:28 INFO - PID 5456 | Values: 150.0 150.0 148.0 150.0 150.0 149.0 150.0 150.0 149.0 150.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 15:07:28 INFO - PID 5456 | Values: 94.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:2.64 (4.8%) stddev-sans-first:2.69 15:07:28 INFO - PID 5456 | Values: 53.0 59.0 53.0 53.0 57.0 57.0 54.0 59.0 52.0 54.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#9] json-stringify-tinderbox Cycles:10 Average:53.60 Median:54.00 stddev:0.52 (1.0%) stddev-sans-first:0.53 15:07:28 INFO - PID 5456 | Values: 54.0 54.0 53.0 53.0 53.0 54.0 54.0 54.0 54.0 53.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:78.00 stddev:4.72 (6.1%) stddev-sans-first:4.97 15:07:28 INFO - PID 5456 | Values: 78.0 86.0 77.0 80.0 76.0 78.0 76.0 77.0 90.0 77.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.00 stddev:10.87 (7.9%) stddev-sans-first:11.16 15:07:28 INFO - PID 5456 | Values: 129.0 136.0 128.0 138.0 141.0 148.0 128.0 124.0 136.0 160.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.00 Median:186.50 stddev:4.81 (2.6%) stddev-sans-first:4.97 15:07:28 INFO - PID 5456 | Values: 189.0 185.0 192.0 185.0 179.0 188.0 184.0 184.0 180.0 194.0 15:07:28 INFO - PID 5456 | 15:07:28 INFO - PID 5456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.96 (4.3%) stddev-sans-first:3.12 15:07:28 INFO - PID 5456 | Values: 68.0 72.0 67.0 70.0 66.0 68.0 72.0 65.0 67.0 74.0 15:07:28 INFO - PID 5456 | -------- Summary: end -------- 15:07:28 INFO - PID 5456 | 15:07:28 INFO - TEST-INFO | 5456: exit 0 15:07:29 INFO - TEST-OK | kraken | took 61713ms 15:07:29 INFO - SUITE-END | took 1178s 15:07:29 INFO - Completed test suite (00:19:38) 15:07:29 INFO - javascript benchmark 15:07:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8214.601204870323, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.1157564306354, 3078.322768990822, 3103.394838006588, 3112.066380085974, 3119.033099739081, 6026.728797204125, 6089.330173680892, 6112.199536562809, 6116.244470650287, 6147.0164773636225, 6147.661878596687, 6198.318184999646, 6206.069089636557, 6209.192804935364, 6222.12890195373, 5703.287089113871, 5719.8570035749235, 5787.623804452718, 5791.420857914217, 5823.912641310384, 5544.944550554484, 5707.914381284284, 5712.685802280873, 5721.170430287606, 5726.971365143189, 5600.859978500529, 5600.943990560083, 5610.579206559524, 5612.270404847384, 5627.774889004435, 5688.175214593902, 5702.059160238556, 5732.856678583027, 5757.913631295534, 5783.277090363705, 5666.801661941853, 5697.230873832021, 5713.285839270091, 5716.371199168088, 5718.828435146952, 6104.267487901436, 6146.477549408306, 6168.660723660197, 6173.135760993465, 6212.81361559154, 6446.290908000116, 6447.54867159299, 6507.2191337039385, 6518.185226846645, 6739.326067393222, 6632.701528431232, 6638.966805165944, 6642.202935647705, 6643.667816609151, 6687.49843761715, 6110.077186749992, 6168.629882207082, 6174.969125154345, 6175.382461753788, 6187.226596675416, 6623.4038936495945, 6731.798046058626, 6733.730650773914, 6769.22153952292, 6775.62734049632, 6359.777407790705, 6387.457066149336, 6486.027095935648, 6505.934940650627, 6510.153680021662, 6655.0, 6666.83332916681, 6684.598924064474, 6689.4982876284475, 6691.330866913367, 6415.1981002374705, 6520.119783829217, 6525.869482610321, 6630.071789949411, 6667.233268174125, 6425.807225783141, 6533.836654083686, 6549.9345006550275, 6550.868982620416, 6582.506312026617, 5374.543163831118, 5440.483154100354, 5473.17902314656, 5478.342598888079, 5480.26016487777, 4577.793999270041, 4593.19619066662, 4593.425821772278, 4595.379623750818, 4631.95368046322, 5798.5071268941765, 5807.593468457252, 5809.128630705428, 5813.128030795415, 5814.215080964101, 6421.646809425433, 6448.355164483608, 6539.574927629689, 6554.967225163844, 6693.096431981718, 5718.285214348207, 5728.570357223225, 5781.5952883298605, 5791.131330300404, 5799.2750906136735, 5820.679862607512, 5876.911846322223, 5976.312724036705, 5999.610025348338, 6000.849978750479, 6534.1178940844275, 6539.836504087436, 6547.377999090078, 6550.836229094215, 6576.309487503839, 6721.428678562182, 6727.596344219362, 6744.7976560703255, 6752.864942701217, 6753.527253092237, 6286.18279623646, 6353.650549219652, 6372.617642941438, 6509.7396104155305, 6518.57629254097, 6349.079383489276, 6407.775727849503, 6467.611943283418, 6487.124238227968, 6502.544821862613, 6695.9665201675625, 6801.455883529206, 6804.11546498952, 6808.7276508939085, 6820.0, 6298.1812364392335, 6561.606303621798, 6572.342765723581, 6572.737090516326, 6595.571287866465, 6321.11504389395, 6451.612903225821, 6476.481881449378, 6481.837954051187, 6492.5455218134275, 6363.236411630634, 6397.552171348148, 6440.227172739301, 6480.740770369132, 6494.058361537645, 6517.902231466437, 6531.444827189742, 6532.673366331569, 6535.3137920517665, 6570.408663220333, 6207.348228435949, 6209.379062093754, 6294.527910406646, 6295.622262664255, 6305.5270854687], "value": 6053.20878022575, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.6814122139313, 791.6516732637642, 821.8643923752581, 848.4188330993268, 851.6337974670893, 40847.795761021225, 41606.375904361455, 41632.0, 41640.79179604101, 41880.581194188126, 36425.81787091061, 36487.63512364875, 36561.0, 36807.26385472296, 36808.0, 6822.351876571718, 6890.827729306782, 6930.064441300436, 6941.861162776741, 6960.721571137148, 6849.589024658511, 6891.586504809702, 6933.72265109395, 6936.445084393236, 6950.756723514678, 6870.931290687104, 6918.550294230884, 6924.792256232321, 6925.238223795379, 6941.167059952812, 6904.0, 6941.930580694229, 6942.409895158918, 6947.270536593635, 6951.304869513034, 6253.7185826637915, 6255.718492667841, 6266.185395898504, 6271.153394291758, 6285.654289014103, 33314.833425832956, 33471.6652833471, 33555.0, 33583.16042098943, 33592.0, 3354.2117602363423, 3562.305350456662, 3662.230931504387, 3670.210904655485, 3678.6321367863266, 31320.53019204714, 31519.36961260762, 31656.366872662416, 31668.524972125437, 31693.52459713106, 4709.7174169549935, 4947.307376967192, 4965.602751779849, 5046.26829109777, 5052.570531504826, 188970.0, 190271.0, 191171.0, 193605.0, 194822.0, 48214.75892620515, 48455.75772121117, 48493.5150648489, 48565.0, 48706.756466218154, 51092.74453627782, 51112.74443627758, 51309.743451282506, 51313.74343128261, 51339.48660513422, 14475.131492110508, 14509.347079381454, 14557.78163327551, 14623.195724235056, 14630.19533925623, 11490.25313354646, 11548.249363791327, 11596.652100437, 11652.592159274385, 11672.474738636782, 14534.854651453561, 14554.417823287162, 14668.55994320172, 14697.0, 14798.778018329735, 5747.4252574742195, 5829.708514574254, 5860.208871802337, 5877.441643043904, 5883.882322353615, 1009.7021378693303, 1018.974525636865, 1037.273908264218, 1046.3198920701604, 1055.3245922609535, 22813.885930570574, 22984.7701522986, 23012.309630711105, 23391.88304058469, 23678.763212368, 1093.4805967165532, 1106.8616422947132, 1134.4157758754247, 1138.612871623652, 1144.7653231087606, 11823.88176118245, 11885.28688278706, 12211.938940305241, 12254.0, 12304.323262220663, 229917.0, 231756.0, 231866.0, 232023.0, 232275.0, 50599.24101138486, 50622.24066639003, 50711.239331410055, 50724.23913641298, 50735.746321268896, 1448.5509492057497, 1483.2880217495447, 1499.6101013736507, 1514.121809350574, 1528.3428125905966, 21698.132074716836, 21901.89971041576, 22329.330120096423, 22604.0, 22891.08435662555, 36167.09582260464, 36356.0, 36388.27223455569, 36433.0, 36625.0, 134592.0, 135836.0, 135951.32024339816, 136216.0, 136291.0, 33295.33409331751, 36959.0, 37102.81448592848, 37261.0, 37721.62278377291, 44908.550914490435, 45701.0, 45962.0, 46427.0, 46849.06301873875, 31441.528377073904, 33200.66799331976, 33461.49807752837, 34026.829865850515, 34751.0, 32617.0, 33664.66335336615, 33665.0, 33800.49299260464, 33932.830335848164, 36958.815205924875, 37626.81186594049, 37689.81155094317, 37717.62282377141, 37874.62125378821, 30868.536971945887, 31388.0, 33021.50467742938, 33139.0, 33229.83385083156, 23324.6501302484, 23933.042678292673, 24202.0, 24433.51132977366, 24592.139275125286], "value": 16576.20509581437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7931205110136, 570.116319704458, 576.9942300576996, 577.7746678795271, 588.1677426441585, 21647.567048659017, 22410.32769016928, 22509.54980900383, 22545.09819607218, 22629.434264143365, 23734.762652373473, 25909.22272331833, 26188.345291367725, 26199.08303209388, 26285.737142628615, 6508.642024688652, 6624.867502649944, 6660.300668429793, 6669.266380698144, 6678.465722742193, 6530.0, 6577.0, 6595.20857497101, 6622.205335359764, 6623.3045530219115, 6096.603720758137, 6453.16108905844, 6466.6766661666725, 6527.249366322886, 6599.868002639944, 6356.68216589171, 6498.3826536478955, 6504.219493660744, 6517.771877984248, 6520.087187793689, 6075.149479072889, 6081.452669259788, 6088.086786981944, 6093.512518998469, 6103.23709536308, 27339.633018349203, 28675.56986645202, 28843.134705958644, 28913.132606021853, 29075.0, 1953.179664540882, 2011.989940050305, 2014.7985201479735, 2018.1927229108328, 2024.0082359643816, 18208.544786380313, 18743.78165419257, 18762.24951001958, 18771.718424223647, 18783.24867005318, 2293.7362203346497, 2316.073570571768, 2333.9649905251435, 2362.870042147681, 2381.666566680666, 118699.4065029678, 122890.0, 123787.0, 124142.0, 124261.0, 13829.585112446643, 14536.636584085483, 14813.777793333109, 14959.40162393492, 15119.622009449631, 23139.0, 23235.651465228035, 23257.7674223259, 23344.182953596544, 23359.53280934406, 9453.196478299284, 9510.0, 9615.711528654152, 9756.609735610497, 9853.605855765833, 8684.913150868411, 8724.738257852274, 8753.47479151253, 8824.073472285447, 8882.0, 9045.366824322235, 9068.45589264633, 9104.81790364189, 9128.771780705536, 9285.25717942563, 2682.195341397573, 2736.370634754018, 2742.9588556171675, 2804.467151241258, 2926.7415011544813, 970.6748239339759, 984.625842179967, 989.3694366390846, 1008.3647302199568, 1031.138998935882, 19210.327638532584, 19757.40727778169, 21705.34883953484, 23617.763822361558, 23920.641190382157, 1046.9162467002623, 1055.1137044882337, 1056.1550759392455, 1079.422508957704, 1103.1450625764935, 10556.524956376981, 10564.683059508227, 10999.945000274947, 11177.72055698614, 11349.489272982735, 474197.0, 501536.0, 519473.0, 536458.0, 537447.0, 108838.45580772046, 109219.0, 111404.99999999838, 112194.87805122008, 112758.0, 1237.3874931908763, 1270.7712611729792, 1289.071868254855, 1293.909426340147, 1296.1834044551872, 16552.0, 17417.39039133624, 17532.474025779247, 17633.206505707018, 17698.203580839152, 49980.0, 53251.733741331045, 53458.0, 56343.71828140833, 56642.0, 68380.31619683739, 70005.64997174981, 70209.29790702027, 70251.64874175597, 71884.0, 17593.736093958345, 17930.103494825467, 18074.0, 18194.090295484908, 18213.726794098366, 19387.4183774487, 19716.901415493405, 19763.703544447133, 19950.50123746918, 20029.0, 15614.843851561793, 15685.529434116996, 15958.680826383175, 16172.514824555283, 16367.099809510592, 13449.798253026016, 13659.248741319323, 13812.585622431343, 14378.28108594587, 14995.625109371917, 16080.919595401949, 16674.49976500707, 16802.915985419993, 16841.74737378916, 16919.492415227563, 18068.63862722712, 18349.266029358678, 18359.81640183581, 18421.53946151357, 18513.72229416587, 15373.923130384277, 16236.675266494367, 16284.43004494837, 16286.67426651484, 16313.347466101697], "value": 11802.412265457544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.748631503172, 1394.2401391241772, 1405.5431984605, 1420.112429731418, 1420.8366037905637, 13275.269860157687, 13828.170309781408, 13835.792463113035, 13888.861111388884, 13971.580852574427, 13320.733585328311, 13607.251601161932, 14024.0, 14117.29413529322, 14143.0, 2582.52223338682, 2621.1874318961086, 2624.501344744502, 2625.2255584602494, 2629.2243788082465, 2494.550980823451, 2557.6802899637546, 2568.1653462624627, 2574.4207553300544, 2576.3945472813875, 2432.866192359428, 2535.9239222823344, 2558.6417901493805, 2584.508943300776, 2586.5473542130144, 2526.355779276282, 2603.5053339865367, 2613.8562379069144, 2616.3982284074673, 2616.8037397195285, 2495.5757521221435, 2519.4709111086695, 2520.6975162980375, 2529.8988040478357, 2537.796976241896, 13353.666158346023, 13377.73244535104, 13490.392932317971, 13496.527621533298, 13556.186628802303, 6798.456123510107, 7162.355388015104, 7162.820929476753, 7165.6775445105095, 7166.3908567771805, 4619.676622636417, 4653.88365290867, 5025.7235852028125, 5042.823501177441, 5073.188289873602, 1757.8769486135975, 1762.7708397908318, 1793.3812834572052, 1823.3253696132383, 1830.8169183081718, 22078.448038798997, 22180.11279548816, 22323.218687346027, 22416.439589010242, 22491.55016899669, 5702.258706368229, 5817.923684118452, 5886.352501224862, 5977.970110149508, 6075.696215189223, 15182.392704291704, 15203.771943420857, 15205.695886082216, 15255.694886102216, 15272.618184545476, 7047.859042819115, 7138.286171382821, 7187.712491500386, 7200.135983681992, 7238.23998480152, 6554.410103090745, 6708.463322934251, 6735.124433823572, 6743.561668491532, 6827.965860170667, 4686.039361930796, 4733.455652599926, 4801.591864691471, 4852.053849499384, 4905.3132561441425, 1290.6063650586661, 1293.9353032348345, 1304.5042883704132, 1319.4722111155422, 1335.619348485677, 878.4026861733954, 881.9823603527893, 895.0825403960862, 896.9596368163449, 925.4539821505344, 7241.52930059555, 7846.176151504124, 7960.044794624682, 8079.5960201989665, 8146.714864979697, 701.7683765625259, 723.3706675192616, 739.9630018499054, 740.3632875726871, 748.4611080022376, 4440.955590444119, 5120.436751957282, 5128.769205385766, 5135.075686376488, 5225.425203227642, 17544.649107018042, 17666.823331766518, 18536.165872535767, 18565.35021274249, 18725.81274187268, 18227.270909163486, 18249.81750182481, 18335.90832045858, 18556.81443185578, 19065.904670476837, 10645.308054976556, 10691.091257243066, 10714.0, 10805.729856753644, 10805.891941080647, 7637.121731001006, 7737.497062690907, 7750.341220996278, 8016.759497215093, 8152.510849349058, 15124.243787810345, 15632.140232287333, 15710.0, 15859.52421427359, 15901.52295431139, 15714.76427853606, 16254.349826006828, 16287.592810179367, 16421.343146274015, 16680.082595457367, 10097.697069087939, 10129.64546240878, 10270.178385729274, 10301.278910476494, 10470.581176752845, 12477.438515266653, 12736.23582585048, 12746.936265318614, 12767.170133941265, 12770.106092573802, 10145.340552864336, 10355.223358248311, 10423.114035307084, 10610.204234682275, 10852.077573406348, 9812.901870981199, 10053.849192261976, 10082.092611664692, 10175.84736228972, 10239.7440063999, 8851.46891186531, 8972.102789720975, 9001.414908030956, 9001.459912405277, 9023.0, 6750.6624668767345, 7060.6469676517, 7091.43268538526, 7092.822679433056, 7139.821504462222, 6986.580805151707, 7282.0, 7338.816529586803, 7377.483576149618, 7385.29839665231], "value": 6089.546205272172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.94971028042033, 489.23923299269643, 490.7374554613281, 511.9718415487147, 516.5325380530619, 6320.652364119977, 6327.905081423771, 6329.2088488938825, 6336.841578960528, 6434.260060093091, 5953.315368732597, 6189.845253868655, 6220.564560480768, 6226.844328891769, 6230.657313847737, 5012.448630650625, 5021.071101846161, 5043.84868453947, 5059.6964182149, 5070.569001634865, 5025.296458495814, 5049.116404629193, 5052.646314757969, 5066.897237646373, 5094.235864620318, 5026.798928042874, 5034.0, 5047.369078865142, 5049.747512624373, 5056.79772809089, 4829.275608658694, 5032.597392208614, 5037.244413337992, 5041.369828771422, 5045.747712614391, 4488.910221795579, 4508.0, 4533.5013148553635, 4535.659825513099, 4549.909001819979, 6061.909071363933, 6115.357887421801, 6118.479929205978, 6126.172966649535, 6148.139260503488, 5753.590370359247, 5772.826815195551, 5776.249087618583, 5777.959967205901, 5803.578123359762, 6663.900041499382, 6669.466442684574, 6672.666366681695, 6678.165229346332, 6682.264950855402, 4888.388951381077, 4923.138450771101, 4928.926066109011, 4956.157453232959, 4957.801687932479, 6894.517383783137, 6930.480213983921, 6959.478039147034, 6974.965125174393, 7005.614691191982, 5096.464871188546, 5096.980603879239, 5103.157978933508, 5112.821051263262, 5115.18157094863, 5175.146100893386, 5177.430482646906, 5178.533931946067, 5180.870478238075, 5197.168453047494, 5820.708964551755, 5823.56323275756, 5828.213191219131, 5838.416158384212, 5840.620359676607, 6751.683421732813, 6771.0, 6772.93227067723, 6780.796576102724, 6784.0, 1688.1727953302793, 1792.3726695656417, 1797.2361746257789, 1807.3493542324752, 1809.6380723855282, 1238.8885000350012, 1239.1635645938954, 1242.8188529131316, 1243.8507379114565, 1273.216971562501, 5622.971885140548, 5779.162021506858, 5809.186713860063, 5840.5035571976005, 5845.649261044351, 6702.530822842355, 6721.361470660279, 6831.69257383419, 6842.623655698984, 6875.3124687531845, 5802.88394232113, 5806.332271788714, 5813.7383817728305, 5815.924054050014, 5853.560982926298, 3590.281943611288, 3609.3322735294055, 3622.2574372253625, 3628.639260277396, 3630.9092272692865, 6595.4393876521035, 6596.0, 6609.224125867051, 6621.86756264872, 6681.897486914605, 6921.653917304216, 6962.677091352627, 6973.58158510491, 6986.567753610498, 6988.405985491188, 6572.671366431659, 6580.539362244597, 6587.407133357925, 6612.933870661232, 6621.50338724588, 6657.900131498128, 6755.223149337692, 6785.1518560179975, 6785.558938669168, 6820.215675197416, 6620.801375958729, 6733.932660673527, 6757.729690812313, 6764.5603035802515, 6765.797026089225, 6324.810255692337, 6573.211214654272, 6577.210734711865, 6583.210014798255, 6595.868082638224, 5019.196928491424, 5061.240813877947, 5061.266116413026, 5069.670471419346, 5076.492350764894, 6797.6941037654415, 6811.761588344384, 6825.624590647562, 6842.760503382557, 6847.0, 6551.50863685216, 6594.538382313192, 6618.470522358296, 6626.171728533934, 6631.834204144742, 6520.250171230369, 6525.967370163119, 6526.804195874131, 6540.542162048801, 6569.047488114292, 6394.360563943755, 6506.642134682638, 6552.312007239171, 6554.442872355903, 6569.211694596679, 6617.669116544057, 6629.6353700545005, 6634.800955971328, 6670.032845237511, 6683.097781799394, 6369.649669268235, 6405.423511883952, 6445.871082578416, 6461.838454038687, 6491.188601424822], "value": 5114.768581762989, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.9549022548875, 911.1480765484273, 922.5940586142093, 926.1155596405433, 937.0395344771606, 17213.139343032846, 18339.08304584772, 18341.816581834177, 18347.541311467205, 18389.816101838995, 15310.0813951163, 15358.078515289062, 15379.307931143125, 16527.173641317917, 17297.82702172978, 1042.7653777899989, 1064.435849000031, 1065.0999905080196, 1066.4188017530425, 1066.9519871605758, 1049.375621505203, 1062.1237479079753, 1065.4193464561833, 1066.386827574144, 1068.1134658233648, 1114.6098865397087, 1115.8995690387862, 1125.4597793059336, 1126.9943650281778, 1128.7573171768067, 1004.8090862736129, 1028.4343611013912, 1099.9065079468214, 1123.1015187849728, 1124.8144056230713, 795.5982228974389, 795.9084705258912, 798.1539568057877, 800.9799755006113, 801.234820746186, 18280.45158645243, 18454.723179152323, 18469.168887400097, 18484.53788655281, 18484.630307393913, 17866.0, 18857.717134242997, 18932.71600925987, 18991.0, 19029.524261893424, 14955.177465239407, 15562.688746225012, 15696.372145114181, 15757.60605984848, 15790.921045394814, 3478.060923550627, 3487.2153765402836, 3513.4027215373194, 3532.6114127445962, 3536.681698647134, 94535.52732236295, 95939.0, 96562.0, 97107.51446242724, 101598.49200754096, 14030.368633411317, 14131.788023179455, 14365.13809171453, 14372.856271437151, 14457.277136143151, 26414.0, 27321.043763468184, 27725.445491090468, 27807.30481737973, 28244.0, 7862.921370786219, 8030.678772849021, 8035.477693949874, 8037.678492860337, 8074.959625201836, 3844.7308688392104, 3855.9614403855603, 3968.722189446711, 3976.5426975897562, 4024.4566983457444, 4671.15919134559, 4728.1252968201, 4731.053789242096, 4754.23932170851, 4754.334393184957, 823.7816978500703, 852.7100785732756, 862.607513581319, 864.3258258558335, 864.8616221404545, 623.6943897490197, 656.8226578823691, 691.8858388365963, 702.7399862051074, 711.7010855440727, 10937.890621093688, 11528.76942461146, 11817.763644727058, 11897.107716921266, 12175.0868684849, 657.3459407889085, 660.8380946668098, 666.4501786026451, 682.5733916302311, 687.8349196192878, 5159.638825282269, 5192.3769147702515, 5297.920531191958, 5306.177542480922, 5310.486511344326, 91156.54421727848, 94734.0, 95975.52012239894, 96870.59990084283, 98403.50798246106, 68304.65847670729, 84302.57848710717, 84630.0, 84995.5750221245, 90363.0, 66135.66932165308, 71125.0, 73475.63262183654, 74971.25028749752, 77014.0, 12104.51581936748, 12397.504099835905, 12461.563845265373, 12555.246685198917, 12562.309073001074, 31914.840425797724, 33675.326493470486, 34463.65536344604, 34698.826505867306, 35454.645453545134, 42664.573354267304, 43726.78136609297, 44796.77601611971, 45189.54810451985, 46410.30384544302, 15808.209589520708, 15924.203789810232, 15944.362225511313, 16048.1173535452, 16135.596610084373, 15883.0, 16277.0, 16385.0, 16504.83495165033, 16683.66632667364, 17554.91222543879, 17730.5567360817, 17851.553711156805, 17867.106644667976, 18148.455546333633, 15302.61743456378, 15354.769678454608, 15354.84645153534, 15382.0, 15611.375544978073, 15775.842241577897, 16227.837721623106, 16813.495595132164, 16833.91583042077, 17100.401485947932, 12314.876851231373, 12413.689657758629, 12461.314627695201, 12491.188072775603, 12595.05537084704, 11574.768504629692, 11728.70678233051, 11802.82295765547, 11844.881551184379, 11850.407479625812], "value": 8329.914673213045, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 109.0, 107.0, 108.0, 108.0, 110.0, 110.0, 109.0, 110.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 150.0, 185.0, 122.0, 152.0, 154.0, 125.0, 172.0, 121.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 162.0, 161.0, 172.0, 162.0, 164.0, 164.0, 171.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 164.0, 75.0, 75.0, 75.0, 74.0, 106.0, 75.0], "value": 86.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 139.0, 81.0, 82.0, 82.0, 138.0, 83.0, 81.0, 129.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 150.0, 150.0, 149.0, 150.0, 150.0, 149.0, 150.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 53.0, 53.0, 57.0, 57.0, 54.0, 59.0, 52.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 86.0, 77.0, 80.0, 76.0, 78.0, 76.0, 77.0, 90.0, 77.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 128.0, 138.0, 141.0, 148.0, 128.0, 124.0, 136.0, 160.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 192.0, 185.0, 179.0, 188.0, 184.0, 184.0, 180.0, 194.0], "value": 186.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 67.0, 70.0, 66.0, 68.0, 72.0, 65.0, 67.0, 74.0], "value": 68.9, "unit": "score"}]}]} 15:07:29 INFO - Return code: 0 15:07:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:07:29 INFO - # TBPL SUCCESS # 15:07:29 INFO - Running post-action listener: _resource_record_post_action 15:07:29 INFO - [mozharness: 2017-06-28 22:07:29.590811Z] Finished run-tests step (success) 15:07:29 INFO - Running post-run listener: _resource_record_post_run 15:07:29 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 448880640; Read time: 144; Write time: 284160 15:07:29 INFO - TinderboxPrint: CPU usage
13.1% 15:07:29 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 144 15:07:29 INFO - TinderboxPrint: I/O write bytes / time
448,880,640 / 284,160 15:07:29 INFO - TinderboxPrint: CPU idle
8,291.9 (86.9%) 15:07:29 INFO - TinderboxPrint: CPU user
1,206.4 (12.6%) 15:07:29 INFO - TinderboxPrint: Swap in / out
0 / 0 15:07:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121040896; Read time: 32; Write time: 95120 15:07:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:07:29 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 8192; Write bytes: 327839744; Read time: 96; Write time: 189040 15:07:30 INFO - Running post-run listener: _upload_blobber_files 15:07:30 INFO - Blob upload gear active. 15:07:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:07:30 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 15:07:30 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'] 15:07:30 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 15:07:30 INFO - (blobuploader) - INFO - Open directory for files ... 15:07:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:07:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:31 INFO - (blobuploader) - INFO - Done attempting. 15:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:35 INFO - (blobuploader) - INFO - Done attempting. 15:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:35 INFO - (blobuploader) - INFO - Done attempting. 15:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:07:36 INFO - (blobuploader) - INFO - Done attempting. 15:07:36 INFO - (blobuploader) - INFO - Iteration through files over. 15:07:36 INFO - Return code: 0 15:07:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:07:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:07:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d5532c1349237fd0540ffe792aaf40bbc497c43af47fc49df1aee0cd73ea2e484121229d61fbfb5871271fa59f75bfa818896e39e221939a81422ce4a28bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03015d9c67def294c0b8706ff72d013ed2df156b3de07282682cf0684c92b77ff029468add3517e8a7cffd7bab5c9b5a4a421ead5d4c6469c1b204fd80e5582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e8413f4cbee75de248533fdfed85080024da6799b5fdedf2fba9fcb80a6a8d9a4a80eefda5963e9e724c962af4e40881a932f6ce32cb725c7db92e21e6952f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2259c3c77ccd611f852023762e03ff9941995b44985fd507f55ec65ec5604f304f39edef91725ff126e6701d577b89e897b0c2bfb8f0654de1d2c2486a37a579"} 15:07:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:07:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:07:36 INFO - Contents: 15:07:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d5532c1349237fd0540ffe792aaf40bbc497c43af47fc49df1aee0cd73ea2e484121229d61fbfb5871271fa59f75bfa818896e39e221939a81422ce4a28bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03015d9c67def294c0b8706ff72d013ed2df156b3de07282682cf0684c92b77ff029468add3517e8a7cffd7bab5c9b5a4a421ead5d4c6469c1b204fd80e5582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e8413f4cbee75de248533fdfed85080024da6799b5fdedf2fba9fcb80a6a8d9a4a80eefda5963e9e724c962af4e40881a932f6ce32cb725c7db92e21e6952f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2259c3c77ccd611f852023762e03ff9941995b44985fd507f55ec65ec5604f304f39edef91725ff126e6701d577b89e897b0c2bfb8f0654de1d2c2486a37a579"} 15:07:36 INFO - Running post-run listener: copy_logs_to_upload_dir 15:07:36 INFO - Copying logs to upload dir... 15:07:36 INFO - mkdir: /builds/slave/test/build/upload/logs 15:07:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.288458 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-06-28 15:07:35.858586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 15:07:35.862889) ========= 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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d5532c1349237fd0540ffe792aaf40bbc497c43af47fc49df1aee0cd73ea2e484121229d61fbfb5871271fa59f75bfa818896e39e221939a81422ce4a28bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03015d9c67def294c0b8706ff72d013ed2df156b3de07282682cf0684c92b77ff029468add3517e8a7cffd7bab5c9b5a4a421ead5d4c6469c1b204fd80e5582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e8413f4cbee75de248533fdfed85080024da6799b5fdedf2fba9fcb80a6a8d9a4a80eefda5963e9e724c962af4e40881a932f6ce32cb725c7db92e21e6952f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2259c3c77ccd611f852023762e03ff9941995b44985fd507f55ec65ec5604f304f39edef91725ff126e6701d577b89e897b0c2bfb8f0654de1d2c2486a37a579"} build_url:https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011409 build_url: 'https://queue.taskcluster.net/v1/task/HjzDKNl1RmS00UgGSOH2vQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77d5532c1349237fd0540ffe792aaf40bbc497c43af47fc49df1aee0cd73ea2e484121229d61fbfb5871271fa59f75bfa818896e39e221939a81422ce4a28bdf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d03015d9c67def294c0b8706ff72d013ed2df156b3de07282682cf0684c92b77ff029468add3517e8a7cffd7bab5c9b5a4a421ead5d4c6469c1b204fd80e5582", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2e8413f4cbee75de248533fdfed85080024da6799b5fdedf2fba9fcb80a6a8d9a4a80eefda5963e9e724c962af4e40881a932f6ce32cb725c7db92e21e6952f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2259c3c77ccd611f852023762e03ff9941995b44985fd507f55ec65ec5604f304f39edef91725ff126e6701d577b89e897b0c2bfb8f0654de1d2c2486a37a579"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-28 15:07:35.886311) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 15:07:35.889620) ========= 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=4300f881736b422476174874000001bc-1498673696.270601-1673155222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-28 15:07:35.937581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 15:07:35.937852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-28 15:07:35.938098) ========= ========= Total master_lag: 0.30 =========