builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1498407787.06 results: success (0) revision: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.057990) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.058384) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.058663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.076777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.077033) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-25 09:23:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.7M=0s 2017-06-25 09:23:07 (36.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135424 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.227833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.228107) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018508 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.283416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:07.283719) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d50abca6521baeae8ac6b07ddf843d63a1aa5f84 --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 d50abca6521baeae8ac6b07ddf843d63a1aa5f84 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-25 09:23:07,750 truncating revision to first 12 chars 2017-06-25 09:23:07,750 Setting DEBUG logging. 2017-06-25 09:23:07,750 attempt 1/10 2017-06-25 09:23:07,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d50abca6521b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-25 09:23:08,243 unpacking tar archive at: mozilla-central-d50abca6521b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:08.094160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:08.094434) ========= script_repo_revision: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:08.098832) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:08.099093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-25 09:23:08.108236) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-06-25 09:23:08.108507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:08 INFO - MultiFileLogger online at 20170625 09:23:08 in /builds/slave/test 09:23:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:23:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:08 INFO - {'append_to_log': False, 09:23:08 INFO - 'base_work_dir': '/builds/slave/test', 09:23:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:23:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:08 INFO - 'branch': 'Firefox-Non-PGO', 09:23:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:08 INFO - 'config_files': ('talos/linux_config.py',), 09:23:08 INFO - 'default_actions': ('clobber', 09:23:08 INFO - 'read-buildbot-config', 09:23:08 INFO - 'download-and-extract', 09:23:08 INFO - 'populate-webroot', 09:23:08 INFO - 'create-virtualenv', 09:23:08 INFO - 'install', 09:23:08 INFO - 'setup-mitmproxy', 09:23:08 INFO - 'run-tests'), 09:23:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:08 INFO - 'download_minidump_stackwalk': True, 09:23:08 INFO - 'download_symbols': 'ondemand', 09:23:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:08 INFO - 'gecko_profile': False, 09:23:08 INFO - 'gecko_profile_interval': 0, 09:23:08 INFO - 'installer_path': 'installer.exe', 09:23:08 INFO - 'log_level': 'info', 09:23:08 INFO - 'log_name': 'talos', 09:23:08 INFO - 'log_to_console': True, 09:23:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:08 INFO - 'opt_config_files': (), 09:23:08 INFO - 'pip_index': False, 09:23:08 INFO - 'suite': 'dromaeojs-e10s', 09:23:08 INFO - 'system_bits': '32', 09:23:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:08 INFO - 'title': 'talos-linux64-ix-045', 09:23:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:08 INFO - 'use_talos_json': True, 09:23:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:08 INFO - 'work_dir': 'build'} 09:23:08 INFO - [mozharness: 2017-06-25 16:23:08.678377Z] Running clobber step. 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: clobber 09:23:08 INFO - rmtree: /builds/slave/test/build 09:23:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:09 INFO - Running post-action listener: _resource_record_post_action 09:23:09 INFO - [mozharness: 2017-06-25 16:23:09.701414Z] Finished clobber step (success) 09:23:09 INFO - [mozharness: 2017-06-25 16:23:09.701513Z] Running read-buildbot-config step. 09:23:09 INFO - Running pre-action listener: _resource_record_pre_action 09:23:09 INFO - Running main action method: read_buildbot_config 09:23:09 INFO - Using buildbot properties: 09:23:09 INFO - { 09:23:09 INFO - "project": "", 09:23:09 INFO - "product": "firefox", 09:23:09 INFO - "who": "ffxbld@noreply.mozilla.org", 09:23:09 INFO - "installer_path": "public/build/target.tar.bz2", 09:23:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:23:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:23:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:23:09 INFO - "stage_platform": "linux64", 09:23:09 INFO - "basedir": "/builds/slave/test", 09:23:09 INFO - "buildnumber": 936, 09:23:09 INFO - "platform": "ubuntu64_hw", 09:23:09 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:23:09 INFO - "slavebuilddir": "test", 09:23:09 INFO - "taskId": "OElVh6kPRvyENXYhjqcAQQ", 09:23:09 INFO - "branch": "mozilla-central", 09:23:09 INFO - "script_repo_revision": "production", 09:23:09 INFO - "revision": "d50abca6521baeae8ac6b07ddf843d63a1aa5f84", 09:23:09 INFO - "slavename": "talos-linux64-ix-045", 09:23:09 INFO - "repo_path": "mozilla-central" 09:23:09 INFO - } 09:23:09 INFO - Finding installer, test and symbols from parent task. 09:23:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OElVh6kPRvyENXYhjqcAQQ'}, attempt #1 09:23:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OElVh6kPRvyENXYhjqcAQQ'}, attempt #1 09:23:10 INFO - Task dependencies: FXzgljF5Q7yAXAIKBzOadA 09:23:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA'}, attempt #1 09:23:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 09:23:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/test_packages.json 09:23:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.crashreporter-symbols.zip 09:23:11 INFO - Running post-action listener: _resource_record_post_action 09:23:11 INFO - [mozharness: 2017-06-25 16:23:11.076279Z] Finished read-buildbot-config step (success) 09:23:11 INFO - [mozharness: 2017-06-25 16:23:11.076498Z] Running download-and-extract step. 09:23:11 INFO - Running pre-action listener: _resource_record_pre_action 09:23:11 INFO - Running main action method: download_and_extract 09:23:11 INFO - mkdir: /builds/slave/test/build/tests 09:23:11 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')]} 09:23:11 INFO - trying https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.test_packages.json 09:23:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:23:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:23:11 INFO - Downloaded 989 bytes. 09:23:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:23:11 INFO - Using the following test package requirements: 09:23:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:23:11 INFO - u'common': [u'target.common.tests.zip'], 09:23:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:23:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:23:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:23:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:23:11 INFO - u'mozbase': [u'target.common.tests.zip'], 09:23:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:23:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:23:11 INFO - u'web-platform': [u'target.common.tests.zip', 09:23:11 INFO - u'target.web-platform.tests.tar.gz'], 09:23:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:23:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:23:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip 09:23:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:23:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip into memory 09:23:14 INFO - Content-Length response header: 67750346 09:23:14 INFO - Bytes received: 67750346 09:23:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:23:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip 09:23:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:23:25 INFO - Fetch https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.common.tests.zip into memory 09:23:27 INFO - Content-Length response header: 67750346 09:23:27 INFO - Bytes received: 67750346 09:23:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.talos.tests.zip 09:23:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:39 INFO - Fetch https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.talos.tests.zip into memory 09:23:39 INFO - Content-Length response header: 14441306 09:23:39 INFO - Bytes received: 14441306 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:40 INFO - trying https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 09:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:42 INFO - Downloaded 61856642 bytes. 09:23:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 09:23:42 INFO - mkdir: /builds/slave/test/properties 09:23:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:42 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:42 INFO - Contents: 09:23:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 09:23:42 INFO - Running post-action listener: _resource_record_post_action 09:23:42 INFO - Running post-action listener: set_extra_try_arguments 09:23:42 INFO - [mozharness: 2017-06-25 16:23:42.551060Z] Finished download-and-extract step (success) 09:23:42 INFO - [mozharness: 2017-06-25 16:23:42.551156Z] Running populate-webroot step. 09:23:42 INFO - Running pre-action listener: _resource_record_pre_action 09:23:42 INFO - Running main action method: populate_webroot 09:23:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:42 INFO - '--tppagecycles', 09:23:42 INFO - '7'], 09:23:42 INFO - 'tests': ['tsvgm']}}, 09:23:42 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['damp', 'tps']}, 09:23:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'tests': ['damp', 'tps']}, 09:23:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['dromaeo_dom']}, 09:23:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:23:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['a11yr', 09:23:42 INFO - 'ts_paint', 09:23:42 INFO - 'tpaint', 09:23:42 INFO - 'sessionrestore', 09:23:42 INFO - 'sessionrestore_no_auto_restore', 09:23:42 INFO - 'tabpaint']}, 09:23:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:42 INFO - 'bloom_basic_ref']}, 09:23:42 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:23:42 INFO - 'talos_options': ['--mitmproxy', 09:23:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:23:42 INFO - '--firstNonBlankPaint'], 09:23:42 INFO - 'tests': ['quantum_pageload_google', 09:23:42 INFO - 'quantum_pageload_youtube', 09:23:42 INFO - 'quantum_pageload_amazon', 09:23:42 INFO - 'quantum_pageload_facebook']}, 09:23:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['tsvgx', 09:23:42 INFO - 'tsvgr_opacity', 09:23:42 INFO - 'tart', 09:23:42 INFO - 'tscrollx', 09:23:42 INFO - 'cart', 09:23:42 INFO - 'tsvg_static']}, 09:23:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:42 INFO - 'tsvgr_opacity', 09:23:42 INFO - 'tart', 09:23:42 INFO - 'tscrollx', 09:23:42 INFO - 'cart', 09:23:42 INFO - 'tsvg_static']}, 09:23:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'talos_options': ['--disable-e10s'], 09:23:42 INFO - 'tests': ['tp5o']}, 09:23:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'talos_options': ['--disable-e10s', 09:23:42 INFO - '--xperf_path', 09:23:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:42 INFO - 'tests': ['tp5n']}, 09:23:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:42 INFO - 'talos_options': ['--xperf_path', 09:23:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:42 INFO - 'tests': ['tp5n']}}, 09:23:42 INFO - 'talos.zip': {'path': '', 09:23:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:42 INFO - Running post-action listener: _resource_record_post_action 09:23:42 INFO - [mozharness: 2017-06-25 16:23:42.566016Z] Finished populate-webroot step (success) 09:23:42 INFO - [mozharness: 2017-06-25 16:23:42.566106Z] Running create-virtualenv step. 09:23:42 INFO - Running pre-action listener: _resource_record_pre_action 09:23:42 INFO - Running main action method: create_virtualenv 09:23:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:42 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 09:23:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:23:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:42 INFO - Using real prefix '/usr' 09:23:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:45 INFO - Installing pip.................done. 09:23:45 INFO - Return code: 0 09:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:45 INFO - Reading from file tmpfile_stdout 09:23:45 INFO - Output received: 09:23:45 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) 09:23:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:45 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:45 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 09:23:45 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 09:23:45 INFO - Using env: {'DISPLAY': ':0', 09:23:45 INFO - 'HOME': '/home/cltbld', 09:23:45 INFO - 'LANG': 'en_US.UTF-8', 09:23:45 INFO - 'LANGUAGE': 'en_US:en', 09:23:45 INFO - 'LOGNAME': 'cltbld', 09:23:45 INFO - 'MAIL': '/var/mail/cltbld', 09:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:45 INFO - 'MOZ_NO_REMOTE': '1', 09:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:45 INFO - 'NO_EM_RESTART': '1', 09:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:45 INFO - 'PWD': '/builds/slave/test', 09:23:45 INFO - 'SHELL': '/bin/bash', 09:23:45 INFO - 'SHLVL': '1', 09:23:45 INFO - 'TERM': 'linux', 09:23:45 INFO - 'TMOUT': '86400', 09:23:45 INFO - 'USER': 'cltbld', 09:23:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:45 INFO - '_': '/tools/buildbot/bin/python'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 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 09:23:45 INFO - Cleaning up... 09:23:45 INFO - Return code: 0 09:23:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:45 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:45 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 09:23:45 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 09:23:45 INFO - Using env: {'DISPLAY': ':0', 09:23:45 INFO - 'HOME': '/home/cltbld', 09:23:45 INFO - 'LANG': 'en_US.UTF-8', 09:23:45 INFO - 'LANGUAGE': 'en_US:en', 09:23:45 INFO - 'LOGNAME': 'cltbld', 09:23:45 INFO - 'MAIL': '/var/mail/cltbld', 09:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:45 INFO - 'MOZ_NO_REMOTE': '1', 09:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:45 INFO - 'NO_EM_RESTART': '1', 09:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:45 INFO - 'PWD': '/builds/slave/test', 09:23:45 INFO - 'SHELL': '/bin/bash', 09:23:45 INFO - 'SHLVL': '1', 09:23:45 INFO - 'TERM': 'linux', 09:23:45 INFO - 'TMOUT': '86400', 09:23:45 INFO - 'USER': 'cltbld', 09:23:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:45 INFO - '_': '/tools/buildbot/bin/python'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 INFO - Downloading/unpacking psutil>=3.1.1 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:47 INFO - Installing collected packages: psutil 09:23:47 INFO - Running setup.py install for psutil 09:23:47 INFO - building 'psutil._psutil_linux' extension 09:23:47 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 09:23:47 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 09:23:47 INFO - building 'psutil._psutil_posix' extension 09:23:47 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 09:23:47 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 09:23:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:47 INFO - Successfully installed psutil 09:23:47 INFO - Cleaning up... 09:23:47 INFO - Return code: 0 09:23:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:47 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')]} 09:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:47 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')]} 09:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:47 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:47 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 09:23:47 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 09:23:47 INFO - Using env: {'DISPLAY': ':0', 09:23:47 INFO - 'HOME': '/home/cltbld', 09:23:47 INFO - 'LANG': 'en_US.UTF-8', 09:23:47 INFO - 'LANGUAGE': 'en_US:en', 09:23:47 INFO - 'LOGNAME': 'cltbld', 09:23:47 INFO - 'MAIL': '/var/mail/cltbld', 09:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:47 INFO - 'MOZ_NO_REMOTE': '1', 09:23:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:47 INFO - 'NO_EM_RESTART': '1', 09:23:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:47 INFO - 'PWD': '/builds/slave/test', 09:23:47 INFO - 'SHELL': '/bin/bash', 09:23:47 INFO - 'SHLVL': '1', 09:23:47 INFO - 'TERM': 'linux', 09:23:47 INFO - 'TMOUT': '86400', 09:23:47 INFO - 'USER': 'cltbld', 09:23:47 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:47 INFO - '_': '/tools/buildbot/bin/python'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:48 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 09:23:48 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 09:23:48 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 09:23:48 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 09:23:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:49 INFO - Installing collected packages: mozsystemmonitor 09:23:49 INFO - Running setup.py install for mozsystemmonitor 09:23:49 INFO - Successfully installed mozsystemmonitor 09:23:49 INFO - Cleaning up... 09:23:49 INFO - Return code: 0 09:23:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:49 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')]} 09:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:49 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')]} 09:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:49 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:49 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 09:23:49 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 09:23:49 INFO - Using env: {'DISPLAY': ':0', 09:23:49 INFO - 'HOME': '/home/cltbld', 09:23:49 INFO - 'LANG': 'en_US.UTF-8', 09:23:49 INFO - 'LANGUAGE': 'en_US:en', 09:23:49 INFO - 'LOGNAME': 'cltbld', 09:23:49 INFO - 'MAIL': '/var/mail/cltbld', 09:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:49 INFO - 'MOZ_NO_REMOTE': '1', 09:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:49 INFO - 'NO_EM_RESTART': '1', 09:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:49 INFO - 'PWD': '/builds/slave/test', 09:23:49 INFO - 'SHELL': '/bin/bash', 09:23:49 INFO - 'SHLVL': '1', 09:23:49 INFO - 'TERM': 'linux', 09:23:49 INFO - 'TMOUT': '86400', 09:23:49 INFO - 'USER': 'cltbld', 09:23:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:49 INFO - '_': '/tools/buildbot/bin/python'} 09:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:49 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:49 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 09:23:49 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 09:23:49 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 09:23:49 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 09:23:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23: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 09:23: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 09:23: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 09:23: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 09:23:50 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:50 INFO - warning: no files found matching '*.txt' 09:23:50 INFO - no previously-included directories found matching 'build' 09:23:50 INFO - no previously-included directories found matching 'dist' 09:23:50 INFO - no previously-included directories found matching '.git*' 09:23:50 INFO - Installing collected packages: jsonschema, functools32 09:23:50 INFO - Running setup.py install for functools32 09:23:50 INFO - warning: no files found matching '*.txt' 09:23:50 INFO - no previously-included directories found matching 'build' 09:23:50 INFO - no previously-included directories found matching 'dist' 09:23:50 INFO - no previously-included directories found matching '.git*' 09:23:50 INFO - Successfully installed jsonschema functools32 09:23:50 INFO - Cleaning up... 09:23:50 INFO - Return code: 0 09:23:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23: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', '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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23: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 functools32==3.2.3-2 09:23:50 INFO - Using env: {'DISPLAY': ':0', 09:23:50 INFO - 'HOME': '/home/cltbld', 09:23:50 INFO - 'LANG': 'en_US.UTF-8', 09:23:50 INFO - 'LANGUAGE': 'en_US:en', 09:23:50 INFO - 'LOGNAME': 'cltbld', 09:23:50 INFO - 'MAIL': '/var/mail/cltbld', 09:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:50 INFO - 'MOZ_NO_REMOTE': '1', 09:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:50 INFO - 'NO_EM_RESTART': '1', 09:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:50 INFO - 'PWD': '/builds/slave/test', 09:23:50 INFO - 'SHELL': '/bin/bash', 09:23:50 INFO - 'SHLVL': '1', 09:23:50 INFO - 'TERM': 'linux', 09:23:50 INFO - 'TMOUT': '86400', 09:23:50 INFO - 'USER': 'cltbld', 09:23:50 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:50 INFO - '_': '/tools/buildbot/bin/python'} 09:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:51 INFO - Cleaning up... 09:23:51 INFO - Return code: 0 09:23:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23: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', '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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23: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 blobuploader==1.2.4 09:23:51 INFO - Using env: {'DISPLAY': ':0', 09:23:51 INFO - 'HOME': '/home/cltbld', 09:23:51 INFO - 'LANG': 'en_US.UTF-8', 09:23:51 INFO - 'LANGUAGE': 'en_US:en', 09:23:51 INFO - 'LOGNAME': 'cltbld', 09:23:51 INFO - 'MAIL': '/var/mail/cltbld', 09:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:51 INFO - 'MOZ_NO_REMOTE': '1', 09:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:51 INFO - 'NO_EM_RESTART': '1', 09:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:51 INFO - 'PWD': '/builds/slave/test', 09:23:51 INFO - 'SHELL': '/bin/bash', 09:23:51 INFO - 'SHLVL': '1', 09:23:51 INFO - 'TERM': 'linux', 09:23:51 INFO - 'TMOUT': '86400', 09:23:51 INFO - 'USER': 'cltbld', 09:23:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:51 INFO - '_': '/tools/buildbot/bin/python'} 09:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:23: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 09:23: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 09:23: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 09:23: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 09:23:52 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23: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 09:23: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 09:23: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 09:23: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 09:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23: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 09:23: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 09:23: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 09:23: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 09:23:53 INFO - Downloading docopt-0.6.1.tar.gz 09:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:53 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:53 INFO - Running setup.py install for blobuploader 09:23:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:53 INFO - Running setup.py install for requests 09:23:53 INFO - Running setup.py install for docopt 09:23:53 INFO - Successfully installed blobuploader requests docopt 09:23:53 INFO - Cleaning up... 09:23:53 INFO - Return code: 0 09:23:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:53 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:53 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 09:23:53 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 09:23:53 INFO - Using env: {'DISPLAY': ':0', 09:23:53 INFO - 'HOME': '/home/cltbld', 09:23:53 INFO - 'LANG': 'en_US.UTF-8', 09:23:53 INFO - 'LANGUAGE': 'en_US:en', 09:23:53 INFO - 'LOGNAME': 'cltbld', 09:23:53 INFO - 'MAIL': '/var/mail/cltbld', 09:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:53 INFO - 'MOZ_NO_REMOTE': '1', 09:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:53 INFO - 'NO_EM_RESTART': '1', 09:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:53 INFO - 'PWD': '/builds/slave/test', 09:23:53 INFO - 'SHELL': '/bin/bash', 09:23:53 INFO - 'SHLVL': '1', 09:23:53 INFO - 'TERM': 'linux', 09:23:53 INFO - 'TMOUT': '86400', 09:23:53 INFO - 'USER': 'cltbld', 09:23:53 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:53 INFO - '_': '/tools/buildbot/bin/python'} 09:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:53 INFO - Running setup.py (path:/tmp/pip-4jtQNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:54 INFO - Running setup.py (path:/tmp/pip-Q1zBQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:54 INFO - Running setup.py (path:/tmp/pip-HRp8c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:54 INFO - Running setup.py (path:/tmp/pip-yb6dzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:54 INFO - Running setup.py (path:/tmp/pip-lYSRbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:54 INFO - Running setup.py (path:/tmp/pip-beo7bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:54 INFO - Running setup.py (path:/tmp/pip-eyvxuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:54 INFO - Running setup.py (path:/tmp/pip-So7oIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:54 INFO - Running setup.py (path:/tmp/pip-5pLnOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:54 INFO - Running setup.py (path:/tmp/pip-3ogtSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:54 INFO - Running setup.py (path:/tmp/pip-Qv_sXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:54 INFO - Running setup.py (path:/tmp/pip-J5dQpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:54 INFO - Running setup.py (path:/tmp/pip-_Y2iep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:54 INFO - Running setup.py (path:/tmp/pip-n3ta9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:54 INFO - Running setup.py (path:/tmp/pip-TuCmUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:55 INFO - Running setup.py (path:/tmp/pip-u5FSDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:55 INFO - Running setup.py (path:/tmp/pip-A692Ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:55 INFO - Running setup.py install for manifestparser 09:23:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Running setup.py install for mozcrash 09:23:55 INFO - Running setup.py install for mozdebug 09:23:55 INFO - Running setup.py install for mozdevice 09:23:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Running setup.py install for mozfile 09:23:55 INFO - Running setup.py install for mozhttpd 09:23:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Running setup.py install for mozinfo 09:23:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Running setup.py install for mozInstall 09:23:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:55 INFO - Running setup.py install for mozleak 09:23:56 INFO - Running setup.py install for mozlog 09:23:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Running setup.py install for moznetwork 09:23:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Running setup.py install for mozprocess 09:23:56 INFO - Running setup.py install for mozprofile 09:23:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Running setup.py install for mozrunner 09:23:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Running setup.py install for mozscreenshot 09:23:56 INFO - Running setup.py install for moztest 09:23:56 INFO - Running setup.py install for mozversion 09:23:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:56 INFO - Cleaning up... 09:23:56 INFO - Return code: 0 09:23:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:56 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:56 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 09:23:56 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 09:23:56 INFO - Using env: {'DISPLAY': ':0', 09:23:56 INFO - 'HOME': '/home/cltbld', 09:23:56 INFO - 'LANG': 'en_US.UTF-8', 09:23:56 INFO - 'LANGUAGE': 'en_US:en', 09:23:56 INFO - 'LOGNAME': 'cltbld', 09:23:56 INFO - 'MAIL': '/var/mail/cltbld', 09:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:56 INFO - 'MOZ_NO_REMOTE': '1', 09:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:56 INFO - 'NO_EM_RESTART': '1', 09:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:56 INFO - 'PWD': '/builds/slave/test', 09:23:56 INFO - 'SHELL': '/bin/bash', 09:23:56 INFO - 'SHLVL': '1', 09:23:56 INFO - 'TERM': 'linux', 09:23:56 INFO - 'TMOUT': '86400', 09:23:56 INFO - 'USER': 'cltbld', 09:23:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:56 INFO - '_': '/tools/buildbot/bin/python'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:57 INFO - Running setup.py (path:/tmp/pip-S95n0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:57 INFO - Running setup.py (path:/tmp/pip-K7hTKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:57 INFO - Running setup.py (path:/tmp/pip-2zhrub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:57 INFO - Running setup.py (path:/tmp/pip-zaatn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:57 INFO - Running setup.py (path:/tmp/pip-i3gvPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:57 INFO - Running setup.py (path:/tmp/pip-8iiBkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:57 INFO - Running setup.py (path:/tmp/pip-tgCnCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:57 INFO - Running setup.py (path:/tmp/pip-CzSQXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:57 INFO - Running setup.py (path:/tmp/pip-UvfH3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:57 INFO - Running setup.py (path:/tmp/pip-FaMnJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:57 INFO - Running setup.py (path:/tmp/pip-LWBOV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:57 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)) 09:23:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:57 INFO - Running setup.py (path:/tmp/pip-k7HlyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:58 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)) 09:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:58 INFO - Running setup.py (path:/tmp/pip-AI9fEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:58 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)) 09:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:58 INFO - Running setup.py (path:/tmp/pip-AR_KDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:58 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)) 09:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:58 INFO - Running setup.py (path:/tmp/pip-xOMFCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:58 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)) 09:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:58 INFO - Running setup.py (path:/tmp/pip-0B7E6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:58 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)) 09:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:58 INFO - Running setup.py (path:/tmp/pip-Ze2BCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:58 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)) 09:23:58 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)) 09:23:58 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)) 09:23:58 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)) 09:23:58 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)) 09:23:58 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)) 09:23:58 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)) 09:23:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:58 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 09:23:58 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 09:23:58 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 09:23:58 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 09:23:59 INFO - Downloading blessings-1.6.tar.gz 09:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:59 INFO - Installing collected packages: blessings 09:23:59 INFO - Running setup.py install for blessings 09:23:59 INFO - Successfully installed blessings 09:23:59 INFO - Cleaning up... 09:23:59 INFO - Return code: 0 09:23:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:59 INFO - Reading from file tmpfile_stdout 09:23:59 INFO - Current package versions: 09:23:59 INFO - argparse == 1.2.1 09:23:59 INFO - blessings == 1.6 09:23:59 INFO - blobuploader == 1.2.4 09:23:59 INFO - docopt == 0.6.1 09:23:59 INFO - functools32 == 3.2.3-2 09:23:59 INFO - jsonschema == 2.5.1 09:23:59 INFO - manifestparser == 1.1 09:23:59 INFO - mozInstall == 1.13 09:23:59 INFO - mozcrash == 1.0 09:23:59 INFO - mozdebug == 0.1 09:23:59 INFO - mozdevice == 0.51 09:23:59 INFO - mozfile == 1.2 09:23:59 INFO - mozhttpd == 0.7 09:23:59 INFO - mozinfo == 0.10 09:23:59 INFO - mozleak == 0.1 09:23:59 INFO - mozlog == 3.4 09:23:59 INFO - moznetwork == 0.27 09:23:59 INFO - mozprocess == 0.25 09:23:59 INFO - mozprofile == 0.28 09:23:59 INFO - mozrunner == 6.13 09:23:59 INFO - mozscreenshot == 0.1 09:23:59 INFO - mozsystemmonitor == 0.3 09:23:59 INFO - moztest == 0.8 09:23:59 INFO - mozversion == 1.4 09:23:59 INFO - psutil == 3.1.1 09:23:59 INFO - requests == 1.2.3 09:23:59 INFO - wsgiref == 0.1.2 09:23:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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')]} 09:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:59 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:23:59 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 09:23:59 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 09:23:59 INFO - Using env: {'DISPLAY': ':0', 09:23:59 INFO - 'HOME': '/home/cltbld', 09:23:59 INFO - 'LANG': 'en_US.UTF-8', 09:23:59 INFO - 'LANGUAGE': 'en_US:en', 09:23:59 INFO - 'LOGNAME': 'cltbld', 09:23:59 INFO - 'MAIL': '/var/mail/cltbld', 09:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:59 INFO - 'MOZ_NO_REMOTE': '1', 09:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:59 INFO - 'NO_EM_RESTART': '1', 09:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:59 INFO - 'PWD': '/builds/slave/test', 09:23:59 INFO - 'SHELL': '/bin/bash', 09:23:59 INFO - 'SHLVL': '1', 09:23:59 INFO - 'TERM': 'linux', 09:23:59 INFO - 'TMOUT': '86400', 09:23:59 INFO - 'USER': 'cltbld', 09:23:59 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:59 INFO - '_': '/tools/buildbot/bin/python'} 09:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 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)) 09:24:00 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:24: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 09:24: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 09:24: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 09:24: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 09:24:01 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:24:01 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)) 09:24:01 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)) 09:24:01 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)) 09:24:01 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)) 09:24:01 INFO - Installing collected packages: marionette-driver 09:24:01 INFO - Running setup.py install for marionette-driver 09:24:01 INFO - Successfully installed marionette-driver 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:01 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')]} 09:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:01 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')]} 09:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:01 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 0xdf73b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11759a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', '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 09:24:01 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 09:24:01 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 09:24:01 INFO - Using env: {'DISPLAY': ':0', 09:24:01 INFO - 'HOME': '/home/cltbld', 09:24:01 INFO - 'LANG': 'en_US.UTF-8', 09:24:01 INFO - 'LANGUAGE': 'en_US:en', 09:24:01 INFO - 'LOGNAME': 'cltbld', 09:24:01 INFO - 'MAIL': '/var/mail/cltbld', 09:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:01 INFO - 'MOZ_NO_REMOTE': '1', 09:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:01 INFO - 'NO_EM_RESTART': '1', 09:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:01 INFO - 'PWD': '/builds/slave/test', 09:24:01 INFO - 'SHELL': '/bin/bash', 09:24:01 INFO - 'SHLVL': '1', 09:24:01 INFO - 'TERM': 'linux', 09:24:01 INFO - 'TMOUT': '86400', 09:24:01 INFO - 'USER': 'cltbld', 09:24:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:01 INFO - '_': '/tools/buildbot/bin/python'} 09:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:01 INFO - Cleaning up... 09:24:01 INFO - Return code: 0 09:24:01 INFO - Running post-action listener: _resource_record_post_action 09:24:01 INFO - Running post-action listener: _start_resource_monitoring 09:24:01 INFO - Starting resource monitoring. 09:24:01 INFO - [mozharness: 2017-06-25 16:24:01.773903Z] Finished create-virtualenv step (success) 09:24:01 INFO - [mozharness: 2017-06-25 16:24:01.774455Z] Running install step. 09:24:01 INFO - Running pre-action listener: _resource_record_pre_action 09:24:01 INFO - Running main action method: install 09:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:01 INFO - Reading from file tmpfile_stdout 09:24:01 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:02 INFO - Reading from file tmpfile_stdout 09:24:02 INFO - Output received: 09:24:02 INFO - Usage: mozinstall [options] installer 09:24:02 INFO - Options: 09:24:02 INFO - -h, --help show this help message and exit 09:24:02 INFO - -d DEST, --destination=DEST 09:24:02 INFO - Directory to install application into. [default: 09:24:02 INFO - "/builds/slave/test"] 09:24:02 INFO - --app=APP Application being installed. [default: firefox] 09:24:02 INFO - mkdir: /builds/slave/test/build/application 09:24:02 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'] 09:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:24:20 INFO - Reading from file tmpfile_stdout 09:24:20 INFO - Output received: 09:24:20 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:20 INFO - Running post-action listener: _resource_record_post_action 09:24:20 INFO - [mozharness: 2017-06-25 16:24:20.397145Z] Finished install step (success) 09:24:20 INFO - [mozharness: 2017-06-25 16:24:20.397295Z] Running setup-mitmproxy step. 09:24:20 INFO - Running pre-action listener: _resource_record_pre_action 09:24:20 INFO - Running main action method: setup_mitmproxy 09:24:20 INFO - Skipping: mitmproxy is not required 09:24:20 INFO - Running post-action listener: _resource_record_post_action 09:24:20 INFO - [mozharness: 2017-06-25 16:24:20.398257Z] Finished setup-mitmproxy step (success) 09:24:20 INFO - [mozharness: 2017-06-25 16:24:20.398577Z] Running run-tests step. 09:24:20 INFO - Running pre-action listener: _resource_record_pre_action 09:24:20 INFO - Running main action method: run_tests 09:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:20 INFO - Python 2.7.3 09:24:20 INFO - Return code: 0 09:24:20 INFO - grabbing minidump binary from tooltool 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:20 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 0x1173140>, '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 0x1173a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1173ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:20 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 09:24:20 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 09:24:20 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 09:24:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:20 INFO - Return code: 0 09:24:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:20 INFO - ENV: RUST_BACKTRACE is now 1 09:24:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:24:20 INFO - Using env: {'DISPLAY': ':0', 09:24:20 INFO - 'HOME': '/home/cltbld', 09:24:20 INFO - 'LANG': 'en_US.UTF-8', 09:24:20 INFO - 'LANGUAGE': 'en_US:en', 09:24:20 INFO - 'LOGNAME': 'cltbld', 09:24:20 INFO - 'MAIL': '/var/mail/cltbld', 09:24:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:20 INFO - 'MOZ_NO_REMOTE': '1', 09:24:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:20 INFO - 'NO_EM_RESTART': '1', 09:24:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:20 INFO - 'PWD': '/builds/slave/test', 09:24:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:20 INFO - 'RUST_BACKTRACE': '1', 09:24:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:24:20 INFO - 'SHELL': '/bin/bash', 09:24:20 INFO - 'SHLVL': '1', 09:24:20 INFO - 'TERM': 'linux', 09:24:20 INFO - 'TMOUT': '86400', 09:24:20 INFO - 'USER': 'cltbld', 09:24:20 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1498395742.278231-421767161', 09:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:20 INFO - '_': '/tools/buildbot/bin/python'} 09:24:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:24:20 INFO - mozversion application_buildid: 20170625153553 09:24:20 INFO - mozversion application_changeset: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 09:24:20 INFO - mozversion application_display_name: Nightly 09:24:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:20 INFO - mozversion application_name: Firefox 09:24:20 INFO - mozversion application_remotingname: firefox 09:24:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:24:20 INFO - mozversion application_vendor: Mozilla 09:24:20 INFO - mozversion application_version: 56.0a1 09:24:20 INFO - mozversion platform_buildid: 20170625153553 09:24:20 INFO - mozversion platform_changeset: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 09:24:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:24:20 INFO - mozversion platform_version: 56.0a1 09:24:20 INFO - using testdate: 1498407860 09:24:20 INFO - actual date: 1498407860 09:24:20 INFO - starting webserver on 'localhost:49664' 09:24:20 INFO - SUITE-START | Running 2 tests 09:24:20 INFO - TEST-START | dromaeo_css 09:24:20 INFO - operating with platform_type : linux_ 09:24:20 INFO - Initialising browser for dromaeo_css test... 09:24:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49664/getInfo.html -profile /tmp/tmp_yj9Lx/profile 09:24:20 INFO - TEST-INFO | started process 19638 (/builds/slave/test/build/application/firefox/firefox http://localhost:49664/getInfo.html) 09:24:27 INFO - TEST-INFO | 19638: exit 0 09:24:27 INFO - Browser initialized. 09:24:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:27 INFO - TEST-INFO | started process 19869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_yj9Lx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:38 INFO - PID 19869 | RSS: Main: 176529408 09:24:38 INFO - PID 19869 | 09:27:43 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49664/tests/dromaeo/cssquery-ext.html) 09:27:45 INFO - PID 19869 | RSS: Main: 181702656 09:27:45 INFO - PID 19869 | 09:30:46 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-ext.html (next: http://localhost:49664/tests/dromaeo/cssquery-jquery.html) 09:30:47 INFO - PID 19869 | RSS: Main: 180584448 09:30:47 INFO - PID 19869 | 09:33:49 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49664/tests/dromaeo/cssquery-mootools.html) 09:33:49 INFO - PID 19869 | RSS: Main: 181903360 09:33:49 INFO - PID 19869 | 09:36:51 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49664/tests/dromaeo/cssquery-prototype.html) 09:36:52 INFO - PID 19869 | RSS: Main: 179306496 09:36:52 INFO - PID 19869 | 09:39:54 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49664/tests/dromaeo/cssquery-yui.html) 09:39:55 INFO - PID 19869 | RSS: Main: 183963648 09:39:55 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | Cycle 1(1): loaded http://localhost:49664/tests/dromaeo/cssquery-yui.html (next: http://localhost:49664/tests/dromaeo/cssquery-dojo.html) 09:42:57 INFO - PID 19869 | RSS: Main: 181420032 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | __start_tp_report 09:42:57 INFO - PID 19869 | _x_x_mozilla_page_load 09:42:57 INFO - PID 19869 | _x_x_mozilla_page_load_details 09:42:57 INFO - PID 19869 | |i|pagename|runs| 09:42:57 INFO - PID 19869 | |0;dojo.html;3108.974038567273;3123.5314702794594;3138.027211564414;3166.430042592334;3199.6480387157408;6045.6674882881425;6145.078238264257;6178.598391104575;6178.691065446721;6183;6098.115773212881;6115.666295175933;6116.418940200674;6118.588722523099;6120.296165940918;5610.887782244353;5629.296337957755;5634.014047541685;5698.572607054467;5770.019096753541;5727.770889164429;5810.070388737803;5813.7383817728305;5821;5844.357120716718;5466.590005749565;5664.178694089354;5709.400512946122;5777.248957635502;5784.710764461781;5098.2720913054345;5815.709214539298;5826.388229235954;5835.824925252249;5844.152597873327;5647.604667673265;5652.971735141298;5654.869026194778;5700.344460387026;5714.085746280617;6044.093385992092;6068.6662233577135;6072.666003369813;6072.726727297282;6104.38956104386;6650.3682150195655;6650.900236496408;6650.900236496456;6698.4641228701585;6703.765368212089;6758.560693554952;6775.966120169368;6782.593044417302;6785.558938668971;6786.4910131739825;6267.62394256346;6272.560920735596;6274.152989346471;6277.654728989858;6288.402601752826;6660.300668429842;6745.696443660047;6872.450203983669;6876.896846547305;6879;6358.364163583605;6358.554901156875;6438.227412710505;6467.935320646828;6486.772962946275;6654.767083152066;6654.83362915931;6696.19645642526;6712.060311556386;6712.228093769181;6630.90053649186;6646.9032609619835;6669.866602668017;6669.932810750353;6706.497012724065;6462.386073323027;6541.28045914949;6551;6562.179727534059;6642.1033160523675;5323.387810401853;5351.170568561879;5352.866178345573;5353.009693206769;5363.785448582013;4605.4933957264675;4617.907641847211;4633.351330813689;4634.652401069933;4642.767861606906;5758.942410575841;5766.971165144231;5774.076147816413;5782.653040817564;5796.971015144982;6670.833229169212;6687.431568316651;6696.799096027127;6697.732090716414;6703.698333575001;5639.605227634026;5717.056685646905;5732.197492351074;5753.913691294634;5765.509931655856;5780.797672081457;5788.363280039192;5814.069748840166;5816.738246778905;5822.475977161991;6356.396142366468;6364.872702545923;6366.29970703213;6378.553501255054;6391.392817682313;6683.598984060972;6699.497537684791;6704.765333213314;6711.765088222084;6736.797896063126;6452.483801295791;6461.57999730016;6463.450606698295;6479.222493300834;6493.675316234264;6571.769988050395;6571.934280657132;6578.736850525926;6589.110470086477;6591.670416479061;6583.769568065095;6762.661866906733;6762.763303284361;6767.0526126341365;6768.830779230559;6359.7456101755415;6397.776077837253;6405.327440618668;6413.35866413355;6450.774222902176;6451.967740161269;6532.183477065367;6533.248676402084;6540.901886471612;6557.180352455943;6414.454771344302;6440.484761218998;6442.323556026549;6443.420092191538;6453.193350831146;6466.321036291121;6570.113034740249;6575.342465753386;6598.967005164944;6603.174603174603;6176.66028368444;6245.28179259391;6251.156093927443;6287.842803929939;6338.271098823694 09:42:57 INFO - PID 19869 | |1;ext.html;788.2078511096347;810.3233799777186;848.3128665780719;870.6430363550943;880.6917578847405;36745.08137296569;37331;37443.812780936125;37555;37582.24835503288;34644.65355346446;34752.30495390091;34807.30385392291;34866.8256658717;34948;6839.999999999987;6890.276520965302;6918.65406729664;6921.826954326132;6925.134358205224;6837.521373503857;6865.725370985155;6907.240203577628;6912.447004239649;6912.723491060377;6877.6217308048035;6879.759208427706;6887.207971083314;6895.069165662621;6945.861082778341;6823.454123670094;6828.5902845829405;6841.144856892888;6916.515843890905;6927.0994770679745;6193.225846769154;6257.9687101564205;6296.68516574174;6304.527160462938;6318.936810631881;30588;31035.22411939697;31103.84448077745;31113.84443077793;31210.063698089092;3486.337595856779;3549.2014296783277;3551.733619978512;3555.964440355589;3560.1633616100194;28893;29016;29142;29183.124506264845;29274.707252927412;3688.2807852468777;3752.66226039655;3766.3408903441787;3780.1494663700446;3787.659110680052;180052;181055;181318;188939;189717;45292.3206151908;45665;45971.31043034357;45982;46245;48343.75828120907;48500.5149948503;48539;48564;48626;15385.307661155275;15440.227988600525;15587.688246235011;15607.531774046796;15629.765553516707;12645.810312845315;12681.175723577939;12730.17253878495;12818.871811281768;12822.743545129046;13764.862351376558;13915.373808178656;13931.442742290195;13975.720485590231;14031.158130512202;5719.571032172604;5775.653460792366;5825.533957283407;5875.471207591338;5933.376995415506;971.7755627908745;991.9851202231972;1011.1708399112804;1021.9642312519026;1024.9436281004466;21705.782942170375;22318.21886233974;22502.549949000928;22866.031307096207;23470.17854375123;1093.5054773083004;1099.5656715597295;1110.8111621024445;1114.8550688410455;1116.0903863351343;11557.190996630323;11796.066025162221;12107.515699371927;12151;12330.63008109758;220173;221623;222298;222479;224227;43904.3414348785;43971.78014109909;44079.33880991788;44102.117957640665;44190.779046105206;1418.3121186224673;1427.3505554972671;1452.992735036318;1462.4661998370518;1473.7199932012884;21076.89461552744;21378.251761188283;22488.550228995657;22790.886045569667;23078.769212307663;34404.76369036004;34541.48187777135;34954.65045349514;34985.82507087448;35004.12489687778;175802;176946;177819;178025;178349;29306.413871722874;29401.11796646104;29689.703102968695;31055;32447.351052978334;36161;40107.799461002505;40229.1954160921;40283;40349.79825100856;27041.72958270392;27370.178894633194;27548.724512755416;27693;27703.58444623292;30879.69120308768;31530;31853;31895.840520797246;32885.17787055343;34108.488372673935;34797.8155182146;35031.12422189466;35674.46488302626;35836.28327433489;30108;31005.844970775903;31218.843905780326;31283.53074703927;32065.67934320627;23013.53972920566;24674.876625617475;24781.380465488506;24858.25425237246;25147.74852251454 09:42:57 INFO - PID 19869 | |2;jquery.html;552.0281574074535;562.4263251483487;563.3296377311;580.5471732049002;587.3715124816447;21346.89326553367;21964.341069767914;22147.446313842163;22195.66706499404;22205;18368.357107501208;18906;19122.61754764904;19128.23487060516;21319.147234110616;3914.7063970202207;3933.4886464759543;4061.3704875744306;6355.777547785829;6380.936190638081;6227.968860155693;6331.335209802974;6334.113224148623;6338.207724034496;6353.523485738565;6273.905891411632;6319.399657032574;6320.273168585602;6320.525960552954;6322.557420980534;6263.091851681481;6292.150559674454;6295.685215739195;6299.842503937415;6320.020396838498;3600;3750;3750.5311836020496;3776.4524143999242;5831.037878750001;26368.340791480365;27357.179284621492;27483;27558.448831023266;27610.861945690343;1933.584279379926;1949.87325823821;1966.9771718706193;1969.0351727653347;1970.4581240158927;16884.746728799077;17201.397951071776;17504.649907001916;17667.11664416774;17730.20214090369;2234.8100411464884;2340.7659234076455;2346.3430239532786;2346.9438752561246;2370.656254843038;108823;108887;113654.43172784083;114399.42800285945;117557;13877.306134693426;14072.2963851807;14184.503542376173;14313.57059288223;14319.14085154894;21777.56444871094;21850;21863;21909.233176838734;21944.45138871509;9302.767430814149;9581.406972385355;9612.615495380247;9636.132748052709;9751.171150452292;8872.24585910205;8875.423097498771;8964.14840590143;8976;8995.955020224988;8356.832863342821;8391.85201037155;8582.111935374207;8698.782530436663;8853.557322133867;2542.8601426921696;2563.115725074846;2573.2280315905155;2631.802614803859;2652.469506098788;970.1075010989906;975.4479744822827;979.1823827104305;997.7006897930592;1012.2559918459926;16643.251053702614;17227.483175504756;17531.474055778348;17550.38573649942;17680.55798605045;986.358866736627;1010.5553556435145;1034.8913364096811;1038.8805287391895;1045.0751085289573;9251.398659087272;9463.38487998278;9560.617575297048;9656.275779316438;9831.410115393099;402301;420883;428172;433888;436494;102139.48930255302;105627;106633.46683266533;107408.46295768471;107589;1092.2408925796494;1131.6152508147104;1135.7217481717032;1210.4552951172009;1250.4810503640888;17684.29262829524;19567;19859.404217873485;19929.20283188714;20018.69971950451;48103.27845082257;51499.22751158661;51770;52532;53158.73420632872;59942;60471.69764151151;60977.39022609717;61127.69436152791;61141.694291528256;11585.189036767682;11598.652040438463;11605.419729013347;11608.593699220486;11725.237859539102;15747.685046299239;16450.67098657996;16456;17015.914920425814;17078;13287.734245315232;14088.436462541384;14507.492237771627;14830.777538336717;15209.923950380176;12546.686332841751;13070.654482045384;13358.198508089547;13490.932545337211;13934.163950162618;14706.485273015393;15524.767128492857;15700.607484812972;15767.29047192902;15881.682366352377;10939.398333091438;10973.286736362112;11670.241434306743;12280.078994075302;12284.385780711107;13881.861181388056;14093.718125637224;14125.929370353082;14142.151470911778;14142.43430262778 09:42:57 INFO - PID 19869 | |3;mootools.html;1343.7782765843635;1379.8827099696525;1399.5661344983057;1403.235236795946;1410.3230449384296;12961.611151665442;13690.657733556665;13721.862781372183;13745.312734363279;13746;13028.934855325733;13517.932410337959;13786.103903246307;13836.100653457519;13880.236586987712;2581.6256642786784;2622.2264431992608;2638.5514462541414;2641.5641419165813;2648.139354709727;2566.1275166443406;2587.3531617095728;2594.4681340325283;2601.4276859091065;2619.318977065967;2521.13021007752;2541.224926397448;2541.644169816227;2627.4088330125664;2629.855357955312;2551.3111459905813;2599.155274535774;2601.0246157690963;2601.9982306811826;2607.256931774435;2512.170983575434;2526.9747302526926;2529.5699731045765;2541.301142185895;2550.617407388888;12766.61700148997;13022.544210952572;13096.47614095435;13150.342482875818;13198.86801131986;7273.16358618755;7608.961955190244;7617.047869016373;7626.466147369686;7648.273414025659;4195.517515485697;4330.177266319421;4335.826566937319;4371.082072764723;4423.292273236299;1555.789968354269;1570.4895908829676;1573.7640820116787;1590.085700722078;1607.4132941476278;19243.134058967382;20023.599528009505;21304;21861.67207491889;22092.779072209392;5901.17383566301;6024.246969128859;6621.470282377399;6870.106886104874;6890.621015844076;16819.243134058997;16981.830181698024;16983.405580804614;16991.830081699023;17004.149792510325;7291.197968223597;7557.508761930457;7566.546007239584;7587.696492140363;7626.847463050819;6740.898886516707;6828.795136145924;6832.043513908056;6875.243723190445;6938.444924406035;4667.509911459248;4706.8117275308605;4735.337052812609;4761.619070474423;4786.2581299898575;1689.5353777710982;1697.711389063862;1699.7110491216522;1700.5153531243784;1752.2027477497709;858.686579398515;862.8791969124328;863.5984267315729;880.1330689271063;905.4748246017294;6973;7034.120734908137;7040.542364746275;7142.250063743336;7186.1376634804155;693.5630552751835;712.056525104239;724.6521669598623;725.6843273176186;730.9963450182715;4119.732217405859;4716.716996980123;4884.413870335582;4915.877103072452;5188.195829646411;17344;17542;17827.554311142067;17958.461246162376;17999.55001124956;17366.65266694659;17695.73456398155;18129.546761331072;18341.54146146357;18649.533761655795;10014.599416023424;10328.122109620766;10614.681559553226;10748.677539673823;10815.242932994772;7576.659050342858;7958.641861116148;8392.496450213006;8642.870356944777;8763.474191548272;15950.840491594936;15980.600484987968;16364.427245046367;16390.918045409697;16679.08265045434;15939.681206376039;16065.340161915668;16160.353585856434;16465.176741162653;16914.83085169182;10875.836862447228;10909;11015.173861960546;11017.559297628326;11065.5020524075;12391;12410.193337433038;12435;12539.87460125387;12546.1844980076;9253.907460925304;9299.256059515357;9614.18279446255;9687.951560242154;9744;8786.341024423065;9160.633574657206;9248.352615316864;9378.906210937803;9507.144357007903;8959.865602015845;9066.410683305565;9069.727908162766;9072.95463522678;9083.318751093826;6151.26184857802;6162.445379915829;6315.652639104894;6398;6659.866802664016;6836.760713375008;6986.16166060076;7006.334398232159;7122.821929451805;7165.964170179116 09:42:57 INFO - PID 19869 | |4;prototype.html;498.44605011057416;502.42740223101686;519.1719207863457;521.5618880140681;524.334095698463;6263.1231627572115;6322.936770632292;6375.234971803385;6377.936220637792;6424.775132870351;6000.519958403317;6161.16824228729;6219.222597175353;6246.469050130744;6299.716512756925;5004;5011.949880501203;5025;5033.471485494016;5060.797568097271;5018.7164839997895;5028.371453568304;5045.747712614373;5082.618803589727;5084.822031228908;4827.131116399047;5029.522195391451;5036.093503169428;5041.773120209599;5048.29323894655;4950.925736113961;4992.326035985132;5002.1496345621335;5006.199008158677;5008.9499105008845;4370.912581748347;4380.8685739427865;4391.956080439219;4472.373867658531;4485.932711009337;6087.721578468527;6091.664958427285;6104.847378815521;6107.9616465201025;6135.754569817202;5687.601867869251;5719.742611582489;5723.799667011676;5739.942600573982;5754.712264386764;6588.143541339643;6607.93392066078;6647.504311529916;6648.16897887764;6672.766453174116;4903.411590609114;4905.681130726492;4921.311016457699;4929.7781599828095;4934.555889969884;6961.582305061713;7018.613976231305;7028.297170282982;7060.823479413004;7070.858582828366;5025.346704928409;5038.294638750578;5039.44566097729;5042.697438153723;5062.645614806928;5100.948990510047;5123.564497017721;5133.666311689728;5137.255098010767;5145.639805213674;5779.24869766936;5780.294813030167;5804.303483581997;5806.680632565165;5807.477327040587;6675.7997260082275;6696.1629796275465;6701.1623547056615;6732.629705366154;6743.662816859235;1673.3390310827156;1768.5843826700716;1774.6894293498585;1787.356551641408;1796.6047469556677;1193.9761204775855;1234.938253087342;1235.6478403654914;1256.6104507602672;1265.6329664397406;5609.49514543693;5736.082226843685;5774.595778295563;5776.624519406225;5784.739686714108;6609.339066093352;6758.42553382968;6800.183977922582;6807.18313802337;6808.148981377328;5829.912551311649;5840.970795145997;5867.237259156283;5870.14882841994;5888.676122813201;3626.5648122224975;3658.32321020612;3659.688926441229;3662.066173125836;3670.376036073874;6544.901826472606;6565.146530950946;6573.1783527059115;6583.703733332011;6645.435138013227;6904.27505111956;6972.511924165361;6977.964585405263;7010.75462358815;7012.929870701228;6544.836379090466;6555.246146693096;6555.967220163869;6590.439812615981;6592.670366481752;6750.594964302158;6767.898481522682;6803.693833777591;6807.829804254933;6849.1438570178725;6759.662016899037;6762.526623136333;6765.424938880054;6775.898361524482;6782.728690852311;6216.968915155576;6532.673366331569;6619.909683091471;6655.301193374819;6670.733170673313;4995.325631039908;4997.875053123701;5001.699898006132;5052.545270925487;5069.493050695049;6884.862302754017;6890.621015844176;6894.069300644549;6894.896576551456;6923.5499692519825;6635.170603674541;6642.202935647753;6642.90035649456;6647.567908085959;6650.700718467778;6625.734970601122;6644.734210631714;6650.434713049445;6652.501062420241;6689.96305572637;6566.277709452052;6587.670616469253;6588.366946260878;6601.570897891622;6637.1703537057865;6642.933570664231;6668.633225172662;6704.631245281556;6718.800749531542;6719.278692129696;6449;6517.3808488193545;6527.51043671736;6548.443382312556;6556.737730490918 09:42:57 INFO - PID 19869 | |5;yui.html;859.8925134358205;861.6165806216228;868.8001759595293;872.0146234754731;887.2458410351201;15503.767443488343;16142.354305827768;17567.209475573596;17872.106394680246;17894.37369692058;16199.514014579552;16278.348866045344;16287.51137465878;18036.098195090257;18887.811121888775;1017.6438246613682;1022.657409767725;1030.4023666273542;1039.7244730146517;1046.863907691999;995.1143482300758;1005.2008653120787;1005.5022763731963;1005.5726316315537;1042.7184660141756;1095.5672509358837;1103.3710784852638;1105.2097750108671;1105.5522513382093;1106.2366966792927;1036.6319956415439;1080.8162612355918;1085.3704851186333;1092.20814909191;1093.3494570730443;791.1179035375573;793.2305663506389;794.8728203487415;798.2775588092785;799.5602418669708;18701.251949921985;18849.528761780926;18881.339153129713;18918;18931;18841.62316753657;19874.304399345954;19899.602007959904;19953.102110405067;20120.496987575283;15021;15381.154036527987;15462.304196311194;15508;15557.688846223013;3602.9099272518133;3607.2424790793966;3617.819109044537;3622.3841946869097;3639.199376137272;88802;93935.53032234864;94024;97107.51446242724;98843.50578247063;15702.685946281239;16073.678526429407;16154.59613509648;16172.110533920511;16245.837541624433;26107.347316316864;27874;27916.30209244785;28055.158345249674;28184.43631127366;8716.259117975043;8740;8761.38670293086;8767.517786521803;8777.473351598797;3968.9206215876097;4069.348904175318;4089.407035979766;4090.6318431341324;4098.774567398762;4392.890177745582;4453.0648563801315;4479.440069991251;4480.596746292849;4508.346289787963;897.659046017246;907.5280853955906;914.6341463414687;918.7932715139041;921.6589861751195;610.2981571193163;611.1749138662858;622.4087117238641;630.338144947803;644.4554351572914;10321.380717156995;11721.296722196525;11849.881501185051;11869.64391068252;12098.57654982089;611.4832966143601;642.2870613618879;642.9614223146626;646.4182235987648;660.8843452395812;4909.263610458388;4962.826301079445;5090.185570308733;5198.428172900978;5242.606804489678;89561.55219223863;94466.52766736122;94512;94637;98473;83660.58169709235;87449;87899.56050219708;88492.5575372119;89290;69745.3025469749;72145;74618.62690686512;74901.25098749052;76632;9869.358491698016;9888;10040.949795250977;10041.297109202578;10403.375797452178;33444.66555334513;33526;33990.32019359648;35016.64983350134;35657.28685426225;41586.58413415827;43699;43702.78148609364;64960.67519662371;65711.34288657052;17196.14019299055;17541.473755787345;17683.11584420748;17693;17957.461276161735;16397.377633988148;17099.230534626222;19126.426207213804;19563.217471300988;19931;17069.780928479217;17847.643047138725;17946.56427485772;17992.730109048636;18180.636387271916;16069;16692;16695.248713807665;16720.163991800604;16822;15682.607934801721;15888.126153061692;16241.67516649684;16576.336946522006;16832.915835420743;11901.583444579399;12394.132410731163;12406.25562466255;12430;12652;12965.805512917503;13306.40121194568;14105;14268.785968210277;14296.499622513162 09:42:57 INFO - PID 19869 | __end_tp_report 09:42:57 INFO - PID 19869 | __start_cc_report 09:42:57 INFO - PID 19869 | _x_x_mozilla_cycle_collect,366 09:42:57 INFO - PID 19869 | __end_cc_report 09:42:57 INFO - PID 19869 | __startTimestamp1498408977465__endTimestamp 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | ------- Summary: start ------- 09:42:57 INFO - PID 19869 | Number of tests: 6 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#0] dojo.html Cycles:165 Average:6117.09 Median:6358.55 stddev:724.09 (11.4%) stddev-sans-first:686.78 09:42:57 INFO - PID 19869 | Values: 3109.0 3123.5 3138.0 3166.4 3199.6 6045.7 6145.1 6178.6 6178.7 6183.0 6098.1 6115.7 6116.4 6118.6 6120.3 5610.9 5629.3 5634.0 5698.6 5770.0 5727.8 5810.1 5813.7 5821.0 5844.4 5466.6 5664.2 5709.4 5777.2 5784.7 5098.3 5815.7 5826.4 5835.8 5844.2 5647.6 5653.0 5654.9 5700.3 5714.1 6044.1 6068.7 6072.7 6072.7 6104.4 6650.4 6650.9 6650.9 6698.5 6703.8 6758.6 6776.0 6782.6 6785.6 6786.5 6267.6 6272.6 6274.2 6277.7 6288.4 6660.3 6745.7 6872.5 6876.9 6879.0 6358.4 6358.6 6438.2 6467.9 6486.8 6654.8 6654.8 6696.2 6712.1 6712.2 6630.9 6646.9 6669.9 6669.9 6706.5 6462.4 6541.3 6551.0 6562.2 6642.1 5323.4 5351.2 5352.9 5353.0 5363.8 4605.5 4617.9 4633.4 4634.7 4642.8 5758.9 5767.0 5774.1 5782.7 5797.0 6670.8 6687.4 6696.8 6697.7 6703.7 5639.6 5717.1 5732.2 5753.9 5765.5 5780.8 5788.4 5814.1 5816.7 5822.5 6356.4 6364.9 6366.3 6378.6 6391.4 6683.6 6699.5 6704.8 6711.8 6736.8 6452.5 6461.6 6463.5 6479.2 6493.7 6571.8 6571.9 6578.7 6589.1 6591.7 6583.8 6762.7 6762.8 6767.1 6768.8 6359.7 6397.8 6405.3 6413.4 6450.8 6452.0 6532.2 6533.2 6540.9 6557.2 6414.5 6440.5 6442.3 6443.4 6453.2 6466.3 6570.1 6575.3 6599.0 6603.2 6176.7 6245.3 6251.2 6287.8 6338.3 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#1] ext.html Cycles:180 Average:34979.29 Median:32256.52 stddev:50648.24 (157.0%) stddev-sans-first:50725.25 09:42:57 INFO - PID 19869 | Values: 788.2 810.3 848.3 870.6 880.7 36745.1 37331.0 37443.8 37555.0 37582.2 34644.7 34752.3 34807.3 34866.8 34948.0 6840.0 6890.3 6918.7 6921.8 6925.1 6837.5 6865.7 6907.2 6912.4 6912.7 6877.6 6879.8 6887.2 6895.1 6945.9 6823.5 6828.6 6841.1 6916.5 6927.1 6193.2 6258.0 6296.7 6304.5 6318.9 30588.0 31035.2 31103.8 31113.8 31210.1 3486.3 3549.2 3551.7 3556.0 3560.2 28893.0 29016.0 29142.0 29183.1 29274.7 3688.3 3752.7 3766.3 3780.1 3787.7 180052.0 181055.0 181318.0 188939.0 189717.0 45292.3 45665.0 45971.3 45982.0 46245.0 48343.8 48500.5 48539.0 48564.0 48626.0 15385.3 15440.2 15587.7 15607.5 15629.8 12645.8 12681.2 12730.2 12818.9 12822.7 13764.9 13915.4 13931.4 13975.7 14031.2 5719.6 5775.7 5825.5 5875.5 5933.4 971.8 992.0 1011.2 1022.0 1024.9 21705.8 22318.2 22502.5 22866.0 23470.2 1093.5 1099.6 1110.8 1114.9 1116.1 11557.2 11796.1 12107.5 12151.0 12330.6 220173.0 221623.0 222298.0 222479.0 224227.0 43904.3 43971.8 44079.3 44102.1 44190.8 1418.3 1427.4 1453.0 1462.5 1473.7 21076.9 21378.3 22488.6 22790.9 23078.8 34404.8 34541.5 34954.7 34985.8 35004.1 175802.0 176946.0 177819.0 178025.0 178349.0 29306.4 29401.1 29689.7 31055.0 32447.4 36161.0 40107.8 40229.2 40283.0 40349.8 27041.7 27370.2 27548.7 27693.0 27703.6 30879.7 31530.0 31853.0 31895.8 32885.2 34108.5 34797.8 35031.1 35674.5 35836.3 30108.0 31005.8 31218.8 31283.5 32065.7 23013.5 24674.9 24781.4 24858.3 25147.7 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#2] jquery.html Cycles:180 Average:30170.30 Median:21954.40 stddev:71468.19 (325.5%) stddev-sans-first:71634.08 09:42:57 INFO - PID 19869 | Values: 552.0 562.4 563.3 580.5 587.4 21346.9 21964.3 22147.4 22195.7 22205.0 18368.4 18906.0 19122.6 19128.2 21319.1 3914.7 3933.5 4061.4 6355.8 6380.9 6228.0 6331.3 6334.1 6338.2 6353.5 6273.9 6319.4 6320.3 6320.5 6322.6 6263.1 6292.2 6295.7 6299.8 6320.0 3600.0 3750.0 3750.5 3776.5 5831.0 26368.3 27357.2 27483.0 27558.4 27610.9 1933.6 1949.9 1967.0 1969.0 1970.5 16884.7 17201.4 17504.6 17667.1 17730.2 2234.8 2340.8 2346.3 2346.9 2370.7 108823.0 108887.0 113654.4 114399.4 117557.0 13877.3 14072.3 14184.5 14313.6 14319.1 21777.6 21850.0 21863.0 21909.2 21944.5 9302.8 9581.4 9612.6 9636.1 9751.2 8872.2 8875.4 8964.1 8976.0 8996.0 8356.8 8391.9 8582.1 8698.8 8853.6 2542.9 2563.1 2573.2 2631.8 2652.5 970.1 975.4 979.2 997.7 1012.3 16643.3 17227.5 17531.5 17550.4 17680.6 986.4 1010.6 1034.9 1038.9 1045.1 9251.4 9463.4 9560.6 9656.3 9831.4 402301.0 420883.0 428172.0 433888.0 436494.0 102139.5 105627.0 106633.5 107408.5 107589.0 1092.2 1131.6 1135.7 1210.5 1250.5 17684.3 19567.0 19859.4 19929.2 20018.7 48103.3 51499.2 51770.0 52532.0 53158.7 59942.0 60471.7 60977.4 61127.7 61141.7 11585.2 11598.7 11605.4 11608.6 11725.2 15747.7 16450.7 16456.0 17015.9 17078.0 13287.7 14088.4 14507.5 14830.8 15209.9 12546.7 13070.7 13358.2 13490.9 13934.2 14706.5 15524.8 15700.6 15767.3 15881.7 10939.4 10973.3 11670.2 12280.1 12284.4 13881.9 14093.7 14125.9 14142.2 14142.4 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#3] mootools.html Cycles:180 Average:8285.42 Median:2601.71 stddev:5607.99 (215.5%) stddev-sans-first:5599.47 09:42:57 INFO - PID 19869 | Values: 1343.8 1379.9 1399.6 1403.2 1410.3 12961.6 13690.7 13721.9 13745.3 13746.0 13028.9 13517.9 13786.1 13836.1 13880.2 2581.6 2622.2 2638.6 2641.6 2648.1 2566.1 2587.4 2594.5 2601.4 2619.3 2521.1 2541.2 2541.6 2627.4 2629.9 2551.3 2599.2 2601.0 2602.0 2607.3 2512.2 2527.0 2529.6 2541.3 2550.6 12766.6 13022.5 13096.5 13150.3 13198.9 7273.2 7609.0 7617.0 7626.5 7648.3 4195.5 4330.2 4335.8 4371.1 4423.3 1555.8 1570.5 1573.8 1590.1 1607.4 19243.1 20023.6 21304.0 21861.7 22092.8 5901.2 6024.2 6621.5 6870.1 6890.6 16819.2 16981.8 16983.4 16991.8 17004.1 7291.2 7557.5 7566.5 7587.7 7626.8 6740.9 6828.8 6832.0 6875.2 6938.4 4667.5 4706.8 4735.3 4761.6 4786.3 1689.5 1697.7 1699.7 1700.5 1752.2 858.7 862.9 863.6 880.1 905.5 6973.0 7034.1 7040.5 7142.3 7186.1 693.6 712.1 724.7 725.7 731.0 4119.7 4716.7 4884.4 4915.9 5188.2 17344.0 17542.0 17827.6 17958.5 17999.6 17366.7 17695.7 18129.5 18341.5 18649.5 10014.6 10328.1 10614.7 10748.7 10815.2 7576.7 7958.6 8392.5 8642.9 8763.5 15950.8 15980.6 16364.4 16390.9 16679.1 15939.7 16065.3 16160.4 16465.2 16914.8 10875.8 10909.0 11015.2 11017.6 11065.5 12391.0 12410.2 12435.0 12539.9 12546.2 9253.9 9299.3 9614.2 9688.0 9744.0 8786.3 9160.6 9248.4 9378.9 9507.1 8959.9 9066.4 9069.7 9073.0 9083.3 6151.3 6162.4 6315.7 6398.0 6659.9 6836.8 6986.2 7006.3 7122.8 7166.0 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#4] prototype.html Cycles:180 Average:5580.15 Median:6148.46 stddev:1576.26 (25.6%) stddev-sans-first:1533.84 09:42:57 INFO - PID 19869 | Values: 498.4 502.4 519.2 521.6 524.3 6263.1 6322.9 6375.2 6377.9 6424.8 6000.5 6161.2 6219.2 6246.5 6299.7 5004.0 5011.9 5025.0 5033.5 5060.8 5018.7 5028.4 5045.7 5082.6 5084.8 4827.1 5029.5 5036.1 5041.8 5048.3 4950.9 4992.3 5002.1 5006.2 5008.9 4370.9 4380.9 4392.0 4472.4 4485.9 6087.7 6091.7 6104.8 6108.0 6135.8 5687.6 5719.7 5723.8 5739.9 5754.7 6588.1 6607.9 6647.5 6648.2 6672.8 4903.4 4905.7 4921.3 4929.8 4934.6 6961.6 7018.6 7028.3 7060.8 7070.9 5025.3 5038.3 5039.4 5042.7 5062.6 5100.9 5123.6 5133.7 5137.3 5145.6 5779.2 5780.3 5804.3 5806.7 5807.5 6675.8 6696.2 6701.2 6732.6 6743.7 1673.3 1768.6 1774.7 1787.4 1796.6 1194.0 1234.9 1235.6 1256.6 1265.6 5609.5 5736.1 5774.6 5776.6 5784.7 6609.3 6758.4 6800.2 6807.2 6808.1 5829.9 5841.0 5867.2 5870.1 5888.7 3626.6 3658.3 3659.7 3662.1 3670.4 6544.9 6565.1 6573.2 6583.7 6645.4 6904.3 6972.5 6978.0 7010.8 7012.9 6544.8 6555.2 6556.0 6590.4 6592.7 6750.6 6767.9 6803.7 6807.8 6849.1 6759.7 6762.5 6765.4 6775.9 6782.7 6217.0 6532.7 6619.9 6655.3 6670.7 4995.3 4997.9 5001.7 5052.5 5069.5 6884.9 6890.6 6894.1 6894.9 6923.5 6635.2 6642.2 6642.9 6647.6 6650.7 6625.7 6644.7 6650.4 6652.5 6690.0 6566.3 6587.7 6588.4 6601.6 6637.2 6642.9 6668.6 6704.6 6718.8 6719.3 6449.0 6517.4 6527.5 6548.4 6556.7 09:42:57 INFO - PID 19869 | 09:42:57 INFO - PID 19869 | [#5] yui.html Cycles:180 Average:20455.75 Median:20036.80 stddev:26258.17 (131.0%) stddev-sans-first:26290.61 09:42:57 INFO - PID 19869 | Values: 859.9 861.6 868.8 872.0 887.2 15503.8 16142.4 17567.2 17872.1 17894.4 16199.5 16278.3 16287.5 18036.1 18887.8 1017.6 1022.7 1030.4 1039.7 1046.9 995.1 1005.2 1005.5 1005.6 1042.7 1095.6 1103.4 1105.2 1105.6 1106.2 1036.6 1080.8 1085.4 1092.2 1093.3 791.1 793.2 794.9 798.3 799.6 18701.3 18849.5 18881.3 18918.0 18931.0 18841.6 19874.3 19899.6 19953.1 20120.5 15021.0 15381.2 15462.3 15508.0 15557.7 3602.9 3607.2 3617.8 3622.4 3639.2 88802.0 93935.5 94024.0 97107.5 98843.5 15702.7 16073.7 16154.6 16172.1 16245.8 26107.3 27874.0 27916.3 28055.2 28184.4 8716.3 8740.0 8761.4 8767.5 8777.5 3968.9 4069.3 4089.4 4090.6 4098.8 4392.9 4453.1 4479.4 4480.6 4508.3 897.7 907.5 914.6 918.8 921.7 610.3 611.2 622.4 630.3 644.5 10321.4 11721.3 11849.9 11869.6 12098.6 611.5 642.3 643.0 646.4 660.9 4909.3 4962.8 5090.2 5198.4 5242.6 89561.6 94466.5 94512.0 94637.0 98473.0 83660.6 87449.0 87899.6 88492.6 89290.0 69745.3 72145.0 74618.6 74901.3 76632.0 9869.4 9888.0 10040.9 10041.3 10403.4 33444.7 33526.0 33990.3 35016.6 35657.3 41586.6 43699.0 43702.8 64960.7 65711.3 17196.1 17541.5 17683.1 17693.0 17957.5 16397.4 17099.2 19126.4 19563.2 19931.0 17069.8 17847.6 17946.6 17992.7 18180.6 16069.0 16692.0 16695.2 16720.2 16822.0 15682.6 15888.1 16241.7 16576.3 16832.9 11901.6 12394.1 12406.3 12430.0 12652.0 12965.8 13306.4 14105.0 14268.8 14296.5 09:42:57 INFO - PID 19869 | -------- Summary: end -------- 09:42:57 INFO - PID 19869 | 09:42:58 INFO - TEST-INFO | 19869: exit 0 09:42:58 INFO - TEST-OK | dromaeo_css | took 1117380ms 09:42:58 INFO - TEST-START | kraken 09:42:58 INFO - operating with platform_type : linux_ 09:42:58 INFO - Initialising browser for kraken test... 09:42:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49664/getInfo.html -profile /tmp/tmpvsx_3_/profile 09:42:58 INFO - TEST-INFO | started process 20297 (/builds/slave/test/build/application/firefox/firefox http://localhost:49664/getInfo.html) 09:43:04 INFO - TEST-INFO | 20297: exit 0 09:43:04 INFO - Browser initialized. 09:43:04 INFO - Running cycle 1/1 for kraken test... 09:43:04 INFO - TEST-INFO | started process 20531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvsx_3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:15 INFO - PID 20531 | RSS: Main: 169230336 09:43:15 INFO - PID 20531 | 09:43:18 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:19 INFO - PID 20531 | RSS: Main: 173522944 09:43:19 INFO - PID 20531 | 09:43:22 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-dft) 09:43:22 INFO - PID 20531 | RSS: Main: 173961216 09:43:22 INFO - PID 20531 | 09:43:25 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-fft) 09:43:26 INFO - PID 20531 | RSS: Main: 168718336 09:43:26 INFO - PID 20531 | 09:43:28 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49664/tests/kraken/driver.html?testName=audio-oscillator) 09:43:28 INFO - PID 20531 | RSS: Main: 169975808 09:43:28 INFO - PID 20531 | 09:43:31 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:31 INFO - PID 20531 | RSS: Main: 169635840 09:43:31 INFO - PID 20531 | 09:43:34 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:35 INFO - PID 20531 | RSS: Main: 173547520 09:43:35 INFO - PID 20531 | 09:43:38 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49664/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:39 INFO - PID 20531 | RSS: Main: 174968832 09:43:39 INFO - PID 20531 | 09:43:42 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49664/tests/kraken/driver.html?testName=json-parse-financial) 09:43:42 INFO - PID 20531 | RSS: Main: 173670400 09:43:42 INFO - PID 20531 | 09:43:44 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:44 INFO - PID 20531 | RSS: Main: 173539328 09:43:44 INFO - PID 20531 | 09:43:46 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:47 INFO - PID 20531 | RSS: Main: 174112768 09:43:47 INFO - PID 20531 | 09:43:49 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:49 INFO - PID 20531 | RSS: Main: 174198784 09:43:49 INFO - PID 20531 | 09:43:52 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:53 INFO - PID 20531 | RSS: Main: 173813760 09:43:53 INFO - PID 20531 | 09:43:56 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:57 INFO - PID 20531 | RSS: Main: 173694976 09:43:57 INFO - PID 20531 | 09:43:58 INFO - PID 20531 | Cycle 1(1): loaded http://localhost:49664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49664/tests/kraken/driver.html?testName=ai-astar) 09:43:59 INFO - PID 20531 | RSS: Main: 174960640 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | __start_tp_report 09:43:59 INFO - PID 20531 | _x_x_mozilla_page_load 09:43:59 INFO - PID 20531 | _x_x_mozilla_page_load_details 09:43:59 INFO - PID 20531 | |i|pagename|runs| 09:43:59 INFO - PID 20531 | |0;ai-astar;102;108;108;109;110;108;111;111;108;109 09:43:59 INFO - PID 20531 | |1;audio-beat-detection;152;126;149;178;121;150;149;121;170;127 09:43:59 INFO - PID 20531 | |2;audio-dft;164;162;163;162;162;167;162;161;165;165 09:43:59 INFO - PID 20531 | |3;audio-fft;75;76;75;170;75;77;74;75;99;75 09:43:59 INFO - PID 20531 | |4;audio-oscillator;83;82;140;82;83;82;130;82;82;138 09:43:59 INFO - PID 20531 | |5;imaging-gaussian-blur;114;114;116;114;113;114;113;114;113;114 09:43:59 INFO - PID 20531 | |6;imaging-darkroom;149;150;149;150;149;151;150;150;149;150 09:43:59 INFO - PID 20531 | |7;imaging-desaturate;94;93;94;94;94;94;94;94;93;94 09:43:59 INFO - PID 20531 | |8;json-parse-financial;53;56;53;53;53;54;54;54;52;58 09:43:59 INFO - PID 20531 | |9;json-stringify-tinderbox;53;53;53;54;53;53;53;53;53;52 09:43:59 INFO - PID 20531 | |10;stanford-crypto-aes;78;76;77;77;77;76;77;77;76;75 09:43:59 INFO - PID 20531 | |11;stanford-crypto-ccm;133;127;137;134;128;133;135;139;127;161 09:43:59 INFO - PID 20531 | |12;stanford-crypto-pbkdf2;190;202;184;186;180;185;186;191;184;198 09:43:59 INFO - PID 20531 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;69;68;72;67;68 09:43:59 INFO - PID 20531 | __end_tp_report 09:43:59 INFO - PID 20531 | __start_cc_report 09:43:59 INFO - PID 20531 | _x_x_mozilla_cycle_collect,929 09:43:59 INFO - PID 20531 | __end_cc_report 09:43:59 INFO - PID 20531 | __startTimestamp1498409039034__endTimestamp 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | ------- Summary: start ------- 09:43:59 INFO - PID 20531 | Number of tests: 14 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:2.55 (2.3%) stddev-sans-first:1.27 09:43:59 INFO - PID 20531 | Values: 102.0 108.0 108.0 109.0 110.0 108.0 111.0 111.0 108.0 109.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:149.50 stddev:20.14 (13.5%) stddev-sans-first:21.17 09:43:59 INFO - PID 20531 | Values: 152.0 126.0 149.0 178.0 121.0 150.0 149.0 121.0 170.0 127.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:1.89 (1.2%) stddev-sans-first:1.99 09:43:59 INFO - PID 20531 | Values: 164.0 162.0 163.0 162.0 162.0 167.0 162.0 161.0 165.0 165.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#3] audio-fft Cycles:10 Average:87.10 Median:75.00 stddev:30.08 (40.1%) stddev-sans-first:31.58 09:43:59 INFO - PID 20531 | Values: 75.0 76.0 75.0 170.0 75.0 77.0 74.0 75.0 99.0 75.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#4] audio-oscillator Cycles:10 Average:98.40 Median:82.00 stddev:26.07 (31.8%) stddev-sans-first:27.05 09:43:59 INFO - PID 20531 | Values: 83.0 82.0 140.0 82.0 83.0 82.0 130.0 82.0 82.0 138.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 09:43:59 INFO - PID 20531 | Values: 114.0 114.0 116.0 114.0 113.0 114.0 113.0 114.0 113.0 114.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 09:43:59 INFO - PID 20531 | Values: 149.0 150.0 149.0 150.0 149.0 151.0 150.0 150.0 149.0 150.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:43:59 INFO - PID 20531 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 94.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.76 (3.3%) stddev-sans-first:1.83 09:43:59 INFO - PID 20531 | Values: 53.0 56.0 53.0 53.0 53.0 54.0 54.0 54.0 52.0 58.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 09:43:59 INFO - PID 20531 | Values: 53.0 53.0 53.0 54.0 53.0 53.0 53.0 53.0 53.0 52.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:77.00 stddev:0.84 (1.1%) stddev-sans-first:0.73 09:43:59 INFO - PID 20531 | Values: 78.0 76.0 77.0 77.0 77.0 76.0 77.0 77.0 76.0 75.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:9.89 (7.4%) stddev-sans-first:10.45 09:43:59 INFO - PID 20531 | Values: 133.0 127.0 137.0 134.0 128.0 133.0 135.0 139.0 127.0 161.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.60 Median:188.00 stddev:6.82 (3.6%) stddev-sans-first:7.21 09:43:59 INFO - PID 20531 | Values: 190.0 202.0 184.0 186.0 180.0 185.0 186.0 191.0 184.0 198.0 09:43:59 INFO - PID 20531 | 09:43:59 INFO - PID 20531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 09:43:59 INFO - PID 20531 | Values: 68.0 69.0 69.0 68.0 68.0 69.0 68.0 72.0 67.0 68.0 09:43:59 INFO - PID 20531 | -------- Summary: end -------- 09:43:59 INFO - PID 20531 | 09:43:59 INFO - TEST-INFO | 20531: exit 0 09:43:59 INFO - TEST-OK | kraken | took 61757ms 09:43:59 INFO - SUITE-END | took 1179s 09:44:00 INFO - Completed test suite (00:19:39) 09:44:00 INFO - javascript benchmark 09:44:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8030.977346387341, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.974038567273, 3123.5314702794594, 3138.027211564414, 3166.430042592334, 3199.6480387157408, 6045.6674882881425, 6145.078238264257, 6178.598391104575, 6178.691065446721, 6183.0, 6098.115773212881, 6115.666295175933, 6116.418940200674, 6118.588722523099, 6120.296165940918, 5610.887782244353, 5629.296337957755, 5634.014047541685, 5698.572607054467, 5770.019096753541, 5727.770889164429, 5810.070388737803, 5813.7383817728305, 5821.0, 5844.357120716718, 5466.590005749565, 5664.178694089354, 5709.400512946122, 5777.248957635502, 5784.710764461781, 5098.2720913054345, 5815.709214539298, 5826.388229235954, 5835.824925252249, 5844.152597873327, 5647.604667673265, 5652.971735141298, 5654.869026194778, 5700.344460387026, 5714.085746280617, 6044.093385992092, 6068.6662233577135, 6072.666003369813, 6072.726727297282, 6104.38956104386, 6650.3682150195655, 6650.900236496408, 6650.900236496456, 6698.4641228701585, 6703.765368212089, 6758.560693554952, 6775.966120169368, 6782.593044417302, 6785.558938668971, 6786.4910131739825, 6267.62394256346, 6272.560920735596, 6274.152989346471, 6277.654728989858, 6288.402601752826, 6660.300668429842, 6745.696443660047, 6872.450203983669, 6876.896846547305, 6879.0, 6358.364163583605, 6358.554901156875, 6438.227412710505, 6467.935320646828, 6486.772962946275, 6654.767083152066, 6654.83362915931, 6696.19645642526, 6712.060311556386, 6712.228093769181, 6630.90053649186, 6646.9032609619835, 6669.866602668017, 6669.932810750353, 6706.497012724065, 6462.386073323027, 6541.28045914949, 6551.0, 6562.179727534059, 6642.1033160523675, 5323.387810401853, 5351.170568561879, 5352.866178345573, 5353.009693206769, 5363.785448582013, 4605.4933957264675, 4617.907641847211, 4633.351330813689, 4634.652401069933, 4642.767861606906, 5758.942410575841, 5766.971165144231, 5774.076147816413, 5782.653040817564, 5796.971015144982, 6670.833229169212, 6687.431568316651, 6696.799096027127, 6697.732090716414, 6703.698333575001, 5639.605227634026, 5717.056685646905, 5732.197492351074, 5753.913691294634, 5765.509931655856, 5780.797672081457, 5788.363280039192, 5814.069748840166, 5816.738246778905, 5822.475977161991, 6356.396142366468, 6364.872702545923, 6366.29970703213, 6378.553501255054, 6391.392817682313, 6683.598984060972, 6699.497537684791, 6704.765333213314, 6711.765088222084, 6736.797896063126, 6452.483801295791, 6461.57999730016, 6463.450606698295, 6479.222493300834, 6493.675316234264, 6571.769988050395, 6571.934280657132, 6578.736850525926, 6589.110470086477, 6591.670416479061, 6583.769568065095, 6762.661866906733, 6762.763303284361, 6767.0526126341365, 6768.830779230559, 6359.7456101755415, 6397.776077837253, 6405.327440618668, 6413.35866413355, 6450.774222902176, 6451.967740161269, 6532.183477065367, 6533.248676402084, 6540.901886471612, 6557.180352455943, 6414.454771344302, 6440.484761218998, 6442.323556026549, 6443.420092191538, 6453.193350831146, 6466.321036291121, 6570.113034740249, 6575.342465753386, 6598.967005164944, 6603.174603174603, 6176.66028368444, 6245.28179259391, 6251.156093927443, 6287.842803929939, 6338.271098823694], "value": 6062.948306831009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.2078511096347, 810.3233799777186, 848.3128665780719, 870.6430363550943, 880.6917578847405, 36745.08137296569, 37331.0, 37443.812780936125, 37555.0, 37582.24835503288, 34644.65355346446, 34752.30495390091, 34807.30385392291, 34866.8256658717, 34948.0, 6839.999999999987, 6890.276520965302, 6918.65406729664, 6921.826954326132, 6925.134358205224, 6837.521373503857, 6865.725370985155, 6907.240203577628, 6912.447004239649, 6912.723491060377, 6877.6217308048035, 6879.759208427706, 6887.207971083314, 6895.069165662621, 6945.861082778341, 6823.454123670094, 6828.5902845829405, 6841.144856892888, 6916.515843890905, 6927.0994770679745, 6193.225846769154, 6257.9687101564205, 6296.68516574174, 6304.527160462938, 6318.936810631881, 30588.0, 31035.22411939697, 31103.84448077745, 31113.84443077793, 31210.063698089092, 3486.337595856779, 3549.2014296783277, 3551.733619978512, 3555.964440355589, 3560.1633616100194, 28893.0, 29016.0, 29142.0, 29183.124506264845, 29274.707252927412, 3688.2807852468777, 3752.66226039655, 3766.3408903441787, 3780.1494663700446, 3787.659110680052, 180052.0, 181055.0, 181318.0, 188939.0, 189717.0, 45292.3206151908, 45665.0, 45971.31043034357, 45982.0, 46245.0, 48343.75828120907, 48500.5149948503, 48539.0, 48564.0, 48626.0, 15385.307661155275, 15440.227988600525, 15587.688246235011, 15607.531774046796, 15629.765553516707, 12645.810312845315, 12681.175723577939, 12730.17253878495, 12818.871811281768, 12822.743545129046, 13764.862351376558, 13915.373808178656, 13931.442742290195, 13975.720485590231, 14031.158130512202, 5719.571032172604, 5775.653460792366, 5825.533957283407, 5875.471207591338, 5933.376995415506, 971.7755627908745, 991.9851202231972, 1011.1708399112804, 1021.9642312519026, 1024.9436281004466, 21705.782942170375, 22318.21886233974, 22502.549949000928, 22866.031307096207, 23470.17854375123, 1093.5054773083004, 1099.5656715597295, 1110.8111621024445, 1114.8550688410455, 1116.0903863351343, 11557.190996630323, 11796.066025162221, 12107.515699371927, 12151.0, 12330.63008109758, 220173.0, 221623.0, 222298.0, 222479.0, 224227.0, 43904.3414348785, 43971.78014109909, 44079.33880991788, 44102.117957640665, 44190.779046105206, 1418.3121186224673, 1427.3505554972671, 1452.992735036318, 1462.4661998370518, 1473.7199932012884, 21076.89461552744, 21378.251761188283, 22488.550228995657, 22790.886045569667, 23078.769212307663, 34404.76369036004, 34541.48187777135, 34954.65045349514, 34985.82507087448, 35004.12489687778, 175802.0, 176946.0, 177819.0, 178025.0, 178349.0, 29306.413871722874, 29401.11796646104, 29689.703102968695, 31055.0, 32447.351052978334, 36161.0, 40107.799461002505, 40229.1954160921, 40283.0, 40349.79825100856, 27041.72958270392, 27370.178894633194, 27548.724512755416, 27693.0, 27703.58444623292, 30879.69120308768, 31530.0, 31853.0, 31895.840520797246, 32885.17787055343, 34108.488372673935, 34797.8155182146, 35031.12422189466, 35674.46488302626, 35836.28327433489, 30108.0, 31005.844970775903, 31218.843905780326, 31283.53074703927, 32065.67934320627, 23013.53972920566, 24674.876625617475, 24781.380465488506, 24858.25425237246, 25147.74852251454], "value": 15949.47389341237, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.0281574074535, 562.4263251483487, 563.3296377311, 580.5471732049002, 587.3715124816447, 21346.89326553367, 21964.341069767914, 22147.446313842163, 22195.66706499404, 22205.0, 18368.357107501208, 18906.0, 19122.61754764904, 19128.23487060516, 21319.147234110616, 3914.7063970202207, 3933.4886464759543, 4061.3704875744306, 6355.777547785829, 6380.936190638081, 6227.968860155693, 6331.335209802974, 6334.113224148623, 6338.207724034496, 6353.523485738565, 6273.905891411632, 6319.399657032574, 6320.273168585602, 6320.525960552954, 6322.557420980534, 6263.091851681481, 6292.150559674454, 6295.685215739195, 6299.842503937415, 6320.020396838498, 3600.0, 3750.0, 3750.5311836020496, 3776.4524143999242, 5831.037878750001, 26368.340791480365, 27357.179284621492, 27483.0, 27558.448831023266, 27610.861945690343, 1933.584279379926, 1949.87325823821, 1966.9771718706193, 1969.0351727653347, 1970.4581240158927, 16884.746728799077, 17201.397951071776, 17504.649907001916, 17667.11664416774, 17730.20214090369, 2234.8100411464884, 2340.7659234076455, 2346.3430239532786, 2346.9438752561246, 2370.656254843038, 108823.0, 108887.0, 113654.43172784083, 114399.42800285945, 117557.0, 13877.306134693426, 14072.2963851807, 14184.503542376173, 14313.57059288223, 14319.14085154894, 21777.56444871094, 21850.0, 21863.0, 21909.233176838734, 21944.45138871509, 9302.767430814149, 9581.406972385355, 9612.615495380247, 9636.132748052709, 9751.171150452292, 8872.24585910205, 8875.423097498771, 8964.14840590143, 8976.0, 8995.955020224988, 8356.832863342821, 8391.85201037155, 8582.111935374207, 8698.782530436663, 8853.557322133867, 2542.8601426921696, 2563.115725074846, 2573.2280315905155, 2631.802614803859, 2652.469506098788, 970.1075010989906, 975.4479744822827, 979.1823827104305, 997.7006897930592, 1012.2559918459926, 16643.251053702614, 17227.483175504756, 17531.474055778348, 17550.38573649942, 17680.55798605045, 986.358866736627, 1010.5553556435145, 1034.8913364096811, 1038.8805287391895, 1045.0751085289573, 9251.398659087272, 9463.38487998278, 9560.617575297048, 9656.275779316438, 9831.410115393099, 402301.0, 420883.0, 428172.0, 433888.0, 436494.0, 102139.48930255302, 105627.0, 106633.46683266533, 107408.46295768471, 107589.0, 1092.2408925796494, 1131.6152508147104, 1135.7217481717032, 1210.4552951172009, 1250.4810503640888, 17684.29262829524, 19567.0, 19859.404217873485, 19929.20283188714, 20018.69971950451, 48103.27845082257, 51499.22751158661, 51770.0, 52532.0, 53158.73420632872, 59942.0, 60471.69764151151, 60977.39022609717, 61127.69436152791, 61141.694291528256, 11585.189036767682, 11598.652040438463, 11605.419729013347, 11608.593699220486, 11725.237859539102, 15747.685046299239, 16450.67098657996, 16456.0, 17015.914920425814, 17078.0, 13287.734245315232, 14088.436462541384, 14507.492237771627, 14830.777538336717, 15209.923950380176, 12546.686332841751, 13070.654482045384, 13358.198508089547, 13490.932545337211, 13934.163950162618, 14706.485273015393, 15524.767128492857, 15700.607484812972, 15767.29047192902, 15881.682366352377, 10939.398333091438, 10973.286736362112, 11670.241434306743, 12280.078994075302, 12284.385780711107, 13881.861181388056, 14093.718125637224, 14125.929370353082, 14142.151470911778, 14142.43430262778], "value": 10624.492011785434, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.7782765843635, 1379.8827099696525, 1399.5661344983057, 1403.235236795946, 1410.3230449384296, 12961.611151665442, 13690.657733556665, 13721.862781372183, 13745.312734363279, 13746.0, 13028.934855325733, 13517.932410337959, 13786.103903246307, 13836.100653457519, 13880.236586987712, 2581.6256642786784, 2622.2264431992608, 2638.5514462541414, 2641.5641419165813, 2648.139354709727, 2566.1275166443406, 2587.3531617095728, 2594.4681340325283, 2601.4276859091065, 2619.318977065967, 2521.13021007752, 2541.224926397448, 2541.644169816227, 2627.4088330125664, 2629.855357955312, 2551.3111459905813, 2599.155274535774, 2601.0246157690963, 2601.9982306811826, 2607.256931774435, 2512.170983575434, 2526.9747302526926, 2529.5699731045765, 2541.301142185895, 2550.617407388888, 12766.61700148997, 13022.544210952572, 13096.47614095435, 13150.342482875818, 13198.86801131986, 7273.16358618755, 7608.961955190244, 7617.047869016373, 7626.466147369686, 7648.273414025659, 4195.517515485697, 4330.177266319421, 4335.826566937319, 4371.082072764723, 4423.292273236299, 1555.789968354269, 1570.4895908829676, 1573.7640820116787, 1590.085700722078, 1607.4132941476278, 19243.134058967382, 20023.599528009505, 21304.0, 21861.67207491889, 22092.779072209392, 5901.17383566301, 6024.246969128859, 6621.470282377399, 6870.106886104874, 6890.621015844076, 16819.243134058997, 16981.830181698024, 16983.405580804614, 16991.830081699023, 17004.149792510325, 7291.197968223597, 7557.508761930457, 7566.546007239584, 7587.696492140363, 7626.847463050819, 6740.898886516707, 6828.795136145924, 6832.043513908056, 6875.243723190445, 6938.444924406035, 4667.509911459248, 4706.8117275308605, 4735.337052812609, 4761.619070474423, 4786.2581299898575, 1689.5353777710982, 1697.711389063862, 1699.7110491216522, 1700.5153531243784, 1752.2027477497709, 858.686579398515, 862.8791969124328, 863.5984267315729, 880.1330689271063, 905.4748246017294, 6973.0, 7034.120734908137, 7040.542364746275, 7142.250063743336, 7186.1376634804155, 693.5630552751835, 712.056525104239, 724.6521669598623, 725.6843273176186, 730.9963450182715, 4119.732217405859, 4716.716996980123, 4884.413870335582, 4915.877103072452, 5188.195829646411, 17344.0, 17542.0, 17827.554311142067, 17958.461246162376, 17999.55001124956, 17366.65266694659, 17695.73456398155, 18129.546761331072, 18341.54146146357, 18649.533761655795, 10014.599416023424, 10328.122109620766, 10614.681559553226, 10748.677539673823, 10815.242932994772, 7576.659050342858, 7958.641861116148, 8392.496450213006, 8642.870356944777, 8763.474191548272, 15950.840491594936, 15980.600484987968, 16364.427245046367, 16390.918045409697, 16679.08265045434, 15939.681206376039, 16065.340161915668, 16160.353585856434, 16465.176741162653, 16914.83085169182, 10875.836862447228, 10909.0, 11015.173861960546, 11017.559297628326, 11065.5020524075, 12391.0, 12410.193337433038, 12435.0, 12539.87460125387, 12546.1844980076, 9253.907460925304, 9299.256059515357, 9614.18279446255, 9687.951560242154, 9744.0, 8786.341024423065, 9160.633574657206, 9248.352615316864, 9378.906210937803, 9507.144357007903, 8959.865602015845, 9066.410683305565, 9069.727908162766, 9072.95463522678, 9083.318751093826, 6151.26184857802, 6162.445379915829, 6315.652639104894, 6398.0, 6659.866802664016, 6836.760713375008, 6986.16166060076, 7006.334398232159, 7122.821929451805, 7165.964170179116], "value": 6055.033790578301, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.44605011057416, 502.42740223101686, 519.1719207863457, 521.5618880140681, 524.334095698463, 6263.1231627572115, 6322.936770632292, 6375.234971803385, 6377.936220637792, 6424.775132870351, 6000.519958403317, 6161.16824228729, 6219.222597175353, 6246.469050130744, 6299.716512756925, 5004.0, 5011.949880501203, 5025.0, 5033.471485494016, 5060.797568097271, 5018.7164839997895, 5028.371453568304, 5045.747712614373, 5082.618803589727, 5084.822031228908, 4827.131116399047, 5029.522195391451, 5036.093503169428, 5041.773120209599, 5048.29323894655, 4950.925736113961, 4992.326035985132, 5002.1496345621335, 5006.199008158677, 5008.9499105008845, 4370.912581748347, 4380.8685739427865, 4391.956080439219, 4472.373867658531, 4485.932711009337, 6087.721578468527, 6091.664958427285, 6104.847378815521, 6107.9616465201025, 6135.754569817202, 5687.601867869251, 5719.742611582489, 5723.799667011676, 5739.942600573982, 5754.712264386764, 6588.143541339643, 6607.93392066078, 6647.504311529916, 6648.16897887764, 6672.766453174116, 4903.411590609114, 4905.681130726492, 4921.311016457699, 4929.7781599828095, 4934.555889969884, 6961.582305061713, 7018.613976231305, 7028.297170282982, 7060.823479413004, 7070.858582828366, 5025.346704928409, 5038.294638750578, 5039.44566097729, 5042.697438153723, 5062.645614806928, 5100.948990510047, 5123.564497017721, 5133.666311689728, 5137.255098010767, 5145.639805213674, 5779.24869766936, 5780.294813030167, 5804.303483581997, 5806.680632565165, 5807.477327040587, 6675.7997260082275, 6696.1629796275465, 6701.1623547056615, 6732.629705366154, 6743.662816859235, 1673.3390310827156, 1768.5843826700716, 1774.6894293498585, 1787.356551641408, 1796.6047469556677, 1193.9761204775855, 1234.938253087342, 1235.6478403654914, 1256.6104507602672, 1265.6329664397406, 5609.49514543693, 5736.082226843685, 5774.595778295563, 5776.624519406225, 5784.739686714108, 6609.339066093352, 6758.42553382968, 6800.183977922582, 6807.18313802337, 6808.148981377328, 5829.912551311649, 5840.970795145997, 5867.237259156283, 5870.14882841994, 5888.676122813201, 3626.5648122224975, 3658.32321020612, 3659.688926441229, 3662.066173125836, 3670.376036073874, 6544.901826472606, 6565.146530950946, 6573.1783527059115, 6583.703733332011, 6645.435138013227, 6904.27505111956, 6972.511924165361, 6977.964585405263, 7010.75462358815, 7012.929870701228, 6544.836379090466, 6555.246146693096, 6555.967220163869, 6590.439812615981, 6592.670366481752, 6750.594964302158, 6767.898481522682, 6803.693833777591, 6807.829804254933, 6849.1438570178725, 6759.662016899037, 6762.526623136333, 6765.424938880054, 6775.898361524482, 6782.728690852311, 6216.968915155576, 6532.673366331569, 6619.909683091471, 6655.301193374819, 6670.733170673313, 4995.325631039908, 4997.875053123701, 5001.699898006132, 5052.545270925487, 5069.493050695049, 6884.862302754017, 6890.621015844176, 6894.069300644549, 6894.896576551456, 6923.5499692519825, 6635.170603674541, 6642.202935647753, 6642.90035649456, 6647.567908085959, 6650.700718467778, 6625.734970601122, 6644.734210631714, 6650.434713049445, 6652.501062420241, 6689.96305572637, 6566.277709452052, 6587.670616469253, 6588.366946260878, 6601.570897891622, 6637.1703537057865, 6642.933570664231, 6668.633225172662, 6704.631245281556, 6718.800749531542, 6719.278692129696, 6449.0, 6517.3808488193545, 6527.51043671736, 6548.443382312556, 6556.737730490918], "value": 5114.833699037892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.8925134358205, 861.6165806216228, 868.8001759595293, 872.0146234754731, 887.2458410351201, 15503.767443488343, 16142.354305827768, 17567.209475573596, 17872.106394680246, 17894.37369692058, 16199.514014579552, 16278.348866045344, 16287.51137465878, 18036.098195090257, 18887.811121888775, 1017.6438246613682, 1022.657409767725, 1030.4023666273542, 1039.7244730146517, 1046.863907691999, 995.1143482300758, 1005.2008653120787, 1005.5022763731963, 1005.5726316315537, 1042.7184660141756, 1095.5672509358837, 1103.3710784852638, 1105.2097750108671, 1105.5522513382093, 1106.2366966792927, 1036.6319956415439, 1080.8162612355918, 1085.3704851186333, 1092.20814909191, 1093.3494570730443, 791.1179035375573, 793.2305663506389, 794.8728203487415, 798.2775588092785, 799.5602418669708, 18701.251949921985, 18849.528761780926, 18881.339153129713, 18918.0, 18931.0, 18841.62316753657, 19874.304399345954, 19899.602007959904, 19953.102110405067, 20120.496987575283, 15021.0, 15381.154036527987, 15462.304196311194, 15508.0, 15557.688846223013, 3602.9099272518133, 3607.2424790793966, 3617.819109044537, 3622.3841946869097, 3639.199376137272, 88802.0, 93935.53032234864, 94024.0, 97107.51446242724, 98843.50578247063, 15702.685946281239, 16073.678526429407, 16154.59613509648, 16172.110533920511, 16245.837541624433, 26107.347316316864, 27874.0, 27916.30209244785, 28055.158345249674, 28184.43631127366, 8716.259117975043, 8740.0, 8761.38670293086, 8767.517786521803, 8777.473351598797, 3968.9206215876097, 4069.348904175318, 4089.407035979766, 4090.6318431341324, 4098.774567398762, 4392.890177745582, 4453.0648563801315, 4479.440069991251, 4480.596746292849, 4508.346289787963, 897.659046017246, 907.5280853955906, 914.6341463414687, 918.7932715139041, 921.6589861751195, 610.2981571193163, 611.1749138662858, 622.4087117238641, 630.338144947803, 644.4554351572914, 10321.380717156995, 11721.296722196525, 11849.881501185051, 11869.64391068252, 12098.57654982089, 611.4832966143601, 642.2870613618879, 642.9614223146626, 646.4182235987648, 660.8843452395812, 4909.263610458388, 4962.826301079445, 5090.185570308733, 5198.428172900978, 5242.606804489678, 89561.55219223863, 94466.52766736122, 94512.0, 94637.0, 98473.0, 83660.58169709235, 87449.0, 87899.56050219708, 88492.5575372119, 89290.0, 69745.3025469749, 72145.0, 74618.62690686512, 74901.25098749052, 76632.0, 9869.358491698016, 9888.0, 10040.949795250977, 10041.297109202578, 10403.375797452178, 33444.66555334513, 33526.0, 33990.32019359648, 35016.64983350134, 35657.28685426225, 41586.58413415827, 43699.0, 43702.78148609364, 64960.67519662371, 65711.34288657052, 17196.14019299055, 17541.473755787345, 17683.11584420748, 17693.0, 17957.461276161735, 16397.377633988148, 17099.230534626222, 19126.426207213804, 19563.217471300988, 19931.0, 17069.780928479217, 17847.643047138725, 17946.56427485772, 17992.730109048636, 18180.636387271916, 16069.0, 16692.0, 16695.248713807665, 16720.163991800604, 16822.0, 15682.607934801721, 15888.126153061692, 16241.67516649684, 16576.336946522006, 16832.915835420743, 11901.583444579399, 12394.132410731163, 12406.25562466255, 12430.0, 12652.0, 12965.805512917503, 13306.40121194568, 14105.0, 14268.785968210277, 14296.499622513162], "value": 8431.415758461768, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 108.0, 109.0, 110.0, 108.0, 111.0, 111.0, 108.0, 109.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 149.0, 178.0, 121.0, 150.0, 149.0, 121.0, 170.0, 127.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 162.0, 162.0, 167.0, 162.0, 161.0, 165.0, 165.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 170.0, 75.0, 77.0, 74.0, 75.0, 99.0, 75.0], "value": 87.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 140.0, 82.0, 83.0, 82.0, 130.0, 82.0, 82.0, 138.0], "value": 98.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 150.0, 149.0, 151.0, 150.0, 150.0, 149.0, 150.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 52.0, 58.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 77.0, 77.0, 76.0, 77.0, 77.0, 76.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 127.0, 137.0, 134.0, 128.0, 133.0, 135.0, 139.0, 127.0, 161.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 202.0, 184.0, 186.0, 180.0, 185.0, 186.0, 191.0, 184.0, 198.0], "value": 188.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0, 72.0, 67.0, 68.0], "value": 68.6, "unit": "score"}]}]} 09:44:00 INFO - Return code: 0 09:44:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:00 INFO - # TBPL SUCCESS # 09:44:00 INFO - Running post-action listener: _resource_record_post_action 09:44:00 INFO - [mozharness: 2017-06-25 16:44:00.390913Z] Finished run-tests step (success) 09:44:00 INFO - Running post-run listener: _resource_record_post_run 09:44:00 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435150848; Read time: 8; Write time: 249796 09:44:00 INFO - TinderboxPrint: CPU usage
13.2% 09:44:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:44:00 INFO - TinderboxPrint: I/O write bytes / time
435,150,848 / 249,796 09:44:00 INFO - TinderboxPrint: CPU idle
8,295.0 (86.8%) 09:44:00 INFO - TinderboxPrint: CPU user
1,209.2 (12.7%) 09:44:00 INFO - TinderboxPrint: Swap in / out
0 / 0 09:44:00 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 105336832; Read time: 0; Write time: 69660 09:44:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:44:00 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329814016; Read time: 8; Write time: 180136 09:44:01 INFO - Running post-run listener: _upload_blobber_files 09:44:01 INFO - Blob upload gear active. 09:44:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44: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 09:44: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:01 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:02 INFO - (blobuploader) - INFO - Done attempting. 09:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:05 INFO - (blobuploader) - INFO - Done attempting. 09:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:05 INFO - (blobuploader) - INFO - Done attempting. 09:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:06 INFO - (blobuploader) - INFO - Done attempting. 09:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:06 INFO - Return code: 0 09:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/559cda16b5b8864305c7701f433e9765cd2617068b504680a525452f1013c2b01ccffd3fbd83ea9199b230a10e7b06326ec7bef38126ab91ea15be32fa2c2c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5411877ae0e2549f6cd3880019ca3f105db8afa3203184558fcd3b2fd072e42ee044f6d1f7f0b8f38d6c3699ebd76afe0d00082de61acfd25cb2b4998e676f5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f0b5ca3c173709fb4151d032f8076597cf7dd1288e5fae283e057ac48afc83cc64b9cb41edd543d0847e21f1ce655a424c4984243264f02a7b5412e8af4964d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33446b5cfdaefc55f3b79c0d437ea43d1525c4f86d0e7c458fc8d9bf569184e54c1af60206c1cb2a84f2fada8faacfae915876387d9df1b0b85d6fc5b68a0f9"} 09:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:06 INFO - Contents: 09:44:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/559cda16b5b8864305c7701f433e9765cd2617068b504680a525452f1013c2b01ccffd3fbd83ea9199b230a10e7b06326ec7bef38126ab91ea15be32fa2c2c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5411877ae0e2549f6cd3880019ca3f105db8afa3203184558fcd3b2fd072e42ee044f6d1f7f0b8f38d6c3699ebd76afe0d00082de61acfd25cb2b4998e676f5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f0b5ca3c173709fb4151d032f8076597cf7dd1288e5fae283e057ac48afc83cc64b9cb41edd543d0847e21f1ce655a424c4984243264f02a7b5412e8af4964d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33446b5cfdaefc55f3b79c0d437ea43d1525c4f86d0e7c458fc8d9bf569184e54c1af60206c1cb2a84f2fada8faacfae915876387d9df1b0b85d6fc5b68a0f9"} 09:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:06 INFO - Copying logs to upload dir... 09:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.032810 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-06-25 09:44:06.363878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-25 09:44:06.371420) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/559cda16b5b8864305c7701f433e9765cd2617068b504680a525452f1013c2b01ccffd3fbd83ea9199b230a10e7b06326ec7bef38126ab91ea15be32fa2c2c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5411877ae0e2549f6cd3880019ca3f105db8afa3203184558fcd3b2fd072e42ee044f6d1f7f0b8f38d6c3699ebd76afe0d00082de61acfd25cb2b4998e676f5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f0b5ca3c173709fb4151d032f8076597cf7dd1288e5fae283e057ac48afc83cc64b9cb41edd543d0847e21f1ce655a424c4984243264f02a7b5412e8af4964d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33446b5cfdaefc55f3b79c0d437ea43d1525c4f86d0e7c458fc8d9bf569184e54c1af60206c1cb2a84f2fada8faacfae915876387d9df1b0b85d6fc5b68a0f9"} build_url:https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/FXzgljF5Q7yAXAIKBzOadA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/559cda16b5b8864305c7701f433e9765cd2617068b504680a525452f1013c2b01ccffd3fbd83ea9199b230a10e7b06326ec7bef38126ab91ea15be32fa2c2c25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5411877ae0e2549f6cd3880019ca3f105db8afa3203184558fcd3b2fd072e42ee044f6d1f7f0b8f38d6c3699ebd76afe0d00082de61acfd25cb2b4998e676f5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f0b5ca3c173709fb4151d032f8076597cf7dd1288e5fae283e057ac48afc83cc64b9cb41edd543d0847e21f1ce655a424c4984243264f02a7b5412e8af4964d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e33446b5cfdaefc55f3b79c0d437ea43d1525c4f86d0e7c458fc8d9bf569184e54c1af60206c1cb2a84f2fada8faacfae915876387d9df1b0b85d6fc5b68a0f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-25 09:44:06.394713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:44:06.394998) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1498395742.278231-421767161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:44:06.479429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-25 09:44:06.479696) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-25 09:44:06.479942) ========= ========= Total master_lag: 0.38 =========