builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1498220769.83 results: success (0) revision: 2f10d697c307a09a286faa1f11831644c40f778d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:09.827742) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:09.828206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:09.828506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:09.845249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:09.845658) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-23 05:26:09-- 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% 46.5M=0s 2017-06-23 05:26:10 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146581 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.034108) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.034660) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018891 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.084469) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.084844) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2f10d697c307a09a286faa1f11831644c40f778d --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 2f10d697c307a09a286faa1f11831644c40f778d --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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-23 05:26:10,154 truncating revision to first 12 chars 2017-06-23 05:26:10,154 Setting DEBUG logging. 2017-06-23 05:26:10,154 attempt 1/10 2017-06-23 05:26:10,154 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2f10d697c307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-23 05:26:10,491 unpacking tar archive at: mozilla-central-2f10d697c307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643130 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.741166) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.741669) ========= script_repo_revision: 2f10d697c307a09a286faa1f11831644c40f778d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.742288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.742719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 05:26:10.752280) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-23 05:26:10.752701) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:11 INFO - MultiFileLogger online at 20170623 05:26:11 in /builds/slave/test 05:26:11 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 05:26:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:11 INFO - {'append_to_log': False, 05:26:11 INFO - 'base_work_dir': '/builds/slave/test', 05:26:11 INFO - 'blob_upload_branch': 'Firefox', 05:26:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:11 INFO - 'branch': 'Firefox', 05:26:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:11 INFO - 'config_files': ('talos/linux_config.py',), 05:26:11 INFO - 'default_actions': ('clobber', 05:26:11 INFO - 'read-buildbot-config', 05:26:11 INFO - 'download-and-extract', 05:26:11 INFO - 'populate-webroot', 05:26:11 INFO - 'create-virtualenv', 05:26:11 INFO - 'install', 05:26:11 INFO - 'setup-mitmproxy', 05:26:11 INFO - 'run-tests'), 05:26:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:11 INFO - 'download_minidump_stackwalk': True, 05:26:11 INFO - 'download_symbols': 'ondemand', 05:26:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:11 INFO - 'gecko_profile': False, 05:26:11 INFO - 'gecko_profile_interval': 0, 05:26:11 INFO - 'installer_path': 'installer.exe', 05:26:11 INFO - 'log_level': 'info', 05:26:11 INFO - 'log_name': 'talos', 05:26:11 INFO - 'log_to_console': True, 05:26:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:11 INFO - 'opt_config_files': (), 05:26:11 INFO - 'pip_index': False, 05:26:11 INFO - 'suite': 'dromaeojs-e10s', 05:26:11 INFO - 'system_bits': '32', 05:26:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:11 INFO - 'title': 'talos-linux64-ix-068', 05:26:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:11 INFO - 'use_talos_json': True, 05:26:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:11 INFO - 'work_dir': 'build'} 05:26:11 INFO - [mozharness: 2017-06-23 12:26:11.053699Z] Running clobber step. 05:26:11 INFO - Running pre-action listener: _resource_record_pre_action 05:26:11 INFO - Running main action method: clobber 05:26:11 INFO - rmtree: /builds/slave/test/build 05:26:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:12 INFO - Running post-action listener: _resource_record_post_action 05:26:12 INFO - [mozharness: 2017-06-23 12:26:12.052090Z] Finished clobber step (success) 05:26:12 INFO - [mozharness: 2017-06-23 12:26:12.052190Z] Running read-buildbot-config step. 05:26:12 INFO - Running pre-action listener: _resource_record_pre_action 05:26:12 INFO - Running main action method: read_buildbot_config 05:26:12 INFO - Using buildbot properties: 05:26:12 INFO - { 05:26:12 INFO - "project": "", 05:26:12 INFO - "product": "firefox", 05:26:12 INFO - "who": "cbook@mozilla.com", 05:26:12 INFO - "installer_path": "public/build/target.tar.bz2", 05:26:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:26:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:26:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:26:12 INFO - "stage_platform": "linux64-pgo", 05:26:12 INFO - "basedir": "/builds/slave/test", 05:26:12 INFO - "buildnumber": 30, 05:26:12 INFO - "platform": "ubuntu64_hw", 05:26:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:26:12 INFO - "slavebuilddir": "test", 05:26:12 INFO - "taskId": "KswnuF4SSYuHR3-bEy8-xw", 05:26:12 INFO - "branch": "mozilla-central", 05:26:12 INFO - "script_repo_revision": "production", 05:26:12 INFO - "revision": "2f10d697c307a09a286faa1f11831644c40f778d", 05:26:12 INFO - "slavename": "talos-linux64-ix-068", 05:26:12 INFO - "repo_path": "mozilla-central" 05:26:12 INFO - } 05:26:12 INFO - Finding installer, test and symbols from parent task. 05:26:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KswnuF4SSYuHR3-bEy8-xw'}, attempt #1 05:26:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KswnuF4SSYuHR3-bEy8-xw'}, attempt #1 05:26:12 INFO - Task dependencies: EgUYqmuyTeepIWNMHZdxUQ 05:26:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ'}, attempt #1 05:26:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 05:26:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/test_packages.json 05:26:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.crashreporter-symbols.zip 05:26:13 INFO - Running post-action listener: _resource_record_post_action 05:26:13 INFO - [mozharness: 2017-06-23 12:26:13.384533Z] Finished read-buildbot-config step (success) 05:26:13 INFO - [mozharness: 2017-06-23 12:26:13.384757Z] Running download-and-extract step. 05:26:13 INFO - Running pre-action listener: _resource_record_pre_action 05:26:13 INFO - Running main action method: download_and_extract 05:26:13 INFO - mkdir: /builds/slave/test/build/tests 05:26:13 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')]} 05:26:13 INFO - trying https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.test_packages.json 05:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:26:13 INFO - Downloaded 989 bytes. 05:26:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:26:13 INFO - Using the following test package requirements: 05:26:13 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:26:13 INFO - u'common': [u'target.common.tests.zip'], 05:26:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:26:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:26:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:26:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:26:13 INFO - u'mozbase': [u'target.common.tests.zip'], 05:26:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:26:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:26:13 INFO - u'web-platform': [u'target.common.tests.zip', 05:26:13 INFO - u'target.web-platform.tests.tar.gz'], 05:26:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:26:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:26:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip 05:26:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:26:13 INFO - Fetch https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip into memory 05:26:15 INFO - Content-Length response header: 68372817 05:26:15 INFO - Bytes received: 68372817 05:26:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:26:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip 05:26:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:26:26 INFO - Fetch https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.common.tests.zip into memory 05:26:27 INFO - Content-Length response header: 68372817 05:26:27 INFO - Bytes received: 68372817 05:26:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.talos.tests.zip 05:26:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:26:40 INFO - Fetch https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.talos.tests.zip into memory 05:26:41 INFO - Content-Length response header: 14441306 05:26:41 INFO - Bytes received: 14441306 05:26:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:41 INFO - trying https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 05:26:41 INFO - Downloading https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:26:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:26:43 INFO - Downloaded 62638735 bytes. 05:26:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 05:26:43 INFO - mkdir: /builds/slave/test/properties 05:26:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:43 INFO - Contents: 05:26:43 INFO - build_url:https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 05:26:43 INFO - Running post-action listener: _resource_record_post_action 05:26:43 INFO - Running post-action listener: set_extra_try_arguments 05:26:43 INFO - [mozharness: 2017-06-23 12:26:43.009016Z] Finished download-and-extract step (success) 05:26:43 INFO - [mozharness: 2017-06-23 12:26:43.009114Z] Running populate-webroot step. 05:26:43 INFO - Running pre-action listener: _resource_record_pre_action 05:26:43 INFO - Running main action method: populate_webroot 05:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:43 INFO - '--tppagecycles', 05:26:43 INFO - '7'], 05:26:43 INFO - 'tests': ['tsvgm']}}, 05:26:43 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['damp', 'tps']}, 05:26:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'tests': ['damp', 'tps']}, 05:26:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['dromaeo_dom']}, 05:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:26:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:26:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:26:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['a11yr', 05:26:43 INFO - 'ts_paint', 05:26:43 INFO - 'tpaint', 05:26:43 INFO - 'sessionrestore', 05:26:43 INFO - 'sessionrestore_no_auto_restore', 05:26:43 INFO - 'tabpaint']}, 05:26:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:26:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:26:43 INFO - 'bloom_basic_ref']}, 05:26:43 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:26:43 INFO - 'talos_options': ['--mitmproxy', 05:26:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:26:43 INFO - '--firstNonBlankPaint'], 05:26:43 INFO - 'tests': ['quantum_pageload_google', 05:26:43 INFO - 'quantum_pageload_youtube', 05:26:43 INFO - 'quantum_pageload_amazon', 05:26:43 INFO - 'quantum_pageload_facebook']}, 05:26:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['tsvgx', 05:26:43 INFO - 'tsvgr_opacity', 05:26:43 INFO - 'tart', 05:26:43 INFO - 'tscrollx', 05:26:43 INFO - 'cart', 05:26:43 INFO - 'tsvg_static']}, 05:26:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:43 INFO - 'tsvgr_opacity', 05:26:43 INFO - 'tart', 05:26:43 INFO - 'tscrollx', 05:26:43 INFO - 'cart', 05:26:43 INFO - 'tsvg_static']}, 05:26:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'talos_options': ['--disable-e10s'], 05:26:43 INFO - 'tests': ['tp5o']}, 05:26:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:26:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'talos_options': ['--disable-e10s', 05:26:43 INFO - '--xperf_path', 05:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:43 INFO - 'tests': ['tp5n']}, 05:26:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:26:43 INFO - 'talos_options': ['--xperf_path', 05:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:43 INFO - 'tests': ['tp5n']}}, 05:26:43 INFO - 'talos.zip': {'path': '', 05:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:43 INFO - Running post-action listener: _resource_record_post_action 05:26:43 INFO - [mozharness: 2017-06-23 12:26:43.024570Z] Finished populate-webroot step (success) 05:26:43 INFO - [mozharness: 2017-06-23 12:26:43.024662Z] Running create-virtualenv step. 05:26:43 INFO - Running pre-action listener: _resource_record_pre_action 05:26:43 INFO - Running main action method: create_virtualenv 05:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:43 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 05:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:43 INFO - Using real prefix '/usr' 05:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:45 INFO - Installing pip.................done. 05:26:45 INFO - Return code: 0 05:26:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:26:46 INFO - Reading from file tmpfile_stdout 05:26:46 INFO - Output received: 05:26:46 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) 05:26:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:46 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:46 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 05:26:46 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 05:26:46 INFO - Using env: {'DISPLAY': ':0', 05:26:46 INFO - 'HOME': '/home/cltbld', 05:26:46 INFO - 'LANG': 'en_US.UTF-8', 05:26:46 INFO - 'LANGUAGE': 'en_US:en', 05:26:46 INFO - 'LOGNAME': 'cltbld', 05:26:46 INFO - 'MAIL': '/var/mail/cltbld', 05:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:46 INFO - 'MOZ_NO_REMOTE': '1', 05:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:46 INFO - 'NO_EM_RESTART': '1', 05:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:46 INFO - 'PWD': '/builds/slave/test', 05:26:46 INFO - 'SHELL': '/bin/bash', 05:26:46 INFO - 'SHLVL': '1', 05:26:46 INFO - 'TERM': 'linux', 05:26:46 INFO - 'TMOUT': '86400', 05:26:46 INFO - 'USER': 'cltbld', 05:26:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:46 INFO - '_': '/tools/buildbot/bin/python'} 05:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:46 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 05:26:46 INFO - Cleaning up... 05:26:46 INFO - Return code: 0 05:26:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:46 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:46 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 05:26:46 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 05:26:46 INFO - Using env: {'DISPLAY': ':0', 05:26:46 INFO - 'HOME': '/home/cltbld', 05:26:46 INFO - 'LANG': 'en_US.UTF-8', 05:26:46 INFO - 'LANGUAGE': 'en_US:en', 05:26:46 INFO - 'LOGNAME': 'cltbld', 05:26:46 INFO - 'MAIL': '/var/mail/cltbld', 05:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:46 INFO - 'MOZ_NO_REMOTE': '1', 05:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:46 INFO - 'NO_EM_RESTART': '1', 05:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:46 INFO - 'PWD': '/builds/slave/test', 05:26:46 INFO - 'SHELL': '/bin/bash', 05:26:46 INFO - 'SHLVL': '1', 05:26:46 INFO - 'TERM': 'linux', 05:26:46 INFO - 'TMOUT': '86400', 05:26:46 INFO - 'USER': 'cltbld', 05:26:46 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:46 INFO - '_': '/tools/buildbot/bin/python'} 05:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:47 INFO - Downloading/unpacking psutil>=3.1.1 05:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:48 INFO - Installing collected packages: psutil 05:26:48 INFO - Running setup.py install for psutil 05:26:48 INFO - building 'psutil._psutil_linux' extension 05:26:48 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 05:26:49 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 05:26:49 INFO - building 'psutil._psutil_posix' extension 05:26:49 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 05:26:49 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 05:26:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:49 INFO - Successfully installed psutil 05:26:49 INFO - Cleaning up... 05:26:50 INFO - Return code: 0 05:26:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26: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')]} 05:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26: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')]} 05:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:50 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:50 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 05:26:50 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 05:26:50 INFO - Using env: {'DISPLAY': ':0', 05:26:50 INFO - 'HOME': '/home/cltbld', 05:26:50 INFO - 'LANG': 'en_US.UTF-8', 05:26:50 INFO - 'LANGUAGE': 'en_US:en', 05:26:50 INFO - 'LOGNAME': 'cltbld', 05:26:50 INFO - 'MAIL': '/var/mail/cltbld', 05:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:50 INFO - 'MOZ_NO_REMOTE': '1', 05:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:50 INFO - 'NO_EM_RESTART': '1', 05:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:50 INFO - 'PWD': '/builds/slave/test', 05:26:50 INFO - 'SHELL': '/bin/bash', 05:26:50 INFO - 'SHLVL': '1', 05:26:50 INFO - 'TERM': 'linux', 05:26:50 INFO - 'TMOUT': '86400', 05:26:50 INFO - 'USER': 'cltbld', 05:26:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:50 INFO - '_': '/tools/buildbot/bin/python'} 05:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:50 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 05:26:50 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 05:26:50 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 05:26:50 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 05:26:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:51 INFO - Installing collected packages: mozsystemmonitor 05:26:51 INFO - Running setup.py install for mozsystemmonitor 05:26:51 INFO - Successfully installed mozsystemmonitor 05:26:51 INFO - Cleaning up... 05:26:51 INFO - Return code: 0 05:26:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:51 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')]} 05:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:51 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')]} 05:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:51 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:51 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 05:26:51 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 05:26:51 INFO - Using env: {'DISPLAY': ':0', 05:26:51 INFO - 'HOME': '/home/cltbld', 05:26:51 INFO - 'LANG': 'en_US.UTF-8', 05:26:51 INFO - 'LANGUAGE': 'en_US:en', 05:26:51 INFO - 'LOGNAME': 'cltbld', 05:26:51 INFO - 'MAIL': '/var/mail/cltbld', 05:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:51 INFO - 'MOZ_NO_REMOTE': '1', 05:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:51 INFO - 'NO_EM_RESTART': '1', 05:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:51 INFO - 'PWD': '/builds/slave/test', 05:26:51 INFO - 'SHELL': '/bin/bash', 05:26:51 INFO - 'SHLVL': '1', 05:26:51 INFO - 'TERM': 'linux', 05:26:51 INFO - 'TMOUT': '86400', 05:26:51 INFO - 'USER': 'cltbld', 05:26:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:51 INFO - '_': '/tools/buildbot/bin/python'} 05:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:51 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 05:26:51 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 05:26:51 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 05:26:51 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 05:26:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:52 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 05:26:52 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 05:26:52 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 05:26:52 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 05:26:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:52 INFO - warning: no files found matching '*.txt' 05:26:52 INFO - no previously-included directories found matching 'build' 05:26:52 INFO - no previously-included directories found matching 'dist' 05:26:52 INFO - no previously-included directories found matching '.git*' 05:26:52 INFO - Installing collected packages: jsonschema, functools32 05:26:53 INFO - Running setup.py install for functools32 05:26:53 INFO - warning: no files found matching '*.txt' 05:26:53 INFO - no previously-included directories found matching 'build' 05:26:53 INFO - no previously-included directories found matching 'dist' 05:26:53 INFO - no previously-included directories found matching '.git*' 05:26:53 INFO - Successfully installed jsonschema functools32 05:26:53 INFO - Cleaning up... 05:26:53 INFO - Return code: 0 05:26:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:53 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 05:26:53 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 05:26:53 INFO - Using env: {'DISPLAY': ':0', 05:26:53 INFO - 'HOME': '/home/cltbld', 05:26:53 INFO - 'LANG': 'en_US.UTF-8', 05:26:53 INFO - 'LANGUAGE': 'en_US:en', 05:26:53 INFO - 'LOGNAME': 'cltbld', 05:26:53 INFO - 'MAIL': '/var/mail/cltbld', 05:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:53 INFO - 'MOZ_NO_REMOTE': '1', 05:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:53 INFO - 'NO_EM_RESTART': '1', 05:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:53 INFO - 'PWD': '/builds/slave/test', 05:26:53 INFO - 'SHELL': '/bin/bash', 05:26:53 INFO - 'SHLVL': '1', 05:26:53 INFO - 'TERM': 'linux', 05:26:53 INFO - 'TMOUT': '86400', 05:26:53 INFO - 'USER': 'cltbld', 05:26:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:53 INFO - '_': '/tools/buildbot/bin/python'} 05:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:53 INFO - Cleaning up... 05:26:53 INFO - Return code: 0 05:26:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:53 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:53 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 05:26:53 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 05:26:53 INFO - Using env: {'DISPLAY': ':0', 05:26:53 INFO - 'HOME': '/home/cltbld', 05:26:53 INFO - 'LANG': 'en_US.UTF-8', 05:26:53 INFO - 'LANGUAGE': 'en_US:en', 05:26:53 INFO - 'LOGNAME': 'cltbld', 05:26:53 INFO - 'MAIL': '/var/mail/cltbld', 05:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:53 INFO - 'MOZ_NO_REMOTE': '1', 05:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:53 INFO - 'NO_EM_RESTART': '1', 05:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:53 INFO - 'PWD': '/builds/slave/test', 05:26:53 INFO - 'SHELL': '/bin/bash', 05:26:53 INFO - 'SHLVL': '1', 05:26:53 INFO - 'TERM': 'linux', 05:26:53 INFO - 'TMOUT': '86400', 05:26:53 INFO - 'USER': 'cltbld', 05:26:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:53 INFO - '_': '/tools/buildbot/bin/python'} 05:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:53 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 05:26:53 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 05:26:53 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 05:26:53 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 05:26:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:54 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 05:26:54 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 05:26:54 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 05:26:54 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 05:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:55 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 05:26:55 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 05:26:55 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 05:26:55 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 05:26:55 INFO - Downloading docopt-0.6.1.tar.gz 05:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:55 INFO - Running setup.py install for blobuploader 05:26:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:55 INFO - Running setup.py install for requests 05:26:55 INFO - Running setup.py install for docopt 05:26:55 INFO - Successfully installed blobuploader requests docopt 05:26:55 INFO - Cleaning up... 05:26:55 INFO - Return code: 0 05:26:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:55 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')]} 05:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:55 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')]} 05:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:55 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:55 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 05:26:55 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 05:26:55 INFO - Using env: {'DISPLAY': ':0', 05:26:55 INFO - 'HOME': '/home/cltbld', 05:26:55 INFO - 'LANG': 'en_US.UTF-8', 05:26:55 INFO - 'LANGUAGE': 'en_US:en', 05:26:55 INFO - 'LOGNAME': 'cltbld', 05:26:55 INFO - 'MAIL': '/var/mail/cltbld', 05:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:55 INFO - 'MOZ_NO_REMOTE': '1', 05:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:55 INFO - 'NO_EM_RESTART': '1', 05:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:55 INFO - 'PWD': '/builds/slave/test', 05:26:55 INFO - 'SHELL': '/bin/bash', 05:26:55 INFO - 'SHLVL': '1', 05:26:55 INFO - 'TERM': 'linux', 05:26:55 INFO - 'TMOUT': '86400', 05:26:55 INFO - 'USER': 'cltbld', 05:26:55 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:55 INFO - '_': '/tools/buildbot/bin/python'} 05:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:56 INFO - Running setup.py (path:/tmp/pip-94ZT02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:56 INFO - Running setup.py (path:/tmp/pip-P2DbBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:56 INFO - Running setup.py (path:/tmp/pip-T17wJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:56 INFO - Running setup.py (path:/tmp/pip-PAixqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:56 INFO - Running setup.py (path:/tmp/pip-8gs0aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:56 INFO - Running setup.py (path:/tmp/pip-xSgRL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:56 INFO - Running setup.py (path:/tmp/pip-tu9And-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:56 INFO - Running setup.py (path:/tmp/pip-wHOM2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:56 INFO - Running setup.py (path:/tmp/pip-uyQf4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:56 INFO - Running setup.py (path:/tmp/pip-CLS0io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:56 INFO - Running setup.py (path:/tmp/pip-0lVLOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:56 INFO - Running setup.py (path:/tmp/pip-j9tlVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:56 INFO - Running setup.py (path:/tmp/pip-KjTJ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:57 INFO - Running setup.py (path:/tmp/pip-6hhI5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:57 INFO - Running setup.py (path:/tmp/pip-Abec8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:57 INFO - Running setup.py (path:/tmp/pip-un8MgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:57 INFO - Running setup.py (path:/tmp/pip-ZsEDjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:57 INFO - Running setup.py install for manifestparser 05:26:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:57 INFO - Running setup.py install for mozcrash 05:26:57 INFO - Running setup.py install for mozdebug 05:26:57 INFO - Running setup.py install for mozdevice 05:26:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:57 INFO - Running setup.py install for mozfile 05:26:57 INFO - Running setup.py install for mozhttpd 05:26:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:57 INFO - Running setup.py install for mozinfo 05:26:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:57 INFO - Running setup.py install for mozInstall 05:26:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Running setup.py install for mozleak 05:26:58 INFO - Running setup.py install for mozlog 05:26:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Running setup.py install for moznetwork 05:26:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Running setup.py install for mozprocess 05:26:58 INFO - Running setup.py install for mozprofile 05:26:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Running setup.py install for mozrunner 05:26:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:58 INFO - Running setup.py install for mozscreenshot 05:26:58 INFO - Running setup.py install for moztest 05:26:58 INFO - Running setup.py install for mozversion 05:26:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:59 INFO - Cleaning up... 05:26:59 INFO - Return code: 0 05:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:59 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:26:59 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 05:26:59 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 05:26:59 INFO - Using env: {'DISPLAY': ':0', 05:26:59 INFO - 'HOME': '/home/cltbld', 05:26:59 INFO - 'LANG': 'en_US.UTF-8', 05:26:59 INFO - 'LANGUAGE': 'en_US:en', 05:26:59 INFO - 'LOGNAME': 'cltbld', 05:26:59 INFO - 'MAIL': '/var/mail/cltbld', 05:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:59 INFO - 'MOZ_NO_REMOTE': '1', 05:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:59 INFO - 'NO_EM_RESTART': '1', 05:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:59 INFO - 'PWD': '/builds/slave/test', 05:26:59 INFO - 'SHELL': '/bin/bash', 05:26:59 INFO - 'SHLVL': '1', 05:26:59 INFO - 'TERM': 'linux', 05:26:59 INFO - 'TMOUT': '86400', 05:26:59 INFO - 'USER': 'cltbld', 05:26:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:59 INFO - '_': '/tools/buildbot/bin/python'} 05:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:59 INFO - Running setup.py (path:/tmp/pip-0kqDSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:59 INFO - Running setup.py (path:/tmp/pip-1gIHQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:59 INFO - Running setup.py (path:/tmp/pip-8qTDJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:59 INFO - Running setup.py (path:/tmp/pip-qA3z_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:59 INFO - Running setup.py (path:/tmp/pip-6Q864z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:59 INFO - Running setup.py (path:/tmp/pip-zbd7rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:59 INFO - Running setup.py (path:/tmp/pip-m9lzuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:59 INFO - Running setup.py (path:/tmp/pip-7UBCFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:59 INFO - Running setup.py (path:/tmp/pip-sT83dD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:59 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)) 05:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:59 INFO - Running setup.py (path:/tmp/pip-XDrJep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:00 INFO - Running setup.py (path:/tmp/pip-WlPtF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:00 INFO - Running setup.py (path:/tmp/pip-s57LIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:00 INFO - Running setup.py (path:/tmp/pip-5YiJlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:00 INFO - Running setup.py (path:/tmp/pip-W6ydTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:00 INFO - Running setup.py (path:/tmp/pip-35seEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:00 INFO - Running setup.py (path:/tmp/pip-QRRVrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:00 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)) 05:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:00 INFO - Running setup.py (path:/tmp/pip-cKqrr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:00 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)) 05:27:00 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)) 05:27:00 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)) 05:27:00 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)) 05:27:00 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)) 05:27:00 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)) 05:27:00 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)) 05:27:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:00 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 05:27:00 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 05:27:00 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 05:27:00 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 05:27:01 INFO - Downloading blessings-1.6.tar.gz 05:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:01 INFO - Installing collected packages: blessings 05:27:01 INFO - Running setup.py install for blessings 05:27:01 INFO - Successfully installed blessings 05:27:01 INFO - Cleaning up... 05:27:01 INFO - Return code: 0 05:27:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:02 INFO - Reading from file tmpfile_stdout 05:27:02 INFO - Current package versions: 05:27:02 INFO - argparse == 1.2.1 05:27:02 INFO - blessings == 1.6 05:27:02 INFO - blobuploader == 1.2.4 05:27:02 INFO - docopt == 0.6.1 05:27:02 INFO - functools32 == 3.2.3-2 05:27:02 INFO - jsonschema == 2.5.1 05:27:02 INFO - manifestparser == 1.1 05:27:02 INFO - mozInstall == 1.13 05:27:02 INFO - mozcrash == 1.0 05:27:02 INFO - mozdebug == 0.1 05:27:02 INFO - mozdevice == 0.51 05:27:02 INFO - mozfile == 1.2 05:27:02 INFO - mozhttpd == 0.7 05:27:02 INFO - mozinfo == 0.10 05:27:02 INFO - mozleak == 0.1 05:27:02 INFO - mozlog == 3.4 05:27:02 INFO - moznetwork == 0.27 05:27:02 INFO - mozprocess == 0.25 05:27:02 INFO - mozprofile == 0.28 05:27:02 INFO - mozrunner == 6.13 05:27:02 INFO - mozscreenshot == 0.1 05:27:02 INFO - mozsystemmonitor == 0.3 05:27:02 INFO - moztest == 0.8 05:27:02 INFO - mozversion == 1.4 05:27:02 INFO - psutil == 3.1.1 05:27:02 INFO - requests == 1.2.3 05:27:02 INFO - wsgiref == 0.1.2 05:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:02 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')]} 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:02 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')]} 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:02 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:27:02 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 05:27:02 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 05:27:02 INFO - Using env: {'DISPLAY': ':0', 05:27:02 INFO - 'HOME': '/home/cltbld', 05:27:02 INFO - 'LANG': 'en_US.UTF-8', 05:27:02 INFO - 'LANGUAGE': 'en_US:en', 05:27:02 INFO - 'LOGNAME': 'cltbld', 05:27:02 INFO - 'MAIL': '/var/mail/cltbld', 05:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:02 INFO - 'MOZ_NO_REMOTE': '1', 05:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:02 INFO - 'NO_EM_RESTART': '1', 05:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:02 INFO - 'PWD': '/builds/slave/test', 05:27:02 INFO - 'SHELL': '/bin/bash', 05:27:02 INFO - 'SHLVL': '1', 05:27:02 INFO - 'TERM': 'linux', 05:27:02 INFO - 'TMOUT': '86400', 05:27:02 INFO - 'USER': 'cltbld', 05:27:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:02 INFO - '_': '/tools/buildbot/bin/python'} 05:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 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)) 05:27:02 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:27:02 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 05:27:02 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 05:27:02 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 05:27:02 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 05:27:03 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:27:03 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)) 05:27:03 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)) 05:27:03 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)) 05:27:03 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)) 05:27:03 INFO - Installing collected packages: marionette-driver 05:27:03 INFO - Running setup.py install for marionette-driver 05:27:03 INFO - Successfully installed marionette-driver 05:27:03 INFO - Cleaning up... 05:27:03 INFO - Return code: 0 05:27:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:03 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')]} 05:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:03 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')]} 05:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:03 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 0x15863b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1760a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19049a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', '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 05:27:03 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 05:27:03 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 05:27:03 INFO - Using env: {'DISPLAY': ':0', 05:27:03 INFO - 'HOME': '/home/cltbld', 05:27:03 INFO - 'LANG': 'en_US.UTF-8', 05:27:03 INFO - 'LANGUAGE': 'en_US:en', 05:27:03 INFO - 'LOGNAME': 'cltbld', 05:27:03 INFO - 'MAIL': '/var/mail/cltbld', 05:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:03 INFO - 'MOZ_NO_REMOTE': '1', 05:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:03 INFO - 'NO_EM_RESTART': '1', 05:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:03 INFO - 'PWD': '/builds/slave/test', 05:27:03 INFO - 'SHELL': '/bin/bash', 05:27:03 INFO - 'SHLVL': '1', 05:27:03 INFO - 'TERM': 'linux', 05:27:03 INFO - 'TMOUT': '86400', 05:27:03 INFO - 'USER': 'cltbld', 05:27:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:03 INFO - '_': '/tools/buildbot/bin/python'} 05:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:03 INFO - Cleaning up... 05:27:03 INFO - Return code: 0 05:27:03 INFO - Running post-action listener: _resource_record_post_action 05:27:03 INFO - Running post-action listener: _start_resource_monitoring 05:27:03 INFO - Starting resource monitoring. 05:27:03 INFO - [mozharness: 2017-06-23 12:27:03.932225Z] Finished create-virtualenv step (success) 05:27:03 INFO - [mozharness: 2017-06-23 12:27:03.933151Z] Running install step. 05:27:03 INFO - Running pre-action listener: _resource_record_pre_action 05:27:03 INFO - Running main action method: install 05:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:04 INFO - Reading from file tmpfile_stdout 05:27:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:04 INFO - Reading from file tmpfile_stdout 05:27:04 INFO - Output received: 05:27:04 INFO - Usage: mozinstall [options] installer 05:27:04 INFO - Options: 05:27:04 INFO - -h, --help show this help message and exit 05:27:04 INFO - -d DEST, --destination=DEST 05:27:04 INFO - Directory to install application into. [default: 05:27:04 INFO - "/builds/slave/test"] 05:27:04 INFO - --app=APP Application being installed. [default: firefox] 05:27:04 INFO - mkdir: /builds/slave/test/build/application 05:27:04 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'] 05:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:27:22 INFO - Reading from file tmpfile_stdout 05:27:22 INFO - Output received: 05:27:22 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:22 INFO - Running post-action listener: _resource_record_post_action 05:27:22 INFO - [mozharness: 2017-06-23 12:27:22.043909Z] Finished install step (success) 05:27:22 INFO - [mozharness: 2017-06-23 12:27:22.044186Z] Running setup-mitmproxy step. 05:27:22 INFO - Running pre-action listener: _resource_record_pre_action 05:27:22 INFO - Running main action method: setup_mitmproxy 05:27:22 INFO - Skipping: mitmproxy is not required 05:27:22 INFO - Running post-action listener: _resource_record_post_action 05:27:22 INFO - [mozharness: 2017-06-23 12:27:22.045374Z] Finished setup-mitmproxy step (success) 05:27:22 INFO - [mozharness: 2017-06-23 12:27:22.045614Z] Running run-tests step. 05:27:22 INFO - Running pre-action listener: _resource_record_pre_action 05:27:22 INFO - Running main action method: run_tests 05:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:22 INFO - Python 2.7.3 05:27:22 INFO - Return code: 0 05:27:22 INFO - grabbing minidump binary from tooltool 05:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:22 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 0x1902140>, '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 0x1902a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1902ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:22 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 05:27:22 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 05:27:22 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 05:27:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:22 INFO - Return code: 0 05:27:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:22 INFO - ENV: RUST_BACKTRACE is now 1 05:27:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:22 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/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:27:22 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/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 05:27:22 INFO - Using env: {'DISPLAY': ':0', 05:27:22 INFO - 'HOME': '/home/cltbld', 05:27:22 INFO - 'LANG': 'en_US.UTF-8', 05:27:22 INFO - 'LANGUAGE': 'en_US:en', 05:27:22 INFO - 'LOGNAME': 'cltbld', 05:27:22 INFO - 'MAIL': '/var/mail/cltbld', 05:27:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:22 INFO - 'MOZ_NO_REMOTE': '1', 05:27:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:22 INFO - 'NO_EM_RESTART': '1', 05:27:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:22 INFO - 'PWD': '/builds/slave/test', 05:27:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:22 INFO - 'RUST_BACKTRACE': '1', 05:27:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:27:22 INFO - 'SHELL': '/bin/bash', 05:27:22 INFO - 'SHLVL': '1', 05:27:22 INFO - 'TERM': 'linux', 05:27:22 INFO - 'TMOUT': '86400', 05:27:22 INFO - 'USER': 'cltbld', 05:27:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785', 05:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:22 INFO - '_': '/tools/buildbot/bin/python'} 05:27:22 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/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:27:22 INFO - mozversion application_buildid: 20170623105628 05:27:22 INFO - mozversion application_changeset: 2f10d697c307a09a286faa1f11831644c40f778d 05:27:22 INFO - mozversion application_display_name: Nightly 05:27:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:22 INFO - mozversion application_name: Firefox 05:27:22 INFO - mozversion application_remotingname: firefox 05:27:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:22 INFO - mozversion application_vendor: Mozilla 05:27:22 INFO - mozversion application_version: 56.0a1 05:27:22 INFO - mozversion platform_buildid: 20170623105628 05:27:22 INFO - mozversion platform_changeset: 2f10d697c307a09a286faa1f11831644c40f778d 05:27:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:22 INFO - mozversion platform_version: 56.0a1 05:27:22 INFO - using testdate: 1498220842 05:27:22 INFO - actual date: 1498220842 05:27:22 INFO - starting webserver on 'localhost:41231' 05:27:22 INFO - SUITE-START | Running 2 tests 05:27:22 INFO - TEST-START | dromaeo_css 05:27:22 INFO - operating with platform_type : linux_ 05:27:22 INFO - Initialising browser for dromaeo_css test... 05:27:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41231/getInfo.html -profile /tmp/tmppMcnQp/profile 05:27:22 INFO - TEST-INFO | started process 3313 (/builds/slave/test/build/application/firefox/firefox http://localhost:41231/getInfo.html) 05:27:30 INFO - TEST-INFO | 3313: exit 0 05:27:30 INFO - Browser initialized. 05:27:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:30 INFO - TEST-INFO | started process 3546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppMcnQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:42 INFO - PID 3546 | RSS: Main: 169451520 05:27:42 INFO - PID 3546 | 05:30:45 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41231/tests/dromaeo/cssquery-ext.html) 05:30:47 INFO - PID 3546 | RSS: Main: 175857664 05:30:47 INFO - PID 3546 | 05:33:49 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-ext.html (next: http://localhost:41231/tests/dromaeo/cssquery-jquery.html) 05:33:49 INFO - PID 3546 | RSS: Main: 172617728 05:33:49 INFO - PID 3546 | 05:36:51 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41231/tests/dromaeo/cssquery-mootools.html) 05:36:51 INFO - PID 3546 | RSS: Main: 175525888 05:36:51 INFO - PID 3546 | 05:39:53 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41231/tests/dromaeo/cssquery-prototype.html) 05:39:54 INFO - PID 3546 | RSS: Main: 174829568 05:39:54 INFO - PID 3546 | 05:42:56 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41231/tests/dromaeo/cssquery-yui.html) 05:42:57 INFO - PID 3546 | RSS: Main: 176152576 05:42:57 INFO - PID 3546 | 05:45:58 INFO - PID 3546 | Cycle 1(1): loaded http://localhost:41231/tests/dromaeo/cssquery-yui.html (next: http://localhost:41231/tests/dromaeo/cssquery-dojo.html) 05:45:59 INFO - PID 3546 | RSS: Main: 178114560 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | __start_tp_report 05:45:59 INFO - PID 3546 | _x_x_mozilla_page_load 05:45:59 INFO - PID 3546 | _x_x_mozilla_page_load_details 05:45:59 INFO - PID 3546 | |i|pagename|runs| 05:45:59 INFO - PID 3546 | |0;dojo.html;3364.7981121132734;3408.216110294634;3433.9484907726373;3449.8447569859354;3490.441529355302;6053.939460605393;6139.9828168395;6239.220097487814;6239.750409983607;6246.906296405557;6194.907076393846;6206.286277078138;6225.8132256032395;6234.189555357797;6279.18370611821;5497.230387745719;5499.780008799643;5532.3637781655225;5536.114221724525;5566.582506312023;5413.566914646838;5424.566034717213;5505.9724701376435;5528.778848846041;5531.585131115163;5507.339119305709;5517.420670829545;5537.169424586304;5556.16657501374;5606.271184745998;5535.6955367454775;5580.525655319303;5585.966596179679;5598.468145526209;5634.690092044936;5514.751836167382;5551.8889622207735;5567.081431563787;5572.804951826666;5576.581756368289;6047.334793172748;6254.8123556293385;6276.435120839146;6276.811695649138;6308.337624549402;6674.599524028526;6683;6728.529002969794;6798.354156355138;6801.965990170067;6825.829354266183;6877.4841886858185;6883.621400822953;6897.965510172417;6904.965475172592;6351.714172862232;6359.8092057238355;6371.96814015927;6384.6169229846355;6394.904076438857;6799.524033317719;6899.275576064541;6902.654867256718;6913.274106218774;6914.101166848278;6540.574862634009;6611.140551728245;6629.801105966829;6654.035164901063;6667.699953502104;6851.2121106072445;6893.75871844483;6897.3447522485285;6921.688524016431;6922.238553759083;6812.93187068123;6819.727210911508;6820.897686534706;6847.109875716125;6861.794146175623;6815.522913396015;6864.519483636098;6879.105716256955;6885.483588730865;6920.619365934922;4985.077760614298;5016.498350165028;5020.422651395063;5041.521055499722;5127.512886275797;4455.799489023002;4495.57292057254;4511.120331535385;4541.909941614055;4551.158035763395;6249.062640603855;6251.156093927352;6255.249370075529;6259.061140828821;6269.529785266123;6756.797296081126;6768.357006084414;6803.183617965876;6803.795886123424;6810.965945170243;6132.263729246545;6187.257529096537;6207.503399728011;6217.658028808459;6231.940570103094;5643.238162847963;5688.175214593861;5690.5447564194765;5691.857703557362;5698.686572238566;6937.549059311129;6968.23349431552;7015.754448594377;7020.297970202939;7047.154341479055;6754.493412993947;6754.8649027020165;6775.186977562724;6780.38976492118;6822.761203357859;7003.894941575983;7028.718851246097;7036.507444478837;7042.612656303748;7052.471064670068;6426.775062872777;6559.8032059038305;6648.235452922976;6758.121444212221;6776.898346524905;6859.485538584527;6933.272006439453;6942.722291108299;6960.060391847036;6976.7558135465015;6654.90017649726;6698.162729658793;6702.19573651165;6717.227518835201;6748.325167483213;6696.096027036482;6724.663766811737;6736.730530778714;6747.527673063035;6752;6437.388448097423;6538.607683539003;6541.967290163519;6584.967075164594;6671.166104236971;6720.495962802712;6748.19021717397;6796.558223715443;6801.965990170018;6812.795616131326;6444.806655800334;6524.249711283263;6533.18335208099;6546.0508226305965;6546.738130474728 05:45:59 INFO - PID 3546 | |1;ext.html;886.620890758455;907.3693782820942;928.7910220200454;947.7488465556625;955.5604421965895;39424.40863387048;40709.38935915956;40982.79508602456;41002.97492562684;41161.58838411615;37630.8118459408;37812.43281350775;38096.80951595245;38101;38147.80926095373;6415;6469.838254043663;6485.4811615070685;6486.935130648704;6519.576227545218;6351.714172862209;6370.872582548346;6445.452136568398;6447.806565803034;6494.415502604765;6380.393862583071;6429.48564114872;6438.710258038376;6489.675516224193;6498.187726534184;6294.276158241815;6411.93588064118;6417.807465776011;6422.871542569169;6478.157839480885;5845.5908086433965;5864.882702345929;5879.79420720277;5914.142449344864;5919.585629005971;38450.42324365137;38865.41701874474;38928.41607375892;39460.40809387833;39516.60483395158;3533.6819686228105;3539;3541.6458354164633;3549.8757543485854;3572.2498275362204;29457.852710736523;29464.70535294641;29503.852480737674;29660.70339296601;29743.10770676883;3765.6234376562397;3773.8664226352444;3781.3760729479604;3799.2781371539318;3839.865604703822;200617;202174;203097;205912;206097;43787.12425751467;49725.50274497209;49887.50112498829;50036.74981625069;50099.74950125299;53233;53333.133340333676;53494.73252633712;53674;53819.73090134524;15813.604659883365;15841.52475425739;15948.601284967968;15953.04281743099;15971.600709982344;12496.125271231109;12656.17734847232;12769.936150319374;12800.74398512043;12837.871621283854;14576.927115364355;14662.046966947115;14669;14789.186594737177;14924.552263432115;5557.833265002057;5725.742341594639;5859.476536100559;5872.473156979217;5875.941240587539;1093.6937657455926;1095.3537412926412;1113.1984970820995;1114.8272017837087;1116.391566596207;24793.752062479503;24848.5030299393;24904.252872413857;25079.498410031698;25196.74803251981;1236.313845815581;1238.1766125526424;1242.3601845049807;1245.0662003497378;1247.5945317771761;13370.465181392636;13427.060105792501;13438.126521776054;13473.258970756506;13482.460701571827;259801;265089;292152;293627;293664;53537.73231133897;53726.19410708843;53962.19056714152;54050.72974635102;54057.72971135198;1515.2272341106116;1516.9317380717894;1517.833038365779;1528.0678785940568;1537.5617948884515;27714.445711085264;29021.7097829019;29310;29420.705792941797;29747.553786692784;38830.2233955325;38945.22109557736;39054.6094539051;39072.6092739069;39232.411513826744;243866;243931;246746;247087;248087;30581.54127688131;31052.844735776176;31081.533776993816;31140.844295778377;34100.488492673125;40382;40422.68446425621;41385.37921931113;42289.154216916104;42696;29675;30018.3996320068;30137.24656883508;30160.698393016668;31831.681683182873;30100.54849177308;30225.697743023167;30946.69053309438;31684.36631267408;32024.519632206;35972.28055438929;36389.81805090958;36462.8176859114;36556;36670.816645917665;28016.29959251035;29130.27174320659;29588.260293492836;30280.334581598225;31063;23279.18522851692;24304.51390972206;24480.26559203227;24670.383240419134;24748.87625561861 05:45:59 INFO - PID 3546 | |2;jquery.html;540.5756481162289;561.7696744334824;569.965802051877;579.3511267380533;586.3784388548139;20995;21974.121035158594;22050.33848984529;22056.88971555144;22160.556788864233;24282.514349712994;25058;26333.21000369987;26528.33679158022;26659.733402665966;6188.443040126388;6351.17434733484;6353.0788035734795;6366.968165159168;6371.267304260023;6165.630062196283;6254.43710066094;6254.46837018854;6257.998720204768;6261.092141639459;5640.802571909984;5930.88138237235;6162.815115546518;6222.066689996492;6224.751009959597;6139.693015349237;6222.502199824004;6237.157983672191;6238.157848690436;6258.624482531062;5786.739596718157;5802.100674395476;5803.88392232153;5823.417658234185;5831.317593906808;27700.722992770217;29431.411371772658;30046.54930176049;30192.698073019426;30242;2089.3836318286144;2227.7660845611304;2245.5621153875;2254.1997590855176;2254.5490901819703;18669.53326166843;19151.04244787755;19170.904145479322;19193.61612767751;19201.711974320395;2270.931872043825;2289.839711220215;2350.7884290413945;2363.550925324183;2407.205622144688;139716.30141849225;141919;142542.2872885629;142690;142730;14376.712465750627;15248;15349;15361.846381536265;15657.60855978587;23247.3025809226;23314.184003559792;23355.299341019796;23394;23472;9307.674231401868;9349.317122917804;9387.765305867408;9512.90487095134;9613.423194608346;8362.700257429135;8428.747137585882;8467.237948584658;8528.360372971927;8560.14398560139;9271.67549135777;9293.349465537347;9390.436573805457;9414.905850941403;9419.811603768023;2632.144553020276;2727.595288426462;2778.277647811543;2818.0841226601437;2878.870450829718;1049.5014867937668;1058.8252938265255;1073.1682945717132;1085.2674444749762;1102.415719668577;20305.796942030687;23268.418289542897;26000;26366;26401.867990659925;1121.9775604487866;1129.2998341028615;1141.3192454334703;1151.6314779270554;1157.548556063136;11898.583549575724;11935.164538482397;11958.521659133537;12017.399130043463;12033.939830300793;561329;613362;623032;632314;634170;111443;113505.43247283711;116840.41579792216;116857;118709;1229.3668760588305;1270.5235536673747;1275.993620031894;1279.1685404486973;1305.484333688188;17635.382761603283;18991.43025709231;19070.33253836109;19127.713084304025;19545.902270488557;51880;52816;53638.73180634072;55683.72158139183;57373.71313143407;70664.29335706578;71288.64355678188;71408;72015.27984720086;72968.63515682388;12000.75998480043;13047;13152.80270795958;13167.802482962954;13206.867931320563;18793.812061879205;18837.623247535248;18840.52898677544;18929;19064.809351906304;15646.843531564538;15890.841091588936;15968.600784980004;15974.68050639004;16164.353425862833;12734.172278801849;14104.858951410764;14188.290585470892;14528.564143075724;14906.25468726581;16258;16387;16429.34282628729;16543.338266469207;16722.414715484898;12782.936085319885;12878.678033048875;12963.481460741841;12978.610641680765;12999.675008124872;15767.605809854846;15784.60538486547;15987.280572374038;16087.919560402122;16108.436204732778 05:45:59 INFO - PID 3546 | |3;mootools.html;1440.5822311529657;1470.4853301344524;1471.5438214153612;1494.6487575419774;1520.2854658310594;14765.261736913151;15334.079955202682;15347.3093710783;15372.538823835303;15379.231038448075;14957.177355245458;15466.61333466664;15970.121643309642;16065.598360041005;16093.758593621105;2675.4381579868204;2707.4043710383685;2718.2796558911905;2719.9048033318836;2720.1295585412677;2632.3155979445387;2676.384431580738;2677.799165062628;2682.6646669166353;2687.9731202688017;2546.923592292225;2604.4530648563823;2664.6669166354204;2680.852553109588;2682.088090049383;2734.945301093977;2760.4617099665475;2760.792940529448;2767.9308017299527;2768.3632764464087;2649.9867500662567;2675.5184066867955;2676.839389636628;2678.25008997481;2683.6779586449557;15027.774583381259;15116.470923517623;15174;15174.241287935669;15176.317065732068;7753.806154846174;8010.399220058519;8084.959575202145;8089.271965523072;8105.351571874236;4466.932996005063;4629.051044535862;4759.190937540627;4827.806887724487;4832.4684284728655;1559.1736379718654;1600.3998500562288;1627.0644379481728;1636.7544868269736;1650.7936507936508;25669.358266043313;25967.701614919366;25970.350741231432;26034.34914127162;26146;6379.266384365765;6471.417572418505;6483.124778154983;6630.270670226271;6722.563033402813;17371.218295176746;17387.130643467775;17410.825891740922;17423.47729568115;17426.47720568385;7706.537607743553;7848.9215107848195;7852.057753069668;7854.136045035156;7863.724769633035;7106.822329441805;7225.963870180615;7238.276172382825;7294.817629559304;7344.522606030591;5158.277841102249;5296.655717378358;5310.654807437504;5313.229581710631;5343;1531.6170957260686;1541.406558474995;1541.961450963735;1542.3907556515114;1548.5741421109285;898.9640414383482;908.8818453601122;918.2424499787702;922.7739203895088;944.3012170993416;7456.384535417147;7509.13644930829;7517.210692877278;7569.621518924032;7649.04386951631;732.3482100930177;1008.4201584089031;1037.5953378182514;1042.8957104289511;1066.632011955874;5602.299712535933;5604.0767706125;5640.520555752725;5881.705914704247;5931.881362372728;21007.8949605251;21939;21944.45138871541;22059.89700514968;22073.668894966588;20465.18139274412;21345.35963921085;21577.13691452356;21685;21724.348269551938;11299;11431.714207144887;11964.88035119655;12114.878851211552;12120.878791212152;8295.04606970206;8464.746057618282;8838.646454141763;8918.10818918103;9188.40275382098;17993.640127197643;18458.353957611955;18799.90600046991;19036.904815475835;19180.616387672446;18502.44492665222;19038.238470461027;19473.61052778965;19487.415377538695;19708.901455492633;12198.451069702061;12669;12710.046746493865;12716.173448725804;12737.80893286583;13680.452781888613;13919.53844846317;13966.79049814274;14041.227732474403;14140.080894741808;11750.353730544903;11816.350100744541;11875.940620296844;12062.45718942632;12208.81686774717;11557.595484158013;11736.647900562997;12091.334976576372;12174.45214965311;12269.93865030669;10072.942341054084;10124.493775311352;10183.541740621542;10210.897891020995;10239.385636861813;7078.327558881898;7155.212926577969;7197.640117993975;7388.076490438695;7496.7750967471065;7513.737019204302;7593.05086864142;7653.311201991847;7812.92187078122;7890.408219383684 05:45:59 INFO - PID 3546 | |4;prototype.html;496.35226030030793;497.8694117819333;514.7992283009629;518.6887867279632;528.3052785586952;6232.376762323765;6299.905501417476;6325.620462772237;6326.746930122796;6340;6044.395560443953;6119.847003824907;6173.475254603364;6189.442950134487;6190.0405437157315;4862.465128835843;4875.878103047435;4884.3406140171155;4898.755062246892;4946.604271658277;4867.196912509449;4868.367112275399;4888.413390393158;4896.681715688486;4948.208286674133;4863.635227357945;4899.730514821684;4901.485344038878;4904.386951631046;4915.459299477055;4673.579377855992;4838.516148385133;4847;4855.8057677693205;4873.658843880912;4328.523862375137;4330.978345108286;4332.67504937131;4337.262665346899;4367.890802729958;6093.756249750005;6096.817095487142;6114.480269177126;6125.5712100153005;6130.203073600448;5769.1923130761725;5830.4169583041785;5837.737301821428;5846.853828654275;5861.9706901465215;6607.339266073354;6695.531312808105;6712.5301228913995;6715.294894036105;6743.224529179158;4921.261810728383;4939.925901111486;4941.827036053757;4952.455229924742;4962.702237865704;6867.278935711778;6908.3437073477935;6948.826279343007;6987.231404545496;7046.541974771675;5109.591232701375;5114.846554603368;5117.9764047189965;5131.717755523482;5132.486751324837;5216.556592689588;5220.451852555503;5233.345831771028;5234.869128271824;5240.633155679142;5856.619319744288;5865.208196893364;5868.562202260388;5873.735681894325;5875.030619947746;6737.730490780314;6743.123393958754;6750.45996320303;6754.6284954327;6757.662116894136;1728.7493313469477;1795.3267524678245;1798.5413719501444;1800.9369672061414;1808.1772793378982;1229.0843321725372;1231.9260844349367;1237.9319137447526;1264.740728150727;1272.2748033620933;6087.665178415141;6156.199694039746;6193.6903154842075;6207.6585787782105;6208.565400421927;6775.322467753185;6780;6814.48891333152;6818.147731533559;6854.675482391036;6194.132821405007;6225.408586184305;6225.782097626561;6238.532110091761;6261.906071408933;3571.1786289153642;3582.6775590197008;3604.747667663291;3607.4228123500116;3622.4023036198732;7063.858722825515;7065.293470652997;7096.432285417154;7119.181294151239;7126.928730712627;6977.51157418986;7016.859662806817;7018.684159212848;7020.104571765594;7074.443622403063;7059.5764254144915;7078.504504684725;7107.431405487549;7119.67961441726;7137.964310178416;6685.298043705536;6813.591184528944;6849.280825513449;6866.141732283465;6878.896816547855;6734;6743.291954344723;6744.763933262312;6753.58174783301;6766.627835469097;6691.8327041822395;6942.826429339307;7035.788926332219;7085.362317391459;7116.857662846817;5111.386633603991;5119.872003199801;5122.743862806919;5136.794528218829;5152.922706159486;6850.520463567702;6881.036654868222;6883.449324054164;6907.654617269217;6919.169699636076;6671.33286671329;6674.232463266592;6681.5656982296;6702.765403210864;6703.262641109376;6675.23234828001;6687.331266873273;6703.93296067033;6709.10235528077;6714.6978385973725;6603.7688680895935;6626.668666566556;6632.834179145367;6681.418802479651;6685.532012759255;6694.933050669431;6701.631410272482;6721.596704197764;6733.956236783307;6768.593884366954;6470.352964703492;6490.448311893542;6522.21733391996;6523.086767852409;6536.215654121535 05:45:59 INFO - PID 3546 | |5;yui.html;857.9528125953078;881.1849039638333;886;894.5035505294563;909.8407778638741;17137.742933856003;17551.64896702065;17679;17699;17706.468805935827;14946.327415266313;15306;15805;15831.05013699179;19057;1057.259918057361;1086.7663452357742;1090.4983707494523;1091.787101515201;1092.7869065532225;1074.8763892152385;1075.9031687148156;1076.3757020927842;1079.6221322537087;1085.7448499602588;1122;1127.7969965406223;1128.5090985421368;1137.1244142010646;1137.4483375562845;1020.3877673395978;1099.115212254135;1115.5259014918709;1128.097521982415;1130.5082289204222;794.2375319693044;808.9919100808976;812.3988248695922;814.0028465130227;817.9468334558294;18321.17554710041;18827.24691012358;18994.335198268134;18997.240110395705;19013.904930475397;19587.902060489607;19622.607547849108;20306.08622611986;20373.49066273355;20479.69280460794;15822.287997040046;15841.287142078634;15923.363065477368;15964.361425542964;15984.920075399548;3529.594096678889;3543.3090547343277;3546.733994950389;3632.8183590820354;3671.1739858531882;112348.43825780819;113416.86583134145;113634;114861.425692871;119693.40153299265;15640.2961866714;15878.52364429069;15994.520164395086;16007.43973960929;16040.75938860918;27593.862030689717;29462.263443414085;29598.408031839244;29610.111696648702;29736.702632973393;8864.8670269946;8872.334574906909;8925.73222803317;8980.146886045815;8981.461112333282;4203.096334288142;4228.746275223496;4316.568343165721;4317.892052698708;4346.130773845243;5072.6195535335;5107.259447380184;5119.488051194925;5143.97428012865;5167.173252279692;1038.325088692356;1064.87655523422;1083.3662307550014;1089.215764649451;1094.5676457799125;715.1275443958363;716.8673795347877;721.9241979592172;738.2580506590949;746.0934964018635;12721.809172862415;13219.471221151238;13404.798928016087;13452.45296790862;14153;714.878470659989;723.6815801047522;734.904462419882;740.2365776229977;750.6622020090981;5725.427457254241;6007.879842403127;6468.838279043061;6577.309382514863;6621.569597976116;107907.46046269718;108433;113595.43202283936;113845;117682;89589.55205223932;89940;91262.54368728246;91360;92208.53895730479;83049;93371.53314233385;93453;94484.11031779325;97005.5149724261;12730.68173295638;14119.929400353343;14460.783088253895;14481.782773258199;14518.274086295854;42732;43849.34225986549;44741;45035.774821125684;46965.76517117529;73139.63430182815;76747.61626191833;77967.61016194883;78167.218327816;79889.60055199919;19096.045197740335;19862.205511779368;20009.199632015137;20051.097700603215;20238.898805506466;19381.90309048446;20121.798782012578;21229.15083396647;21910;22450.32649020532;19087.42737717871;19725.112369943676;19779.30772423016;19845;19869.205231791144;18269;18379.172937218125;18671.81328186701;19208.80791192126;20187.495312617302;18703.438896833115;19125.90437047806;19304.903475482533;19408.223671053;19624.313149039714;13443.663908402368;13526.458941642224;13646.385912633757;13810.93094534521;13963.232022238468;14788.704225915637;16002.599935001717;16155.273012714692;16337.101459419846;16494.25775840114 05:45:59 INFO - PID 3546 | __end_tp_report 05:45:59 INFO - PID 3546 | __start_cc_report 05:45:59 INFO - PID 3546 | _x_x_mozilla_cycle_collect,314 05:45:59 INFO - PID 3546 | __end_cc_report 05:45:59 INFO - PID 3546 | __startTimestamp1498221959149__endTimestamp 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | ------- Summary: start ------- 05:45:59 INFO - PID 3546 | Number of tests: 6 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#0] dojo.html Cycles:165 Average:6242.48 Median:6541.97 stddev:799.19 (12.2%) stddev-sans-first:769.10 05:45:59 INFO - PID 3546 | Values: 3364.8 3408.2 3433.9 3449.8 3490.4 6053.9 6140.0 6239.2 6239.8 6246.9 6194.9 6206.3 6225.8 6234.2 6279.2 5497.2 5499.8 5532.4 5536.1 5566.6 5413.6 5424.6 5506.0 5528.8 5531.6 5507.3 5517.4 5537.2 5556.2 5606.3 5535.7 5580.5 5586.0 5598.5 5634.7 5514.8 5551.9 5567.1 5572.8 5576.6 6047.3 6254.8 6276.4 6276.8 6308.3 6674.6 6683.0 6728.5 6798.4 6802.0 6825.8 6877.5 6883.6 6898.0 6905.0 6351.7 6359.8 6372.0 6384.6 6394.9 6799.5 6899.3 6902.7 6913.3 6914.1 6540.6 6611.1 6629.8 6654.0 6667.7 6851.2 6893.8 6897.3 6921.7 6922.2 6812.9 6819.7 6820.9 6847.1 6861.8 6815.5 6864.5 6879.1 6885.5 6920.6 4985.1 5016.5 5020.4 5041.5 5127.5 4455.8 4495.6 4511.1 4541.9 4551.2 6249.1 6251.2 6255.2 6259.1 6269.5 6756.8 6768.4 6803.2 6803.8 6811.0 6132.3 6187.3 6207.5 6217.7 6231.9 5643.2 5688.2 5690.5 5691.9 5698.7 6937.5 6968.2 7015.8 7020.3 7047.2 6754.5 6754.9 6775.2 6780.4 6822.8 7003.9 7028.7 7036.5 7042.6 7052.5 6426.8 6559.8 6648.2 6758.1 6776.9 6859.5 6933.3 6942.7 6960.1 6976.8 6654.9 6698.2 6702.2 6717.2 6748.3 6696.1 6724.7 6736.7 6747.5 6752.0 6437.4 6538.6 6542.0 6585.0 6671.2 6720.5 6748.2 6796.6 6802.0 6812.8 6444.8 6524.2 6533.2 6546.1 6546.7 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#1] ext.html Cycles:180 Average:40493.69 Median:3536.34 stddev:64106.79 (1812.8%) stddev-sans-first:64217.65 05:45:59 INFO - PID 3546 | Values: 886.6 907.4 928.8 947.7 955.6 39424.4 40709.4 40982.8 41003.0 41161.6 37630.8 37812.4 38096.8 38101.0 38147.8 6415.0 6469.8 6485.5 6486.9 6519.6 6351.7 6370.9 6445.5 6447.8 6494.4 6380.4 6429.5 6438.7 6489.7 6498.2 6294.3 6411.9 6417.8 6422.9 6478.2 5845.6 5864.9 5879.8 5914.1 5919.6 38450.4 38865.4 38928.4 39460.4 39516.6 3533.7 3539.0 3541.6 3549.9 3572.2 29457.9 29464.7 29503.9 29660.7 29743.1 3765.6 3773.9 3781.4 3799.3 3839.9 200617.0 202174.0 203097.0 205912.0 206097.0 43787.1 49725.5 49887.5 50036.7 50099.7 53233.0 53333.1 53494.7 53674.0 53819.7 15813.6 15841.5 15948.6 15953.0 15971.6 12496.1 12656.2 12769.9 12800.7 12837.9 14576.9 14662.0 14669.0 14789.2 14924.6 5557.8 5725.7 5859.5 5872.5 5875.9 1093.7 1095.4 1113.2 1114.8 1116.4 24793.8 24848.5 24904.3 25079.5 25196.7 1236.3 1238.2 1242.4 1245.1 1247.6 13370.5 13427.1 13438.1 13473.3 13482.5 259801.0 265089.0 292152.0 293627.0 293664.0 53537.7 53726.2 53962.2 54050.7 54057.7 1515.2 1516.9 1517.8 1528.1 1537.6 27714.4 29021.7 29310.0 29420.7 29747.6 38830.2 38945.2 39054.6 39072.6 39232.4 243866.0 243931.0 246746.0 247087.0 248087.0 30581.5 31052.8 31081.5 31140.8 34100.5 40382.0 40422.7 41385.4 42289.2 42696.0 29675.0 30018.4 30137.2 30160.7 31831.7 30100.5 30225.7 30946.7 31684.4 32024.5 35972.3 36389.8 36462.8 36556.0 36670.8 28016.3 29130.3 29588.3 30280.3 31063.0 23279.2 24304.5 24480.3 24670.4 24748.9 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#2] jquery.html Cycles:180 Average:37852.62 Median:2262.74 stddev:102028.25 (4509.1%) stddev-sans-first:102276.00 05:45:59 INFO - PID 3546 | Values: 540.6 561.8 570.0 579.4 586.4 20995.0 21974.1 22050.3 22056.9 22160.6 24282.5 25058.0 26333.2 26528.3 26659.7 6188.4 6351.2 6353.1 6367.0 6371.3 6165.6 6254.4 6254.5 6258.0 6261.1 5640.8 5930.9 6162.8 6222.1 6224.8 6139.7 6222.5 6237.2 6238.2 6258.6 5786.7 5802.1 5803.9 5823.4 5831.3 27700.7 29431.4 30046.5 30192.7 30242.0 2089.4 2227.8 2245.6 2254.2 2254.5 18669.5 19151.0 19170.9 19193.6 19201.7 2270.9 2289.8 2350.8 2363.6 2407.2 139716.3 141919.0 142542.3 142690.0 142730.0 14376.7 15248.0 15349.0 15361.8 15657.6 23247.3 23314.2 23355.3 23394.0 23472.0 9307.7 9349.3 9387.8 9512.9 9613.4 8362.7 8428.7 8467.2 8528.4 8560.1 9271.7 9293.3 9390.4 9414.9 9419.8 2632.1 2727.6 2778.3 2818.1 2878.9 1049.5 1058.8 1073.2 1085.3 1102.4 20305.8 23268.4 26000.0 26366.0 26401.9 1122.0 1129.3 1141.3 1151.6 1157.5 11898.6 11935.2 11958.5 12017.4 12033.9 561329.0 613362.0 623032.0 632314.0 634170.0 111443.0 113505.4 116840.4 116857.0 118709.0 1229.4 1270.5 1276.0 1279.2 1305.5 17635.4 18991.4 19070.3 19127.7 19545.9 51880.0 52816.0 53638.7 55683.7 57373.7 70664.3 71288.6 71408.0 72015.3 72968.6 12000.8 13047.0 13152.8 13167.8 13206.9 18793.8 18837.6 18840.5 18929.0 19064.8 15646.8 15890.8 15968.6 15974.7 16164.4 12734.2 14104.9 14188.3 14528.6 14906.3 16258.0 16387.0 16429.3 16543.3 16722.4 12782.9 12878.7 12963.5 12978.6 12999.7 15767.6 15784.6 15987.3 16087.9 16108.4 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#3] mootools.html Cycles:180 Average:9430.88 Median:25818.53 stddev:6708.76 (26.0%) stddev-sans-first:6700.72 05:45:59 INFO - PID 3546 | Values: 1440.6 1470.5 1471.5 1494.6 1520.3 14765.3 15334.1 15347.3 15372.5 15379.2 14957.2 15466.6 15970.1 16065.6 16093.8 2675.4 2707.4 2718.3 2719.9 2720.1 2632.3 2676.4 2677.8 2682.7 2688.0 2546.9 2604.5 2664.7 2680.9 2682.1 2734.9 2760.5 2760.8 2767.9 2768.4 2650.0 2675.5 2676.8 2678.3 2683.7 15027.8 15116.5 15174.0 15174.2 15176.3 7753.8 8010.4 8085.0 8089.3 8105.4 4466.9 4629.1 4759.2 4827.8 4832.5 1559.2 1600.4 1627.1 1636.8 1650.8 25669.4 25967.7 25970.4 26034.3 26146.0 6379.3 6471.4 6483.1 6630.3 6722.6 17371.2 17387.1 17410.8 17423.5 17426.5 7706.5 7848.9 7852.1 7854.1 7863.7 7106.8 7226.0 7238.3 7294.8 7344.5 5158.3 5296.7 5310.7 5313.2 5343.0 1531.6 1541.4 1542.0 1542.4 1548.6 899.0 908.9 918.2 922.8 944.3 7456.4 7509.1 7517.2 7569.6 7649.0 732.3 1008.4 1037.6 1042.9 1066.6 5602.3 5604.1 5640.5 5881.7 5931.9 21007.9 21939.0 21944.5 22059.9 22073.7 20465.2 21345.4 21577.1 21685.0 21724.3 11299.0 11431.7 11964.9 12114.9 12120.9 8295.0 8464.7 8838.6 8918.1 9188.4 17993.6 18458.4 18799.9 19036.9 19180.6 18502.4 19038.2 19473.6 19487.4 19708.9 12198.5 12669.0 12710.0 12716.2 12737.8 13680.5 13919.5 13966.8 14041.2 14140.1 11750.4 11816.4 11875.9 12062.5 12208.8 11557.6 11736.6 12091.3 12174.5 12269.9 10072.9 10124.5 10183.5 10210.9 10239.4 7078.3 7155.2 7197.6 7388.1 7496.8 7513.7 7593.1 7653.3 7812.9 7890.4 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#4] prototype.html Cycles:180 Average:5643.83 Median:6216.99 stddev:1622.41 (26.1%) stddev-sans-first:1580.29 05:45:59 INFO - PID 3546 | Values: 496.4 497.9 514.8 518.7 528.3 6232.4 6299.9 6325.6 6326.7 6340.0 6044.4 6119.8 6173.5 6189.4 6190.0 4862.5 4875.9 4884.3 4898.8 4946.6 4867.2 4868.4 4888.4 4896.7 4948.2 4863.6 4899.7 4901.5 4904.4 4915.5 4673.6 4838.5 4847.0 4855.8 4873.7 4328.5 4331.0 4332.7 4337.3 4367.9 6093.8 6096.8 6114.5 6125.6 6130.2 5769.2 5830.4 5837.7 5846.9 5862.0 6607.3 6695.5 6712.5 6715.3 6743.2 4921.3 4939.9 4941.8 4952.5 4962.7 6867.3 6908.3 6948.8 6987.2 7046.5 5109.6 5114.8 5118.0 5131.7 5132.5 5216.6 5220.5 5233.3 5234.9 5240.6 5856.6 5865.2 5868.6 5873.7 5875.0 6737.7 6743.1 6750.5 6754.6 6757.7 1728.7 1795.3 1798.5 1800.9 1808.2 1229.1 1231.9 1237.9 1264.7 1272.3 6087.7 6156.2 6193.7 6207.7 6208.6 6775.3 6780.0 6814.5 6818.1 6854.7 6194.1 6225.4 6225.8 6238.5 6261.9 3571.2 3582.7 3604.7 3607.4 3622.4 7063.9 7065.3 7096.4 7119.2 7126.9 6977.5 7016.9 7018.7 7020.1 7074.4 7059.6 7078.5 7107.4 7119.7 7138.0 6685.3 6813.6 6849.3 6866.1 6878.9 6734.0 6743.3 6744.8 6753.6 6766.6 6691.8 6942.8 7035.8 7085.4 7116.9 5111.4 5119.9 5122.7 5136.8 5152.9 6850.5 6881.0 6883.4 6907.7 6919.2 6671.3 6674.2 6681.6 6702.8 6703.3 6675.2 6687.3 6703.9 6709.1 6714.7 6603.8 6626.7 6632.8 6681.4 6685.5 6694.9 6701.6 6721.6 6734.0 6768.6 6470.4 6490.4 6522.2 6523.1 6536.2 05:45:59 INFO - PID 3546 | 05:45:59 INFO - PID 3546 | [#5] yui.html Cycles:180 Average:23843.17 Median:19498.06 stddev:31597.98 (162.1%) stddev-sans-first:31639.48 05:45:59 INFO - PID 3546 | Values: 858.0 881.2 886.0 894.5 909.8 17137.7 17551.6 17679.0 17699.0 17706.5 14946.3 15306.0 15805.0 15831.1 19057.0 1057.3 1086.8 1090.5 1091.8 1092.8 1074.9 1075.9 1076.4 1079.6 1085.7 1122.0 1127.8 1128.5 1137.1 1137.4 1020.4 1099.1 1115.5 1128.1 1130.5 794.2 809.0 812.4 814.0 817.9 18321.2 18827.2 18994.3 18997.2 19013.9 19587.9 19622.6 20306.1 20373.5 20479.7 15822.3 15841.3 15923.4 15964.4 15984.9 3529.6 3543.3 3546.7 3632.8 3671.2 112348.4 113416.9 113634.0 114861.4 119693.4 15640.3 15878.5 15994.5 16007.4 16040.8 27593.9 29462.3 29598.4 29610.1 29736.7 8864.9 8872.3 8925.7 8980.1 8981.5 4203.1 4228.7 4316.6 4317.9 4346.1 5072.6 5107.3 5119.5 5144.0 5167.2 1038.3 1064.9 1083.4 1089.2 1094.6 715.1 716.9 721.9 738.3 746.1 12721.8 13219.5 13404.8 13452.5 14153.0 714.9 723.7 734.9 740.2 750.7 5725.4 6007.9 6468.8 6577.3 6621.6 107907.5 108433.0 113595.4 113845.0 117682.0 89589.6 89940.0 91262.5 91360.0 92208.5 83049.0 93371.5 93453.0 94484.1 97005.5 12730.7 14119.9 14460.8 14481.8 14518.3 42732.0 43849.3 44741.0 45035.8 46965.8 73139.6 76747.6 77967.6 78167.2 79889.6 19096.0 19862.2 20009.2 20051.1 20238.9 19381.9 20121.8 21229.2 21910.0 22450.3 19087.4 19725.1 19779.3 19845.0 19869.2 18269.0 18379.2 18671.8 19208.8 20187.5 18703.4 19125.9 19304.9 19408.2 19624.3 13443.7 13526.5 13646.4 13810.9 13963.2 14788.7 16002.6 16155.3 16337.1 16494.3 05:45:59 INFO - PID 3546 | -------- Summary: end -------- 05:45:59 INFO - PID 3546 | 05:45:59 INFO - TEST-INFO | 3546: exit 0 05:45:59 INFO - TEST-OK | dromaeo_css | took 1117223ms 05:45:59 INFO - TEST-START | kraken 05:45:59 INFO - operating with platform_type : linux_ 05:45:59 INFO - Initialising browser for kraken test... 05:45:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41231/getInfo.html -profile /tmp/tmp_e1iTj/profile 05:45:59 INFO - TEST-INFO | started process 3969 (/builds/slave/test/build/application/firefox/firefox http://localhost:41231/getInfo.html) 05:46:05 INFO - TEST-INFO | 3969: exit 0 05:46:05 INFO - Browser initialized. 05:46:05 INFO - Running cycle 1/1 for kraken test... 05:46:05 INFO - TEST-INFO | started process 4211 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_e1iTj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:17 INFO - PID 4211 | RSS: Main: 162734080 05:46:17 INFO - PID 4211 | 05:46:19 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41231/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:20 INFO - PID 4211 | RSS: Main: 167862272 05:46:20 INFO - PID 4211 | 05:46:23 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41231/tests/kraken/driver.html?testName=audio-dft) 05:46:23 INFO - PID 4211 | RSS: Main: 168079360 05:46:23 INFO - PID 4211 | 05:46:26 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41231/tests/kraken/driver.html?testName=audio-fft) 05:46:27 INFO - PID 4211 | RSS: Main: 162566144 05:46:27 INFO - PID 4211 | 05:46:29 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41231/tests/kraken/driver.html?testName=audio-oscillator) 05:46:30 INFO - PID 4211 | RSS: Main: 164114432 05:46:30 INFO - PID 4211 | 05:46:32 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41231/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:32 INFO - PID 4211 | RSS: Main: 163614720 05:46:32 INFO - PID 4211 | 05:46:35 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41231/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:36 INFO - PID 4211 | RSS: Main: 163577856 05:46:36 INFO - PID 4211 | 05:46:39 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41231/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:40 INFO - PID 4211 | RSS: Main: 167477248 05:46:40 INFO - PID 4211 | 05:46:43 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41231/tests/kraken/driver.html?testName=json-parse-financial) 05:46:43 INFO - PID 4211 | RSS: Main: 167190528 05:46:43 INFO - PID 4211 | 05:46:45 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41231/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:45 INFO - PID 4211 | RSS: Main: 167051264 05:46:45 INFO - PID 4211 | 05:46:47 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:48 INFO - PID 4211 | RSS: Main: 167862272 05:46:48 INFO - PID 4211 | 05:46:50 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:50 INFO - PID 4211 | RSS: Main: 167768064 05:46:50 INFO - PID 4211 | 05:46:53 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:54 INFO - PID 4211 | RSS: Main: 167198720 05:46:54 INFO - PID 4211 | 05:46:56 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:57 INFO - PID 4211 | RSS: Main: 167276544 05:46:57 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | Cycle 1(1): loaded http://localhost:41231/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41231/tests/kraken/driver.html?testName=ai-astar) 05:46:59 INFO - PID 4211 | RSS: Main: 169205760 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | __start_tp_report 05:46:59 INFO - PID 4211 | _x_x_mozilla_page_load 05:46:59 INFO - PID 4211 | _x_x_mozilla_page_load_details 05:46:59 INFO - PID 4211 | |i|pagename|runs| 05:46:59 INFO - PID 4211 | |0;ai-astar;101;106;106;105;108;106;105;106;106;110 05:46:59 INFO - PID 4211 | |1;audio-beat-detection;142;115;141;161;115;143;149;117;165;128 05:46:59 INFO - PID 4211 | |2;audio-dft;163;166;164;164;163;160;165;164;173;173 05:46:59 INFO - PID 4211 | |3;audio-fft;75;74;73;190;75;73;75;73;158;73 05:46:59 INFO - PID 4211 | |4;audio-oscillator;81;80;136;81;81;81;130;81;81;128 05:46:59 INFO - PID 4211 | |5;imaging-gaussian-blur;114;114;114;114;113;113;113;114;113;113 05:46:59 INFO - PID 4211 | |6;imaging-darkroom;148;149;148;150;149;149;149;150;149;149 05:46:59 INFO - PID 4211 | |7;imaging-desaturate;95;94;95;95;94;94;94;94;95;95 05:46:59 INFO - PID 4211 | |8;json-parse-financial;46;49;46;47;47;53;49;50;47;48 05:46:59 INFO - PID 4211 | |9;json-stringify-tinderbox;54;53;54;54;54;54;56;54;54;55 05:46:59 INFO - PID 4211 | |10;stanford-crypto-aes;75;76;75;75;74;85;76;83;74;75 05:46:59 INFO - PID 4211 | |11;stanford-crypto-ccm;124;126;127;123;128;118;126;119;121;156 05:46:59 INFO - PID 4211 | |12;stanford-crypto-pbkdf2;173;177;171;173;169;177;187;171;177;170 05:46:59 INFO - PID 4211 | |13;stanford-crypto-sha256-iterative;61;61;60;60;62;62;62;60;60;62 05:46:59 INFO - PID 4211 | __end_tp_report 05:46:59 INFO - PID 4211 | __start_cc_report 05:46:59 INFO - PID 4211 | _x_x_mozilla_cycle_collect,818 05:46:59 INFO - PID 4211 | __end_cc_report 05:46:59 INFO - PID 4211 | __startTimestamp1498222019474__endTimestamp 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | ------- Summary: start ------- 05:46:59 INFO - PID 4211 | Number of tests: 14 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#0] ai-astar Cycles:10 Average:105.90 Median:106.00 stddev:2.28 (2.2%) stddev-sans-first:1.59 05:46:59 INFO - PID 4211 | Values: 101.0 106.0 106.0 105.0 108.0 106.0 105.0 106.0 106.0 110.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:142.50 stddev:18.34 (12.9%) stddev-sans-first:19.38 05:46:59 INFO - PID 4211 | Values: 142.0 115.0 141.0 161.0 115.0 143.0 149.0 117.0 165.0 128.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#2] audio-dft Cycles:10 Average:165.50 Median:164.50 stddev:4.25 (2.6%) stddev-sans-first:4.41 05:46:59 INFO - PID 4211 | Values: 163.0 166.0 164.0 164.0 163.0 160.0 165.0 164.0 173.0 173.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#3] audio-fft Cycles:10 Average:93.90 Median:73.50 stddev:42.89 (58.4%) stddev-sans-first:44.95 05:46:59 INFO - PID 4211 | Values: 75.0 74.0 73.0 190.0 75.0 73.0 75.0 73.0 158.0 73.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:81.00 stddev:24.46 (30.2%) stddev-sans-first:25.34 05:46:59 INFO - PID 4211 | Values: 81.0 80.0 136.0 81.0 81.0 81.0 130.0 81.0 81.0 128.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:46:59 INFO - PID 4211 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 05:46:59 INFO - PID 4211 | Values: 148.0 149.0 148.0 150.0 149.0 149.0 149.0 150.0 149.0 149.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 05:46:59 INFO - PID 4211 | Values: 95.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.50 stddev:2.15 (4.4%) stddev-sans-first:2.13 05:46:59 INFO - PID 4211 | Values: 46.0 49.0 46.0 47.0 47.0 53.0 49.0 50.0 47.0 48.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 05:46:59 INFO - PID 4211 | Values: 54.0 53.0 54.0 54.0 54.0 54.0 56.0 54.0 54.0 55.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:75.50 stddev:3.88 (5.1%) stddev-sans-first:4.06 05:46:59 INFO - PID 4211 | Values: 75.0 76.0 75.0 75.0 74.0 85.0 76.0 83.0 74.0 75.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:126.00 stddev:10.80 (8.6%) stddev-sans-first:11.41 05:46:59 INFO - PID 4211 | Values: 124.0 126.0 127.0 123.0 128.0 118.0 126.0 119.0 121.0 156.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:5.32 (3.0%) stddev-sans-first:5.61 05:46:59 INFO - PID 4211 | Values: 173.0 177.0 171.0 173.0 169.0 177.0 187.0 171.0 177.0 170.0 05:46:59 INFO - PID 4211 | 05:46:59 INFO - PID 4211 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.00 Median:61.50 stddev:0.94 (1.5%) stddev-sans-first:1.00 05:46:59 INFO - PID 4211 | Values: 61.0 61.0 60.0 60.0 62.0 62.0 62.0 60.0 60.0 62.0 05:46:59 INFO - PID 4211 | -------- Summary: end -------- 05:46:59 INFO - PID 4211 | 05:47:00 INFO - TEST-INFO | 4211: exit 0 05:47:00 INFO - TEST-OK | kraken | took 60480ms 05:47:00 INFO - SUITE-END | took 1177s 05:47:00 INFO - Completed test suite (00:19:38) 05:47:00 INFO - javascript benchmark 05:47:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8592.31704042056, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.7981121132734, 3408.216110294634, 3433.9484907726373, 3449.8447569859354, 3490.441529355302, 6053.939460605393, 6139.9828168395, 6239.220097487814, 6239.750409983607, 6246.906296405557, 6194.907076393846, 6206.286277078138, 6225.8132256032395, 6234.189555357797, 6279.18370611821, 5497.230387745719, 5499.780008799643, 5532.3637781655225, 5536.114221724525, 5566.582506312023, 5413.566914646838, 5424.566034717213, 5505.9724701376435, 5528.778848846041, 5531.585131115163, 5507.339119305709, 5517.420670829545, 5537.169424586304, 5556.16657501374, 5606.271184745998, 5535.6955367454775, 5580.525655319303, 5585.966596179679, 5598.468145526209, 5634.690092044936, 5514.751836167382, 5551.8889622207735, 5567.081431563787, 5572.804951826666, 5576.581756368289, 6047.334793172748, 6254.8123556293385, 6276.435120839146, 6276.811695649138, 6308.337624549402, 6674.599524028526, 6683.0, 6728.529002969794, 6798.354156355138, 6801.965990170067, 6825.829354266183, 6877.4841886858185, 6883.621400822953, 6897.965510172417, 6904.965475172592, 6351.714172862232, 6359.8092057238355, 6371.96814015927, 6384.6169229846355, 6394.904076438857, 6799.524033317719, 6899.275576064541, 6902.654867256718, 6913.274106218774, 6914.101166848278, 6540.574862634009, 6611.140551728245, 6629.801105966829, 6654.035164901063, 6667.699953502104, 6851.2121106072445, 6893.75871844483, 6897.3447522485285, 6921.688524016431, 6922.238553759083, 6812.93187068123, 6819.727210911508, 6820.897686534706, 6847.109875716125, 6861.794146175623, 6815.522913396015, 6864.519483636098, 6879.105716256955, 6885.483588730865, 6920.619365934922, 4985.077760614298, 5016.498350165028, 5020.422651395063, 5041.521055499722, 5127.512886275797, 4455.799489023002, 4495.57292057254, 4511.120331535385, 4541.909941614055, 4551.158035763395, 6249.062640603855, 6251.156093927352, 6255.249370075529, 6259.061140828821, 6269.529785266123, 6756.797296081126, 6768.357006084414, 6803.183617965876, 6803.795886123424, 6810.965945170243, 6132.263729246545, 6187.257529096537, 6207.503399728011, 6217.658028808459, 6231.940570103094, 5643.238162847963, 5688.175214593861, 5690.5447564194765, 5691.857703557362, 5698.686572238566, 6937.549059311129, 6968.23349431552, 7015.754448594377, 7020.297970202939, 7047.154341479055, 6754.493412993947, 6754.8649027020165, 6775.186977562724, 6780.38976492118, 6822.761203357859, 7003.894941575983, 7028.718851246097, 7036.507444478837, 7042.612656303748, 7052.471064670068, 6426.775062872777, 6559.8032059038305, 6648.235452922976, 6758.121444212221, 6776.898346524905, 6859.485538584527, 6933.272006439453, 6942.722291108299, 6960.060391847036, 6976.7558135465015, 6654.90017649726, 6698.162729658793, 6702.19573651165, 6717.227518835201, 6748.325167483213, 6696.096027036482, 6724.663766811737, 6736.730530778714, 6747.527673063035, 6752.0, 6437.388448097423, 6538.607683539003, 6541.967290163519, 6584.967075164594, 6671.166104236971, 6720.495962802712, 6748.19021717397, 6796.558223715443, 6801.965990170018, 6812.795616131326, 6444.806655800334, 6524.249711283263, 6533.18335208099, 6546.0508226305965, 6546.738130474728], "value": 6181.314553403051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.620890758455, 907.3693782820942, 928.7910220200454, 947.7488465556625, 955.5604421965895, 39424.40863387048, 40709.38935915956, 40982.79508602456, 41002.97492562684, 41161.58838411615, 37630.8118459408, 37812.43281350775, 38096.80951595245, 38101.0, 38147.80926095373, 6415.0, 6469.838254043663, 6485.4811615070685, 6486.935130648704, 6519.576227545218, 6351.714172862209, 6370.872582548346, 6445.452136568398, 6447.806565803034, 6494.415502604765, 6380.393862583071, 6429.48564114872, 6438.710258038376, 6489.675516224193, 6498.187726534184, 6294.276158241815, 6411.93588064118, 6417.807465776011, 6422.871542569169, 6478.157839480885, 5845.5908086433965, 5864.882702345929, 5879.79420720277, 5914.142449344864, 5919.585629005971, 38450.42324365137, 38865.41701874474, 38928.41607375892, 39460.40809387833, 39516.60483395158, 3533.6819686228105, 3539.0, 3541.6458354164633, 3549.8757543485854, 3572.2498275362204, 29457.852710736523, 29464.70535294641, 29503.852480737674, 29660.70339296601, 29743.10770676883, 3765.6234376562397, 3773.8664226352444, 3781.3760729479604, 3799.2781371539318, 3839.865604703822, 200617.0, 202174.0, 203097.0, 205912.0, 206097.0, 43787.12425751467, 49725.50274497209, 49887.50112498829, 50036.74981625069, 50099.74950125299, 53233.0, 53333.133340333676, 53494.73252633712, 53674.0, 53819.73090134524, 15813.604659883365, 15841.52475425739, 15948.601284967968, 15953.04281743099, 15971.600709982344, 12496.125271231109, 12656.17734847232, 12769.936150319374, 12800.74398512043, 12837.871621283854, 14576.927115364355, 14662.046966947115, 14669.0, 14789.186594737177, 14924.552263432115, 5557.833265002057, 5725.742341594639, 5859.476536100559, 5872.473156979217, 5875.941240587539, 1093.6937657455926, 1095.3537412926412, 1113.1984970820995, 1114.8272017837087, 1116.391566596207, 24793.752062479503, 24848.5030299393, 24904.252872413857, 25079.498410031698, 25196.74803251981, 1236.313845815581, 1238.1766125526424, 1242.3601845049807, 1245.0662003497378, 1247.5945317771761, 13370.465181392636, 13427.060105792501, 13438.126521776054, 13473.258970756506, 13482.460701571827, 259801.0, 265089.0, 292152.0, 293627.0, 293664.0, 53537.73231133897, 53726.19410708843, 53962.19056714152, 54050.72974635102, 54057.72971135198, 1515.2272341106116, 1516.9317380717894, 1517.833038365779, 1528.0678785940568, 1537.5617948884515, 27714.445711085264, 29021.7097829019, 29310.0, 29420.705792941797, 29747.553786692784, 38830.2233955325, 38945.22109557736, 39054.6094539051, 39072.6092739069, 39232.411513826744, 243866.0, 243931.0, 246746.0, 247087.0, 248087.0, 30581.54127688131, 31052.844735776176, 31081.533776993816, 31140.844295778377, 34100.488492673125, 40382.0, 40422.68446425621, 41385.37921931113, 42289.154216916104, 42696.0, 29675.0, 30018.3996320068, 30137.24656883508, 30160.698393016668, 31831.681683182873, 30100.54849177308, 30225.697743023167, 30946.69053309438, 31684.36631267408, 32024.519632206, 35972.28055438929, 36389.81805090958, 36462.8176859114, 36556.0, 36670.816645917665, 28016.29959251035, 29130.27174320659, 29588.260293492836, 30280.334581598225, 31063.0, 23279.18522851692, 24304.51390972206, 24480.26559203227, 24670.383240419134, 24748.87625561861], "value": 16996.33911535704, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.5756481162289, 561.7696744334824, 569.965802051877, 579.3511267380533, 586.3784388548139, 20995.0, 21974.121035158594, 22050.33848984529, 22056.88971555144, 22160.556788864233, 24282.514349712994, 25058.0, 26333.21000369987, 26528.33679158022, 26659.733402665966, 6188.443040126388, 6351.17434733484, 6353.0788035734795, 6366.968165159168, 6371.267304260023, 6165.630062196283, 6254.43710066094, 6254.46837018854, 6257.998720204768, 6261.092141639459, 5640.802571909984, 5930.88138237235, 6162.815115546518, 6222.066689996492, 6224.751009959597, 6139.693015349237, 6222.502199824004, 6237.157983672191, 6238.157848690436, 6258.624482531062, 5786.739596718157, 5802.100674395476, 5803.88392232153, 5823.417658234185, 5831.317593906808, 27700.722992770217, 29431.411371772658, 30046.54930176049, 30192.698073019426, 30242.0, 2089.3836318286144, 2227.7660845611304, 2245.5621153875, 2254.1997590855176, 2254.5490901819703, 18669.53326166843, 19151.04244787755, 19170.904145479322, 19193.61612767751, 19201.711974320395, 2270.931872043825, 2289.839711220215, 2350.7884290413945, 2363.550925324183, 2407.205622144688, 139716.30141849225, 141919.0, 142542.2872885629, 142690.0, 142730.0, 14376.712465750627, 15248.0, 15349.0, 15361.846381536265, 15657.60855978587, 23247.3025809226, 23314.184003559792, 23355.299341019796, 23394.0, 23472.0, 9307.674231401868, 9349.317122917804, 9387.765305867408, 9512.90487095134, 9613.423194608346, 8362.700257429135, 8428.747137585882, 8467.237948584658, 8528.360372971927, 8560.14398560139, 9271.67549135777, 9293.349465537347, 9390.436573805457, 9414.905850941403, 9419.811603768023, 2632.144553020276, 2727.595288426462, 2778.277647811543, 2818.0841226601437, 2878.870450829718, 1049.5014867937668, 1058.8252938265255, 1073.1682945717132, 1085.2674444749762, 1102.415719668577, 20305.796942030687, 23268.418289542897, 26000.0, 26366.0, 26401.867990659925, 1121.9775604487866, 1129.2998341028615, 1141.3192454334703, 1151.6314779270554, 1157.548556063136, 11898.583549575724, 11935.164538482397, 11958.521659133537, 12017.399130043463, 12033.939830300793, 561329.0, 613362.0, 623032.0, 632314.0, 634170.0, 111443.0, 113505.43247283711, 116840.41579792216, 116857.0, 118709.0, 1229.3668760588305, 1270.5235536673747, 1275.993620031894, 1279.1685404486973, 1305.484333688188, 17635.382761603283, 18991.43025709231, 19070.33253836109, 19127.713084304025, 19545.902270488557, 51880.0, 52816.0, 53638.73180634072, 55683.72158139183, 57373.71313143407, 70664.29335706578, 71288.64355678188, 71408.0, 72015.27984720086, 72968.63515682388, 12000.75998480043, 13047.0, 13152.80270795958, 13167.802482962954, 13206.867931320563, 18793.812061879205, 18837.623247535248, 18840.52898677544, 18929.0, 19064.809351906304, 15646.843531564538, 15890.841091588936, 15968.600784980004, 15974.68050639004, 16164.353425862833, 12734.172278801849, 14104.858951410764, 14188.290585470892, 14528.564143075724, 14906.25468726581, 16258.0, 16387.0, 16429.34282628729, 16543.338266469207, 16722.414715484898, 12782.936085319885, 12878.678033048875, 12963.481460741841, 12978.610641680765, 12999.675008124872, 15767.605809854846, 15784.60538486547, 15987.280572374038, 16087.919560402122, 16108.436204732778], "value": 11785.080499348143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.5822311529657, 1470.4853301344524, 1471.5438214153612, 1494.6487575419774, 1520.2854658310594, 14765.261736913151, 15334.079955202682, 15347.3093710783, 15372.538823835303, 15379.231038448075, 14957.177355245458, 15466.61333466664, 15970.121643309642, 16065.598360041005, 16093.758593621105, 2675.4381579868204, 2707.4043710383685, 2718.2796558911905, 2719.9048033318836, 2720.1295585412677, 2632.3155979445387, 2676.384431580738, 2677.799165062628, 2682.6646669166353, 2687.9731202688017, 2546.923592292225, 2604.4530648563823, 2664.6669166354204, 2680.852553109588, 2682.088090049383, 2734.945301093977, 2760.4617099665475, 2760.792940529448, 2767.9308017299527, 2768.3632764464087, 2649.9867500662567, 2675.5184066867955, 2676.839389636628, 2678.25008997481, 2683.6779586449557, 15027.774583381259, 15116.470923517623, 15174.0, 15174.241287935669, 15176.317065732068, 7753.806154846174, 8010.399220058519, 8084.959575202145, 8089.271965523072, 8105.351571874236, 4466.932996005063, 4629.051044535862, 4759.190937540627, 4827.806887724487, 4832.4684284728655, 1559.1736379718654, 1600.3998500562288, 1627.0644379481728, 1636.7544868269736, 1650.7936507936508, 25669.358266043313, 25967.701614919366, 25970.350741231432, 26034.34914127162, 26146.0, 6379.266384365765, 6471.417572418505, 6483.124778154983, 6630.270670226271, 6722.563033402813, 17371.218295176746, 17387.130643467775, 17410.825891740922, 17423.47729568115, 17426.47720568385, 7706.537607743553, 7848.9215107848195, 7852.057753069668, 7854.136045035156, 7863.724769633035, 7106.822329441805, 7225.963870180615, 7238.276172382825, 7294.817629559304, 7344.522606030591, 5158.277841102249, 5296.655717378358, 5310.654807437504, 5313.229581710631, 5343.0, 1531.6170957260686, 1541.406558474995, 1541.961450963735, 1542.3907556515114, 1548.5741421109285, 898.9640414383482, 908.8818453601122, 918.2424499787702, 922.7739203895088, 944.3012170993416, 7456.384535417147, 7509.13644930829, 7517.210692877278, 7569.621518924032, 7649.04386951631, 732.3482100930177, 1008.4201584089031, 1037.5953378182514, 1042.8957104289511, 1066.632011955874, 5602.299712535933, 5604.0767706125, 5640.520555752725, 5881.705914704247, 5931.881362372728, 21007.8949605251, 21939.0, 21944.45138871541, 22059.89700514968, 22073.668894966588, 20465.18139274412, 21345.35963921085, 21577.13691452356, 21685.0, 21724.348269551938, 11299.0, 11431.714207144887, 11964.88035119655, 12114.878851211552, 12120.878791212152, 8295.04606970206, 8464.746057618282, 8838.646454141763, 8918.10818918103, 9188.40275382098, 17993.640127197643, 18458.353957611955, 18799.90600046991, 19036.904815475835, 19180.616387672446, 18502.44492665222, 19038.238470461027, 19473.61052778965, 19487.415377538695, 19708.901455492633, 12198.451069702061, 12669.0, 12710.046746493865, 12716.173448725804, 12737.80893286583, 13680.452781888613, 13919.53844846317, 13966.79049814274, 14041.227732474403, 14140.080894741808, 11750.353730544903, 11816.350100744541, 11875.940620296844, 12062.45718942632, 12208.81686774717, 11557.595484158013, 11736.647900562997, 12091.334976576372, 12174.45214965311, 12269.93865030669, 10072.942341054084, 10124.493775311352, 10183.541740621542, 10210.897891020995, 10239.385636861813, 7078.327558881898, 7155.212926577969, 7197.640117993975, 7388.076490438695, 7496.7750967471065, 7513.737019204302, 7593.05086864142, 7653.311201991847, 7812.92187078122, 7890.408219383684], "value": 6716.776224397186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.35226030030793, 497.8694117819333, 514.7992283009629, 518.6887867279632, 528.3052785586952, 6232.376762323765, 6299.905501417476, 6325.620462772237, 6326.746930122796, 6340.0, 6044.395560443953, 6119.847003824907, 6173.475254603364, 6189.442950134487, 6190.0405437157315, 4862.465128835843, 4875.878103047435, 4884.3406140171155, 4898.755062246892, 4946.604271658277, 4867.196912509449, 4868.367112275399, 4888.413390393158, 4896.681715688486, 4948.208286674133, 4863.635227357945, 4899.730514821684, 4901.485344038878, 4904.386951631046, 4915.459299477055, 4673.579377855992, 4838.516148385133, 4847.0, 4855.8057677693205, 4873.658843880912, 4328.523862375137, 4330.978345108286, 4332.67504937131, 4337.262665346899, 4367.890802729958, 6093.756249750005, 6096.817095487142, 6114.480269177126, 6125.5712100153005, 6130.203073600448, 5769.1923130761725, 5830.4169583041785, 5837.737301821428, 5846.853828654275, 5861.9706901465215, 6607.339266073354, 6695.531312808105, 6712.5301228913995, 6715.294894036105, 6743.224529179158, 4921.261810728383, 4939.925901111486, 4941.827036053757, 4952.455229924742, 4962.702237865704, 6867.278935711778, 6908.3437073477935, 6948.826279343007, 6987.231404545496, 7046.541974771675, 5109.591232701375, 5114.846554603368, 5117.9764047189965, 5131.717755523482, 5132.486751324837, 5216.556592689588, 5220.451852555503, 5233.345831771028, 5234.869128271824, 5240.633155679142, 5856.619319744288, 5865.208196893364, 5868.562202260388, 5873.735681894325, 5875.030619947746, 6737.730490780314, 6743.123393958754, 6750.45996320303, 6754.6284954327, 6757.662116894136, 1728.7493313469477, 1795.3267524678245, 1798.5413719501444, 1800.9369672061414, 1808.1772793378982, 1229.0843321725372, 1231.9260844349367, 1237.9319137447526, 1264.740728150727, 1272.2748033620933, 6087.665178415141, 6156.199694039746, 6193.6903154842075, 6207.6585787782105, 6208.565400421927, 6775.322467753185, 6780.0, 6814.48891333152, 6818.147731533559, 6854.675482391036, 6194.132821405007, 6225.408586184305, 6225.782097626561, 6238.532110091761, 6261.906071408933, 3571.1786289153642, 3582.6775590197008, 3604.747667663291, 3607.4228123500116, 3622.4023036198732, 7063.858722825515, 7065.293470652997, 7096.432285417154, 7119.181294151239, 7126.928730712627, 6977.51157418986, 7016.859662806817, 7018.684159212848, 7020.104571765594, 7074.443622403063, 7059.5764254144915, 7078.504504684725, 7107.431405487549, 7119.67961441726, 7137.964310178416, 6685.298043705536, 6813.591184528944, 6849.280825513449, 6866.141732283465, 6878.896816547855, 6734.0, 6743.291954344723, 6744.763933262312, 6753.58174783301, 6766.627835469097, 6691.8327041822395, 6942.826429339307, 7035.788926332219, 7085.362317391459, 7116.857662846817, 5111.386633603991, 5119.872003199801, 5122.743862806919, 5136.794528218829, 5152.922706159486, 6850.520463567702, 6881.036654868222, 6883.449324054164, 6907.654617269217, 6919.169699636076, 6671.33286671329, 6674.232463266592, 6681.5656982296, 6702.765403210864, 6703.262641109376, 6675.23234828001, 6687.331266873273, 6703.93296067033, 6709.10235528077, 6714.6978385973725, 6603.7688680895935, 6626.668666566556, 6632.834179145367, 6681.418802479651, 6685.532012759255, 6694.933050669431, 6701.631410272482, 6721.596704197764, 6733.956236783307, 6768.593884366954, 6470.352964703492, 6490.448311893542, 6522.21733391996, 6523.086767852409, 6536.215654121535], "value": 5163.490582498325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [857.9528125953078, 881.1849039638333, 886.0, 894.5035505294563, 909.8407778638741, 17137.742933856003, 17551.64896702065, 17679.0, 17699.0, 17706.468805935827, 14946.327415266313, 15306.0, 15805.0, 15831.05013699179, 19057.0, 1057.259918057361, 1086.7663452357742, 1090.4983707494523, 1091.787101515201, 1092.7869065532225, 1074.8763892152385, 1075.9031687148156, 1076.3757020927842, 1079.6221322537087, 1085.7448499602588, 1122.0, 1127.7969965406223, 1128.5090985421368, 1137.1244142010646, 1137.4483375562845, 1020.3877673395978, 1099.115212254135, 1115.5259014918709, 1128.097521982415, 1130.5082289204222, 794.2375319693044, 808.9919100808976, 812.3988248695922, 814.0028465130227, 817.9468334558294, 18321.17554710041, 18827.24691012358, 18994.335198268134, 18997.240110395705, 19013.904930475397, 19587.902060489607, 19622.607547849108, 20306.08622611986, 20373.49066273355, 20479.69280460794, 15822.287997040046, 15841.287142078634, 15923.363065477368, 15964.361425542964, 15984.920075399548, 3529.594096678889, 3543.3090547343277, 3546.733994950389, 3632.8183590820354, 3671.1739858531882, 112348.43825780819, 113416.86583134145, 113634.0, 114861.425692871, 119693.40153299265, 15640.2961866714, 15878.52364429069, 15994.520164395086, 16007.43973960929, 16040.75938860918, 27593.862030689717, 29462.263443414085, 29598.408031839244, 29610.111696648702, 29736.702632973393, 8864.8670269946, 8872.334574906909, 8925.73222803317, 8980.146886045815, 8981.461112333282, 4203.096334288142, 4228.746275223496, 4316.568343165721, 4317.892052698708, 4346.130773845243, 5072.6195535335, 5107.259447380184, 5119.488051194925, 5143.97428012865, 5167.173252279692, 1038.325088692356, 1064.87655523422, 1083.3662307550014, 1089.215764649451, 1094.5676457799125, 715.1275443958363, 716.8673795347877, 721.9241979592172, 738.2580506590949, 746.0934964018635, 12721.809172862415, 13219.471221151238, 13404.798928016087, 13452.45296790862, 14153.0, 714.878470659989, 723.6815801047522, 734.904462419882, 740.2365776229977, 750.6622020090981, 5725.427457254241, 6007.879842403127, 6468.838279043061, 6577.309382514863, 6621.569597976116, 107907.46046269718, 108433.0, 113595.43202283936, 113845.0, 117682.0, 89589.55205223932, 89940.0, 91262.54368728246, 91360.0, 92208.53895730479, 83049.0, 93371.53314233385, 93453.0, 94484.11031779325, 97005.5149724261, 12730.68173295638, 14119.929400353343, 14460.783088253895, 14481.782773258199, 14518.274086295854, 42732.0, 43849.34225986549, 44741.0, 45035.774821125684, 46965.76517117529, 73139.63430182815, 76747.61626191833, 77967.61016194883, 78167.218327816, 79889.60055199919, 19096.045197740335, 19862.205511779368, 20009.199632015137, 20051.097700603215, 20238.898805506466, 19381.90309048446, 20121.798782012578, 21229.15083396647, 21910.0, 22450.32649020532, 19087.42737717871, 19725.112369943676, 19779.30772423016, 19845.0, 19869.205231791144, 18269.0, 18379.172937218125, 18671.81328186701, 19208.80791192126, 20187.495312617302, 18703.438896833115, 19125.90437047806, 19304.903475482533, 19408.223671053, 19624.313149039714, 13443.663908402368, 13526.458941642224, 13646.385912633757, 13810.93094534521, 13963.232022238468, 14788.704225915637, 16002.599935001717, 16155.273012714692, 16337.101459419846, 16494.25775840114], "value": 9370.531003922939, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 106.0, 106.0, 105.0, 108.0, 106.0, 105.0, 106.0, 106.0, 110.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 115.0, 141.0, 161.0, 115.0, 143.0, 149.0, 117.0, 165.0, 128.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 164.0, 164.0, 163.0, 160.0, 165.0, 164.0, 173.0, 173.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 73.0, 190.0, 75.0, 73.0, 75.0, 73.0, 158.0, 73.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 136.0, 81.0, 81.0, 81.0, 130.0, 81.0, 81.0, 128.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 150.0, 149.0, 149.0, 149.0, 150.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 49.0, 46.0, 47.0, 47.0, 53.0, 49.0, 50.0, 47.0, 48.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 74.0, 85.0, 76.0, 83.0, 74.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 126.0, 127.0, 123.0, 128.0, 118.0, 126.0, 119.0, 121.0, 156.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 177.0, 171.0, 173.0, 169.0, 177.0, 187.0, 171.0, 177.0, 170.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 62.0, 62.0, 62.0, 60.0, 60.0, 62.0], "value": 61.0, "unit": "score"}]}]} 05:47:00 INFO - Return code: 0 05:47:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:00 INFO - # TBPL SUCCESS # 05:47:00 INFO - Running post-action listener: _resource_record_post_action 05:47:00 INFO - [mozharness: 2017-06-23 12:47:00.834073Z] Finished run-tests step (success) 05:47:00 INFO - Running post-run listener: _resource_record_post_run 05:47:00 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8724480; Write bytes: 436670464; Read time: 2936; Write time: 366528 05:47:00 INFO - TinderboxPrint: CPU usage
13.1% 05:47:00 INFO - TinderboxPrint: I/O read bytes / time
8,724,480 / 2,936 05:47:00 INFO - TinderboxPrint: I/O write bytes / time
436,670,464 / 366,528 05:47:00 INFO - TinderboxPrint: CPU idle
8,283.9 (86.9%) 05:47:00 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 05:47:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:47:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118345728; Read time: 0; Write time: 135812 05:47:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:47:00 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 6356992; Write bytes: 318324736; Read time: 2324; Write time: 230716 05:47:01 INFO - Running post-run listener: _upload_blobber_files 05:47:01 INFO - Blob upload gear active. 05:47:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:01 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 05:47:01 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'] 05:47:01 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 05:47:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:47:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:47:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:02 INFO - (blobuploader) - INFO - Done attempting. 05:47:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:47:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:47:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:03 INFO - (blobuploader) - INFO - Done attempting. 05:47:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:07 INFO - (blobuploader) - INFO - Done attempting. 05:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:08 INFO - (blobuploader) - INFO - Done attempting. 05:47:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:08 INFO - Return code: 0 05:47:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3cf3322d3ad143d2555e3a21f0df7844090dfbed4d7f667c5f85c865a2604cbfcf57b803611a797cafc87bb6f039a3fc0e1249db6c712f933f305b140665d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d357f64e161fce1ecb18d99e38faeab4743f30c0d056d552d969cd3e80b9f343945f4dcd0787711bd3ca2f7f9e47358db7f07bc3d1f8af60b481a55513257eb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/645d14f4f7181823c9785bafb772aa62e97338bca7ecd71930222c7bc9b0776a9c60482e04e869ef9ad6c6a74d980524d07208ff82dc845d7ab927454e81af4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a51a9300a1ab51bb8debc15d90b9cf145242582e6f2ab94844305b9e80b8bb32dafd649e77d889ae94f760ac41f962790f96726325e06fa2618112e1b6e85653"} 05:47:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:08 INFO - Contents: 05:47:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3cf3322d3ad143d2555e3a21f0df7844090dfbed4d7f667c5f85c865a2604cbfcf57b803611a797cafc87bb6f039a3fc0e1249db6c712f933f305b140665d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d357f64e161fce1ecb18d99e38faeab4743f30c0d056d552d969cd3e80b9f343945f4dcd0787711bd3ca2f7f9e47358db7f07bc3d1f8af60b481a55513257eb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/645d14f4f7181823c9785bafb772aa62e97338bca7ecd71930222c7bc9b0776a9c60482e04e869ef9ad6c6a74d980524d07208ff82dc845d7ab927454e81af4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a51a9300a1ab51bb8debc15d90b9cf145242582e6f2ab94844305b9e80b8bb32dafd649e77d889ae94f760ac41f962790f96726325e06fa2618112e1b6e85653"} 05:47:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:08 INFO - Copying logs to upload dir... 05:47:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.311088 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-06-23 05:47:08.059545) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 05:47:08.062960) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3cf3322d3ad143d2555e3a21f0df7844090dfbed4d7f667c5f85c865a2604cbfcf57b803611a797cafc87bb6f039a3fc0e1249db6c712f933f305b140665d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d357f64e161fce1ecb18d99e38faeab4743f30c0d056d552d969cd3e80b9f343945f4dcd0787711bd3ca2f7f9e47358db7f07bc3d1f8af60b481a55513257eb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/645d14f4f7181823c9785bafb772aa62e97338bca7ecd71930222c7bc9b0776a9c60482e04e869ef9ad6c6a74d980524d07208ff82dc845d7ab927454e81af4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a51a9300a1ab51bb8debc15d90b9cf145242582e6f2ab94844305b9e80b8bb32dafd649e77d889ae94f760ac41f962790f96726325e06fa2618112e1b6e85653"} build_url:https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011049 build_url: 'https://queue.taskcluster.net/v1/task/EgUYqmuyTeepIWNMHZdxUQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3cf3322d3ad143d2555e3a21f0df7844090dfbed4d7f667c5f85c865a2604cbfcf57b803611a797cafc87bb6f039a3fc0e1249db6c712f933f305b140665d5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9d357f64e161fce1ecb18d99e38faeab4743f30c0d056d552d969cd3e80b9f343945f4dcd0787711bd3ca2f7f9e47358db7f07bc3d1f8af60b481a55513257eb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/645d14f4f7181823c9785bafb772aa62e97338bca7ecd71930222c7bc9b0776a9c60482e04e869ef9ad6c6a74d980524d07208ff82dc845d7ab927454e81af4b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a51a9300a1ab51bb8debc15d90b9cf145242582e6f2ab94844305b9e80b8bb32dafd649e77d889ae94f760ac41f962790f96726325e06fa2618112e1b6e85653"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 05:47:08.087410) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:47:08.087753) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1498220768.585006-82492785 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 05:47:08.173673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 05:47:08.174132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 05:47:08.174424) ========= ========= Total master_lag: 0.18 =========